builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1479320051.05 results: success (0) buildid: 20161116073153 builduid: 07b960913c0e4098890d07ee4c522ddd revision: 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.051378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.051859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.052180) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.066981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.067268) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 10:14:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.3M=0s 2016-11-16 10:14:11 (31.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089087 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.175011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.175397) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014159 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.225564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.225965) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 10:14:11,923 truncating revision to first 12 chars 2016-11-16 10:14:11,923 Setting DEBUG logging. 2016-11-16 10:14:11,923 attempt 1/10 2016-11-16 10:14:11,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51750761f2c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 10:14:12,277 unpacking tar archive at: mozilla-central-51750761f2c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.960768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.961082) ========= script_repo_revision: 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.961501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.961828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 10:14:11.975450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-16 10:14:11.975761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:12 INFO - MultiFileLogger online at 20161116 10:14:12 in /builds/slave/test 10:14:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:14:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:12 INFO - {'append_to_log': False, 10:14:12 INFO - 'base_work_dir': '/builds/slave/test', 10:14:12 INFO - 'blob_upload_branch': 'Firefox', 10:14:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:12 INFO - 'branch': 'Firefox', 10:14:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:12 INFO - 'config_files': ('talos/linux_config.py',), 10:14:12 INFO - 'default_actions': ('clobber', 10:14:12 INFO - 'read-buildbot-config', 10:14:12 INFO - 'download-and-extract', 10:14:12 INFO - 'populate-webroot', 10:14:12 INFO - 'create-virtualenv', 10:14:12 INFO - 'install', 10:14:12 INFO - 'run-tests'), 10:14:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:12 INFO - 'download_minidump_stackwalk': True, 10:14:12 INFO - 'download_symbols': 'ondemand', 10:14:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:12 INFO - 'installer_path': 'installer.exe', 10:14:12 INFO - 'log_level': 'info', 10:14:12 INFO - 'log_name': 'talos', 10:14:12 INFO - 'log_to_console': True, 10:14:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:12 INFO - 'opt_config_files': (), 10:14:12 INFO - 'pip_index': False, 10:14:12 INFO - 'sps_profile': False, 10:14:12 INFO - 'sps_profile_interval': 0, 10:14:12 INFO - 'suite': 'dromaeojs', 10:14:12 INFO - 'system_bits': '32', 10:14:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:12 INFO - 'title': 'talos-linux64-ix-005', 10:14:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:12 INFO - 'use_talos_json': True, 10:14:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:12 INFO - 'work_dir': 'build'} 10:14:12 INFO - [mozharness: 2016-11-16 18:14:12.769049Z] Running clobber step. 10:14:12 INFO - Running pre-action listener: _resource_record_pre_action 10:14:12 INFO - Running main action method: clobber 10:14:12 INFO - rmtree: /builds/slave/test/build 10:14:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:13 INFO - Running post-action listener: _resource_record_post_action 10:14:13 INFO - [mozharness: 2016-11-16 18:14:13.242685Z] Finished clobber step (success) 10:14:13 INFO - [mozharness: 2016-11-16 18:14:13.242784Z] Running read-buildbot-config step. 10:14:13 INFO - Running pre-action listener: _resource_record_pre_action 10:14:13 INFO - Running main action method: read_buildbot_config 10:14:13 INFO - Using buildbot properties: 10:14:13 INFO - { 10:14:13 INFO - "project": "", 10:14:13 INFO - "product": "firefox", 10:14:13 INFO - "script_repo_revision": "production", 10:14:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:14:13 INFO - "repository": "", 10:14:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:14:13 INFO - "buildid": "20161116073153", 10:14:13 INFO - "pgo_build": "True", 10:14:13 INFO - "basedir": "/builds/slave/test", 10:14:13 INFO - "buildnumber": 87, 10:14:13 INFO - "slavename": "talos-linux64-ix-005", 10:14:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:14:13 INFO - "platform": "ubuntu64_hw", 10:14:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:14:13 INFO - "branch": "mozilla-central", 10:14:13 INFO - "repo_path": "mozilla-central", 10:14:13 INFO - "revision": "51750761f2c61c64cf0553f6cb5fefd4999d3bc0", 10:14:13 INFO - "stage_platform": "linux64-pgo", 10:14:13 INFO - "builduid": "07b960913c0e4098890d07ee4c522ddd", 10:14:13 INFO - "slavebuilddir": "test" 10:14:13 INFO - } 10:14:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:14:13 INFO - Running post-action listener: _resource_record_post_action 10:14:13 INFO - [mozharness: 2016-11-16 18:14:13.245176Z] Finished read-buildbot-config step (success) 10:14:13 INFO - [mozharness: 2016-11-16 18:14:13.245280Z] Running download-and-extract step. 10:14:13 INFO - Running pre-action listener: _resource_record_pre_action 10:14:13 INFO - Running main action method: download_and_extract 10:14:13 INFO - mkdir: /builds/slave/test/build/tests 10:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:13 INFO - trying https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:14:13 INFO - Downloaded 1361 bytes. 10:14:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:14:13 INFO - Using the following test package requirements: 10:14:13 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:13 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:13 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:13 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'jsshell-linux-x86_64.zip'], 10:14:13 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:13 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:13 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:13 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:13 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:13 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:13 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:14:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:13 INFO - Fetch https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:14 INFO - Http code: 200 10:14:14 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 10:14:14 INFO - x-amz-cf-id: E2SI5AHA_obIaDf-rY4gYn0QQwm9PlpWVF0el7jYTb2nKb8Nvi6hCg== 10:14:14 INFO - x-amz-version-id: PKho5N1Sh5a_TyIMX.ddBhuWSK0CwIfq 10:14:14 INFO - Expected file size: 21908829 10:14:14 INFO - Obtained file size: 21908829 10:14:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:19 INFO - Http code: 200 10:14:19 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 10:14:19 INFO - x-amz-cf-id: V4Bis736LGSxAQzXaqyElCUO6Q9H0qidh8tmwVFJcJNbVhUENVdNNg== 10:14:19 INFO - x-amz-version-id: PKho5N1Sh5a_TyIMX.ddBhuWSK0CwIfq 10:14:19 INFO - Expected file size: 21908829 10:14:19 INFO - Obtained file size: 21908829 10:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:14:24 INFO - Http code: 200 10:14:24 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 10:14:24 INFO - x-amz-cf-id: XwzjYj6f2R0aiFAckW6gdkc577vvqSUzlY03oqmN_ZJk9YogVwNJRQ== 10:14:24 INFO - x-amz-version-id: Vur_tYqL1SRsmq5uCQ79elKIcBj3CJYt 10:14:25 INFO - Expected file size: 14409366 10:14:25 INFO - Obtained file size: 14409366 10:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:26 INFO - trying https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:27 INFO - Downloaded 59514646 bytes. 10:14:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:14:27 INFO - mkdir: /builds/slave/test/properties 10:14:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:27 INFO - Contents: 10:14:27 INFO - build_url:https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:14:28 INFO - Running post-action listener: _resource_record_post_action 10:14:28 INFO - Running post-action listener: set_extra_try_arguments 10:14:28 INFO - [mozharness: 2016-11-16 18:14:28.390029Z] Finished download-and-extract step (success) 10:14:28 INFO - [mozharness: 2016-11-16 18:14:28.390255Z] Running populate-webroot step. 10:14:28 INFO - Running pre-action listener: _resource_record_pre_action 10:14:28 INFO - Running main action method: populate_webroot 10:14:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:28 INFO - '--tppagecycles', 10:14:28 INFO - '7'], 10:14:28 INFO - 'tests': ['tsvgm']}}, 10:14:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['damp', 'tps']}, 10:14:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'tests': ['damp', 'tps']}, 10:14:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['dromaeo_dom']}, 10:14:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['basic_compositor_video']}, 10:14:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:14:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tsvgx', 10:14:28 INFO - 'tsvgr_opacity', 10:14:28 INFO - 'tart', 10:14:28 INFO - 'tscrollx', 10:14:28 INFO - 'cart']}, 10:14:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:28 INFO - 'tsvgr_opacity', 10:14:28 INFO - 'tart', 10:14:28 INFO - 'tscrollx', 10:14:28 INFO - 'cart']}, 10:14:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tp5o']}, 10:14:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:14:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s', 10:14:28 INFO - '--xperf_path', 10:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:28 INFO - 'tests': ['tp5n']}, 10:14:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:14:28 INFO - 'talos_options': ['--xperf_path', 10:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:28 INFO - 'tests': ['tp5n']}}, 10:14:28 INFO - 'talos.zip': {'path': '', 10:14:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:28 INFO - Running post-action listener: _resource_record_post_action 10:14:28 INFO - [mozharness: 2016-11-16 18:14:28.409957Z] Finished populate-webroot step (success) 10:14:28 INFO - [mozharness: 2016-11-16 18:14:28.410044Z] Running create-virtualenv step. 10:14:28 INFO - Running pre-action listener: _resource_record_pre_action 10:14:28 INFO - Running main action method: create_virtualenv 10:14:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:14:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:28 INFO - Using real prefix '/usr' 10:14:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:30 INFO - Installing pip.................done. 10:14:30 INFO - Return code: 0 10:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:14:31 INFO - Reading from file tmpfile_stdout 10:14:31 INFO - Output received: 10:14:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:14:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:14:31 INFO - Using env: {'DISPLAY': ':0', 10:14:31 INFO - 'HOME': '/home/cltbld', 10:14:31 INFO - 'LANG': 'en_US.UTF-8', 10:14:31 INFO - 'LANGUAGE': 'en_US:en', 10:14:31 INFO - 'LOGNAME': 'cltbld', 10:14:31 INFO - 'MAIL': '/var/mail/cltbld', 10:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:31 INFO - 'MOZ_NO_REMOTE': '1', 10:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:31 INFO - 'NO_EM_RESTART': '1', 10:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:31 INFO - 'PWD': '/builds/slave/test', 10:14:31 INFO - 'SHELL': '/bin/bash', 10:14:31 INFO - 'SHLVL': '1', 10:14:31 INFO - 'TERM': 'linux', 10:14:31 INFO - 'TMOUT': '86400', 10:14:31 INFO - 'USER': 'cltbld', 10:14:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:31 INFO - '_': '/tools/buildbot/bin/python'} 10:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:14:31 INFO - Cleaning up... 10:14:31 INFO - Return code: 0 10:14:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:14:31 INFO - Using env: {'DISPLAY': ':0', 10:14:31 INFO - 'HOME': '/home/cltbld', 10:14:31 INFO - 'LANG': 'en_US.UTF-8', 10:14:31 INFO - 'LANGUAGE': 'en_US:en', 10:14:31 INFO - 'LOGNAME': 'cltbld', 10:14:31 INFO - 'MAIL': '/var/mail/cltbld', 10:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:31 INFO - 'MOZ_NO_REMOTE': '1', 10:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:31 INFO - 'NO_EM_RESTART': '1', 10:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:31 INFO - 'PWD': '/builds/slave/test', 10:14:31 INFO - 'SHELL': '/bin/bash', 10:14:31 INFO - 'SHLVL': '1', 10:14:31 INFO - 'TERM': 'linux', 10:14:31 INFO - 'TMOUT': '86400', 10:14:31 INFO - 'USER': 'cltbld', 10:14:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:31 INFO - '_': '/tools/buildbot/bin/python'} 10:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:31 INFO - Downloading/unpacking psutil>=3.1.1 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:33 INFO - Installing collected packages: psutil 10:14:33 INFO - Running setup.py install for psutil 10:14:33 INFO - building 'psutil._psutil_linux' extension 10:14:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:14:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:14:33 INFO - building 'psutil._psutil_posix' extension 10:14:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:14:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:34 INFO - Successfully installed psutil 10:14:34 INFO - Cleaning up... 10:14:34 INFO - Return code: 0 10:14:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:14:34 INFO - Using env: {'DISPLAY': ':0', 10:14:34 INFO - 'HOME': '/home/cltbld', 10:14:34 INFO - 'LANG': 'en_US.UTF-8', 10:14:34 INFO - 'LANGUAGE': 'en_US:en', 10:14:34 INFO - 'LOGNAME': 'cltbld', 10:14:34 INFO - 'MAIL': '/var/mail/cltbld', 10:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:34 INFO - 'MOZ_NO_REMOTE': '1', 10:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:34 INFO - 'NO_EM_RESTART': '1', 10:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:34 INFO - 'PWD': '/builds/slave/test', 10:14:34 INFO - 'SHELL': '/bin/bash', 10:14:34 INFO - 'SHLVL': '1', 10:14:34 INFO - 'TERM': 'linux', 10:14:34 INFO - 'TMOUT': '86400', 10:14:34 INFO - 'USER': 'cltbld', 10:14:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:34 INFO - '_': '/tools/buildbot/bin/python'} 10:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:36 INFO - Installing collected packages: mozsystemmonitor 10:14:36 INFO - Running setup.py install for mozsystemmonitor 10:14:36 INFO - Successfully installed mozsystemmonitor 10:14:36 INFO - Cleaning up... 10:14:36 INFO - Return code: 0 10:14:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:39 INFO - warning: no files found matching '*.txt' 10:14:39 INFO - no previously-included directories found matching 'build' 10:14:39 INFO - no previously-included directories found matching 'dist' 10:14:39 INFO - no previously-included directories found matching '.git*' 10:14:39 INFO - Installing collected packages: jsonschema, functools32 10:14:39 INFO - Running setup.py install for functools32 10:14:39 INFO - warning: no files found matching '*.txt' 10:14:39 INFO - no previously-included directories found matching 'build' 10:14:39 INFO - no previously-included directories found matching 'dist' 10:14:39 INFO - no previously-included directories found matching '.git*' 10:14:39 INFO - Successfully installed jsonschema functools32 10:14:39 INFO - Cleaning up... 10:14:39 INFO - Return code: 0 10:14:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:14:39 INFO - Using env: {'DISPLAY': ':0', 10:14:39 INFO - 'HOME': '/home/cltbld', 10:14:39 INFO - 'LANG': 'en_US.UTF-8', 10:14:39 INFO - 'LANGUAGE': 'en_US:en', 10:14:39 INFO - 'LOGNAME': 'cltbld', 10:14:39 INFO - 'MAIL': '/var/mail/cltbld', 10:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:39 INFO - 'MOZ_NO_REMOTE': '1', 10:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:39 INFO - 'NO_EM_RESTART': '1', 10:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:39 INFO - 'PWD': '/builds/slave/test', 10:14:39 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:39 INFO - Cleaning up... 10:14:39 INFO - Return code: 0 10:14:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:14:39 INFO - Using env: {'DISPLAY': ':0', 10:14:39 INFO - 'HOME': '/home/cltbld', 10:14:39 INFO - 'LANG': 'en_US.UTF-8', 10:14:39 INFO - 'LANGUAGE': 'en_US:en', 10:14:39 INFO - 'LOGNAME': 'cltbld', 10:14:39 INFO - 'MAIL': '/var/mail/cltbld', 10:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:39 INFO - 'MOZ_NO_REMOTE': '1', 10:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:39 INFO - 'NO_EM_RESTART': '1', 10:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:39 INFO - 'PWD': '/builds/slave/test', 10:14:39 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - Downloading docopt-0.6.1.tar.gz 10:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:42 INFO - Running setup.py install for blobuploader 10:14:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:42 INFO - Running setup.py install for requests 10:14:42 INFO - Running setup.py install for docopt 10:14:42 INFO - Successfully installed blobuploader requests docopt 10:14:42 INFO - Cleaning up... 10:14:42 INFO - Return code: 0 10:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:42 INFO - Using env: {'DISPLAY': ':0', 10:14:42 INFO - 'HOME': '/home/cltbld', 10:14:42 INFO - 'LANG': 'en_US.UTF-8', 10:14:42 INFO - 'LANGUAGE': 'en_US:en', 10:14:42 INFO - 'LOGNAME': 'cltbld', 10:14:42 INFO - 'MAIL': '/var/mail/cltbld', 10:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:42 INFO - 'MOZ_NO_REMOTE': '1', 10:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:42 INFO - 'NO_EM_RESTART': '1', 10:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:42 INFO - 'PWD': '/builds/slave/test', 10:14:42 INFO - 'SHELL': '/bin/bash', 10:14:42 INFO - 'SHLVL': '1', 10:14:42 INFO - 'TERM': 'linux', 10:14:42 INFO - 'TMOUT': '86400', 10:14:42 INFO - 'USER': 'cltbld', 10:14:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:42 INFO - '_': '/tools/buildbot/bin/python'} 10:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:43 INFO - Running setup.py (path:/tmp/pip-HqcBia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:43 INFO - Running setup.py (path:/tmp/pip-GDWRYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:43 INFO - Running setup.py (path:/tmp/pip-d9WvC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:43 INFO - Running setup.py (path:/tmp/pip-fdEekW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:43 INFO - Running setup.py (path:/tmp/pip-rsfjjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:43 INFO - Running setup.py (path:/tmp/pip-Up0eTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:43 INFO - Running setup.py (path:/tmp/pip-gNX92p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:43 INFO - Running setup.py (path:/tmp/pip-3BKeOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:43 INFO - Running setup.py (path:/tmp/pip-92QPXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:43 INFO - Running setup.py (path:/tmp/pip-0CnE1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:43 INFO - Running setup.py (path:/tmp/pip-QX1st6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:43 INFO - Running setup.py (path:/tmp/pip-VPtkuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:44 INFO - Running setup.py (path:/tmp/pip-wZBuWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:44 INFO - Running setup.py (path:/tmp/pip-vxOJEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:44 INFO - Running setup.py (path:/tmp/pip-QjDsGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:44 INFO - Running setup.py (path:/tmp/pip-nPJS_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:44 INFO - Running setup.py (path:/tmp/pip-mi3VIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:44 INFO - Running setup.py install for manifestparser 10:14:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozcrash 10:14:44 INFO - Running setup.py install for mozdebug 10:14:44 INFO - Running setup.py install for mozdevice 10:14:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozfile 10:14:44 INFO - Running setup.py install for mozhttpd 10:14:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozinfo 10:14:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozInstall 10:14:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozleak 10:14:45 INFO - Running setup.py install for mozlog 10:14:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for moznetwork 10:14:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozprocess 10:14:45 INFO - Running setup.py install for mozprofile 10:14:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozrunner 10:14:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozscreenshot 10:14:46 INFO - Running setup.py install for moztest 10:14:46 INFO - Running setup.py install for mozversion 10:14:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:46 INFO - Cleaning up... 10:14:46 INFO - Return code: 0 10:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:46 INFO - Using env: {'DISPLAY': ':0', 10:14:46 INFO - 'HOME': '/home/cltbld', 10:14:46 INFO - 'LANG': 'en_US.UTF-8', 10:14:46 INFO - 'LANGUAGE': 'en_US:en', 10:14:46 INFO - 'LOGNAME': 'cltbld', 10:14:46 INFO - 'MAIL': '/var/mail/cltbld', 10:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:46 INFO - 'MOZ_NO_REMOTE': '1', 10:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:46 INFO - 'NO_EM_RESTART': '1', 10:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:46 INFO - 'PWD': '/builds/slave/test', 10:14:46 INFO - 'SHELL': '/bin/bash', 10:14:46 INFO - 'SHLVL': '1', 10:14:46 INFO - 'TERM': 'linux', 10:14:46 INFO - 'TMOUT': '86400', 10:14:46 INFO - 'USER': 'cltbld', 10:14:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:46 INFO - '_': '/tools/buildbot/bin/python'} 10:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 INFO - Running setup.py (path:/tmp/pip-Oiti9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 INFO - Running setup.py (path:/tmp/pip-K8VU1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 INFO - Running setup.py (path:/tmp/pip-icxjiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 INFO - Running setup.py (path:/tmp/pip-r0QFem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:46 INFO - Running setup.py (path:/tmp/pip-Fnotnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:46 INFO - Running setup.py (path:/tmp/pip-ZLp9Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:46 INFO - Running setup.py (path:/tmp/pip-WehypR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:46 INFO - Running setup.py (path:/tmp/pip-6ZrBw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:47 INFO - Running setup.py (path:/tmp/pip-V6LWBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:47 INFO - Running setup.py (path:/tmp/pip-s5obcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 INFO - Running setup.py (path:/tmp/pip-YID2eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 INFO - Running setup.py (path:/tmp/pip-NTmhmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 INFO - Running setup.py (path:/tmp/pip-XK1B0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 INFO - Running setup.py (path:/tmp/pip-ZF9jZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 INFO - Running setup.py (path:/tmp/pip-hZ4WNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:47 INFO - Running setup.py (path:/tmp/pip-1dIzI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:47 INFO - Running setup.py (path:/tmp/pip-_G92a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:49 INFO - Downloading blessings-1.6.tar.gz 10:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:49 INFO - Installing collected packages: blessings 10:14:49 INFO - Running setup.py install for blessings 10:14:49 INFO - Successfully installed blessings 10:14:49 INFO - Cleaning up... 10:14:49 INFO - Return code: 0 10:14:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:50 INFO - Reading from file tmpfile_stdout 10:14:50 INFO - Current package versions: 10:14:50 INFO - argparse == 1.2.1 10:14:50 INFO - blessings == 1.6 10:14:50 INFO - blobuploader == 1.2.4 10:14:50 INFO - docopt == 0.6.1 10:14:50 INFO - functools32 == 3.2.3-2 10:14:50 INFO - jsonschema == 2.5.1 10:14:50 INFO - manifestparser == 1.1 10:14:50 INFO - mozInstall == 1.12 10:14:50 INFO - mozcrash == 1.0 10:14:50 INFO - mozdebug == 0.1 10:14:50 INFO - mozdevice == 0.48 10:14:50 INFO - mozfile == 1.2 10:14:50 INFO - mozhttpd == 0.7 10:14:50 INFO - mozinfo == 0.9 10:14:50 INFO - mozleak == 0.1 10:14:50 INFO - mozlog == 3.4 10:14:50 INFO - moznetwork == 0.27 10:14:50 INFO - mozprocess == 0.23 10:14:50 INFO - mozprofile == 0.28 10:14:50 INFO - mozrunner == 6.13 10:14:50 INFO - mozscreenshot == 0.1 10:14:50 INFO - mozsystemmonitor == 0.3 10:14:50 INFO - moztest == 0.7 10:14:50 INFO - mozversion == 1.4 10:14:50 INFO - psutil == 3.1.1 10:14:50 INFO - requests == 1.2.3 10:14:50 INFO - wsgiref == 0.1.2 10:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:50 INFO - Using env: {'DISPLAY': ':0', 10:14:50 INFO - 'HOME': '/home/cltbld', 10:14:50 INFO - 'LANG': 'en_US.UTF-8', 10:14:50 INFO - 'LANGUAGE': 'en_US:en', 10:14:50 INFO - 'LOGNAME': 'cltbld', 10:14:50 INFO - 'MAIL': '/var/mail/cltbld', 10:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:50 INFO - 'MOZ_NO_REMOTE': '1', 10:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:50 INFO - 'NO_EM_RESTART': '1', 10:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:50 INFO - 'PWD': '/builds/slave/test', 10:14:50 INFO - 'SHELL': '/bin/bash', 10:14:50 INFO - 'SHLVL': '1', 10:14:50 INFO - 'TERM': 'linux', 10:14:50 INFO - 'TMOUT': '86400', 10:14:50 INFO - 'USER': 'cltbld', 10:14:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:50 INFO - '_': '/tools/buildbot/bin/python'} 10:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:14:50 INFO - Cleaning up... 10:14:50 INFO - Return code: 0 10:14:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1acc443e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2044130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:14:50 INFO - Using env: {'DISPLAY': ':0', 10:14:50 INFO - 'HOME': '/home/cltbld', 10:14:50 INFO - 'LANG': 'en_US.UTF-8', 10:14:50 INFO - 'LANGUAGE': 'en_US:en', 10:14:50 INFO - 'LOGNAME': 'cltbld', 10:14:50 INFO - 'MAIL': '/var/mail/cltbld', 10:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:50 INFO - 'MOZ_NO_REMOTE': '1', 10:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:50 INFO - 'NO_EM_RESTART': '1', 10:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:50 INFO - 'PWD': '/builds/slave/test', 10:14:50 INFO - 'SHELL': '/bin/bash', 10:14:50 INFO - 'SHLVL': '1', 10:14:50 INFO - 'TERM': 'linux', 10:14:50 INFO - 'TMOUT': '86400', 10:14:50 INFO - 'USER': 'cltbld', 10:14:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:50 INFO - '_': '/tools/buildbot/bin/python'} 10:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:50 INFO - Cleaning up... 10:14:50 INFO - Return code: 0 10:14:50 INFO - Running post-action listener: _resource_record_post_action 10:14:50 INFO - Running post-action listener: _start_resource_monitoring 10:14:50 INFO - Starting resource monitoring. 10:14:50 INFO - [mozharness: 2016-11-16 18:14:50.641059Z] Finished create-virtualenv step (success) 10:14:50 INFO - [mozharness: 2016-11-16 18:14:50.641593Z] Running install step. 10:14:50 INFO - Running pre-action listener: _resource_record_pre_action 10:14:50 INFO - Running main action method: install 10:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:50 INFO - Reading from file tmpfile_stdout 10:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:50 INFO - Reading from file tmpfile_stdout 10:14:50 INFO - Output received: 10:14:50 INFO - Usage: mozinstall [options] installer 10:14:50 INFO - Options: 10:14:50 INFO - -h, --help show this help message and exit 10:14:50 INFO - -d DEST, --destination=DEST 10:14:50 INFO - Directory to install application into. [default: 10:14:50 INFO - "/builds/slave/test"] 10:14:50 INFO - --app=APP Application being installed. [default: firefox] 10:14:50 INFO - mkdir: /builds/slave/test/build/application 10:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:15:07 INFO - Reading from file tmpfile_stdout 10:15:07 INFO - Output received: 10:15:07 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:07 INFO - Running post-action listener: _resource_record_post_action 10:15:07 INFO - [mozharness: 2016-11-16 18:15:07.848997Z] Finished install step (success) 10:15:07 INFO - [mozharness: 2016-11-16 18:15:07.849306Z] Running run-tests step. 10:15:07 INFO - Running pre-action listener: _resource_record_pre_action 10:15:07 INFO - Running main action method: run_tests 10:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:07 INFO - Python 2.7.3 10:15:07 INFO - Return code: 0 10:15:07 INFO - grabbing minidump binary from tooltool 10:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d2fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d4350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:15:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:15:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:15:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:07 INFO - Return code: 0 10:15:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:15:07 INFO - Using env: {'DISPLAY': ':0', 10:15:07 INFO - 'HOME': '/home/cltbld', 10:15:07 INFO - 'LANG': 'en_US.UTF-8', 10:15:07 INFO - 'LANGUAGE': 'en_US:en', 10:15:07 INFO - 'LOGNAME': 'cltbld', 10:15:07 INFO - 'MAIL': '/var/mail/cltbld', 10:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:07 INFO - 'MOZ_NO_REMOTE': '1', 10:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:07 INFO - 'NO_EM_RESTART': '1', 10:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:07 INFO - 'PWD': '/builds/slave/test', 10:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:07 INFO - 'SHELL': '/bin/bash', 10:15:07 INFO - 'SHLVL': '1', 10:15:07 INFO - 'TERM': 'linux', 10:15:07 INFO - 'TMOUT': '86400', 10:15:07 INFO - 'USER': 'cltbld', 10:15:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927', 10:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:07 INFO - '_': '/tools/buildbot/bin/python'} 10:15:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:15:08 INFO - mozversion application_buildid: 20161116073153 10:15:08 INFO - mozversion application_changeset: 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 10:15:08 INFO - mozversion application_display_name: Nightly 10:15:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:08 INFO - mozversion application_name: Firefox 10:15:08 INFO - mozversion application_remotingname: firefox 10:15:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:15:08 INFO - mozversion application_vendor: Mozilla 10:15:08 INFO - mozversion application_version: 53.0a1 10:15:08 INFO - mozversion platform_buildid: 20161116073153 10:15:08 INFO - mozversion platform_changeset: 51750761f2c61c64cf0553f6cb5fefd4999d3bc0 10:15:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:15:08 INFO - mozversion platform_version: 53.0a1 10:15:08 INFO - using testdate: 1479320108 10:15:08 INFO - actual date: 1479320108 10:15:08 INFO - starting webserver on 'localhost:45731' 10:15:08 INFO - SUITE-START | Running 2 tests 10:15:08 INFO - TEST-START | dromaeo_css 10:15:08 INFO - operating with platform_type : linux_ 10:15:08 INFO - Initialising browser for dromaeo_css test... 10:15:08 INFO - TEST-INFO | started process 1271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5bFBz/profile http://localhost:45731/getInfo.html) 10:15:12 INFO - PROCESS | 1271 | __metrics Screen width/height:1600/1200 10:15:12 INFO - PROCESS | 1271 | colorDepth:24 10:15:12 INFO - PROCESS | 1271 | Browser inner width/height: 1024/697 10:15:12 INFO - PROCESS | 1271 | __metrics 10:15:12 INFO - PROCESS | 1271 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:12 INFO - PROCESS | 1271 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:13 INFO - PROCESS | 1271 | console.error: PushService: 10:15:13 INFO - PROCESS | 1271 | stateChangeProcessEnqueue: Error transitioning state 10:15:13 INFO - PROCESS | 1271 | UnknownError 10:15:13 INFO - TEST-INFO | 1271: exit 0 10:15:13 INFO - Browser initialized. 10:15:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:13 INFO - TEST-INFO | started process 1354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5bFBz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:26 INFO - PROCESS | 1354 | RSS: Main: 173150208 10:15:26 INFO - PROCESS | 1354 | 10:16:17 INFO - PROCESS | 1354 | 1479320177839 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:18:28 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45731/tests/dromaeo/cssquery-ext.html) 10:18:29 INFO - PROCESS | 1354 | RSS: Main: 320188416 10:18:29 INFO - PROCESS | 1354 | 10:21:32 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-ext.html (next: http://localhost:45731/tests/dromaeo/cssquery-jquery.html) 10:21:32 INFO - PROCESS | 1354 | RSS: Main: 285601792 10:21:32 INFO - PROCESS | 1354 | 10:24:34 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45731/tests/dromaeo/cssquery-mootools.html) 10:24:35 INFO - PROCESS | 1354 | RSS: Main: 222789632 10:24:35 INFO - PROCESS | 1354 | 10:27:37 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45731/tests/dromaeo/cssquery-prototype.html) 10:27:37 INFO - PROCESS | 1354 | RSS: Main: 252542976 10:27:37 INFO - PROCESS | 1354 | 10:30:40 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45731/tests/dromaeo/cssquery-yui.html) 10:30:41 INFO - PROCESS | 1354 | RSS: Main: 222339072 10:30:41 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-yui.html (next: http://localhost:45731/tests/dromaeo/cssquery-dojo.html) 10:33:44 INFO - PROCESS | 1354 | RSS: Main: 317620224 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | __start_tp_report 10:33:44 INFO - PROCESS | 1354 | _x_x_mozilla_page_load 10:33:44 INFO - PROCESS | 1354 | _x_x_mozilla_page_load_details 10:33:44 INFO - PROCESS | 1354 | |i|pagename|runs| 10:33:44 INFO - PROCESS | 1354 | |0;dojo.html;3092.953605695914;3108.673589273127;3128.812271263723;3162.6204855417354;3178.0465860241934;5275.973620131898;5281.815136470224;5363.812266570666;5366.329208848894;5386;5225.059489291926;5228.137357336044;5302.575793936486;5309.522143007129;5384;4724;4746.145693775119;4790.377250957371;4818.445878723939;4893.730844803535;4442.234848484848;4861.586765124968;4974.452810190876;4999.675021123633;5045.873853153664;4729.077829823186;4782.641301902371;4812.302216178669;4897.436794768611;4914.557689807899;4818.614510839125;4820.204666230068;4831.9033619327765;4860.198067318888;4867.269909513566;4785.947091639834;4804.56758891698;4808.278758186265;4815.49437309081;4850.708957462563;5261.421243663194;5276.366835979668;5300.602454815904;5329.413764485904;5357.4106848246665;5646.2942132233475;5666.121751128581;5695.03184458643;5781.219535362757;5786.5370770338695;5760.481556659879;5770.2210201622665;5771.942280577183;5779.826605201851;5779.913301300442;5358.115910874662;5361;5364.865878353034;5365;5365.651232669864;5658.179563963285;5691.857703557362;5752.827415177551;5756.740946657411;5782.219400380979;5610.691411972299;5613.831585052455;5620.185073164368;5623.156526521055;5659.3208814941645;5638.718064096779;5658.264425624642;5711.086226203871;5711.857203569944;5717.199592057115;5542.528885044736;5560.749766260528;5607.971960140173;5709;5712.257406537206;5584.888302234014;5613;5638.464345887134;5686.744096515667;5691.459311365414;4362.650987920959;4363.2364336241035;4363.323684828857;4386.035072284092;4399.098184872158;3886.417037444406;3896.279188350164;3901.6293452122004;3915.647591716759;3931.2137572485044;5371.194320851903;5376.596755243372;5392.946070539245;5417.079096553595;5460.5085542301385;5737.540996720252;5761.85595360111;5767.596268261265;5767.769289228384;5768.826935191951;5394.271773310631;5430.484104010192;5449.01917654826;5454.372747134131;5461.508464238158;4882.951170488321;4892.779824907817;4893.996730670204;4899.1426500363;4936.6297527685565;5864.472197502245;5868.4424979626865;5869.090291004901;5872.442117998783;5905.970470147622;5651.265335506358;5655.830325090254;5676.262085928803;5682.261306030189;5689.203511508309;5799.072148456226;5811.883762324815;5848.210491583582;5883.823485295448;5886.293644762484;5563;5607.635503692247;5612.831615051555;5652.830415087554;5662.462066103713;5662.150677398423;5717.17101020358;5724.771009159587;5725.828225153252;5727.427257274239;5490.5882058844945;5525;5537.307836520435;5580;5585.888282234414;5543.584231182596;5606.831795046155;5612;5648.350439699487;5659.915101273402;5476.507114359727;5482.616216864782;5510.366307874646;5515.917261241165;5539.8892022160135;5494.203340515683;5552.916706249491;5602.747876345493;5619.80330688424;5658.717064146694;5456.945430545803;5487.890242195213;5490.862728431662;5528.4471552846;5574.860628484158 10:33:44 INFO - PROCESS | 1354 | |1;ext.html;565.572992390745;584.2054805464568;585.4906231578527;590.9320428150764;599.1641659884461;25909.61135582968;27621.88995035917;27652.585211221824;40875;42061.57938420615;42471.787641061754;42860.571394286046;42866;42876.35685464721;42907.57092429075;8524.616392262347;8657.393982421234;8673.783155421102;8676.696315628955;8681.04508504064;8064.556449395281;8142.51144931303;8145.063317718449;8146.348292136615;8149.225823546753;8598.570071496431;8657.480551166918;8666.220040196382;8667.826643467128;8672.34957378196;8654.697085602005;8686.478811271343;8694.826198463254;8697.347698922606;8702.956485217597;8039.839203215903;8092.1503242159315;8098.959505202495;8100.513969161869;8100.878486822702;40925.795371022956;40934.38598420996;41352.37971430431;41356.37965430521;41400.585994139976;3248.4315244832296;3354.26206234628;3365.3437579671972;3600.171960449085;3805.353089974711;29433.705662943525;30351.089467316015;30412.695873041208;30525.69474305273;30538;3940.349842276021;4063.349864021742;4068.7355321903983;4102;4222.398887011814;247069;248907;249004;249031.9999999982;249346;54643.180352294745;54854.45145548573;55062.449375505734;55062.449375506534;55099;56130.71934640382;56323.71838140783;56660;57262.71368643214;57281;14324.785128223086;14711.04378215434;14713;14722;14734;11125.610603628835;11337;11343.546258149747;11344.773104537862;11351.545938162546;14182.85817141836;15136.35113855071;15186.46847360337;15221;15500.379984800707;6254.405831446005;6359.1733074700915;6437.742490300336;6514.869702606016;6563.50773691975;886.6054605700401;970.6360114956891;993.9701808945744;1022.2435397805571;1024.2215915903819;29457;29604;30485.23786905345;30587.847060764998;30814;861.7974775927652;869.5912920927154;1066.248294952057;1166.848309719731;1212.3271584270815;15168.407317231531;15761.68476630484;15819.446319378767;15875.285612147482;16030.438934637232;498418;499768;502238;502876;503111;55200;55272;55345;55375.169372459444;55468.16797748037;1198.4666823263738;1226.1233218248994;1248.1450206608502;1250.0749445410331;1250.5185503581006;23005.309840704806;25049.499010020063;25728.61407078858;26710.332241694112;26750.197494075208;50507.242391364896;51028.23457648212;51177.488225117275;51204.231936520235;51262.74368628133;425290;430421.893044435;432095;432174;432282;26331.21006369812;26785.732142678324;27354.31614209581;34107;34289.14277143091;44762;45123.23151527297;45328.32007519824;45562.772186138856;45883.08233835371;38565.42151867668;39081;39197.6080239194;39434.80282598569;40969;37806.62193378031;38134;38757.22485550329;38776.22447550977;40363.596364035984;34882.127946801535;35200.11999700028;36122;40355.79822100871;40766.59233407628;31864;33537.49693754644;35772;36229.27541449209;37554.248915021;26898.731012689623;26976.190714278604;27371.315717106434;27458.313542161606;27667 10:33:44 INFO - PROCESS | 1354 | |2;jquery.html;382.5352197080547;401.61244399154816;402.21166513633284;404.9028233224025;417.1469345189088;13435.395407206675;15282.159481228542;18256.995865227425;18724.719129213074;19119.808801911975;16846.32614695414;17064.23210955507;17291.39480118196;17400.21699023544;17420.128993550334;5353.9196912046355;5587.664740115606;5592.832215033555;5598.552115830744;5607.943920560783;5363.275957745713;5381.5425688816495;5469.808556700516;5494.890102197954;5496.862578435551;5511.22842802006;5515.944840551603;5517.117261238202;5522.889542209154;5524;5264.184051472028;5515.7242137892945;5521.089020311644;5525.778968841241;5525.917111243334;4981.12830254704;4982.5017498250245;4982.676126051795;4983.900321993576;4985;22315.44211394712;22483.550328993493;22487;22551;22733.43166420836;2275.0899640143907;2336.778006089419;2353.2704861492994;2399.076355603088;2511.1713134665515;13132.606021819362;13881.305934703325;13929.721405571932;14538.781918271234;14639.63400914975;1845.6954602490573;1866.3561071430336;1888.1408958923794;1896.7723873135312;1899.2782742557877;82805.58597207036;82848;83846.16153838445;86092.56953715254;88183;9822.410655360558;10367.429791361397;10373.429461379697;10738.892611073945;10817.783644327226;14984.850151498564;15004.549863504113;15009.2495375233;15031.098134111988;15039.248037598076;7524.097108347033;7579.2420757924865;7780.922190778133;7884.526928384315;7896.921030789734;7081.92918070823;7114.786556403316;7146.5354751941995;7315.195328513859;7319.121705395387;6246.437820596168;6423.646699431482;6478.1578394808375;6484.708188131545;6605.70274337656;1830.249597664951;1867.2810967777232;1898.8258444081725;1908.4370110817342;1964.4597735622817;936.5598168860624;953.2326477185932;989.8168838764708;1042.74452759073;1074.4412905289205;18124.728129078074;19191.136398862083;19592.70610940837;19711.60576788456;20017.39947801539;995.1690338567232;1028.9125424338865;1037.896210378956;1040.3029969920171;1045.4772613693153;9971;10837.83743243852;10940.945295273472;10942.17933654979;10967.35181381589;478011;494916;497453;500904;504533;58875.11687324694;88079;89016.554917225;89376.5531172353;90200;820.216693058128;841.4110122913985;842.1326034184799;843.2663582683105;843.5739951324542;14788.408463661333;14793.260336983323;14919.477818276308;15044.548663540112;15555.377784888478;37143.44284835675;39203.41194882136;39290.410643839794;39743.44233201489;39855.2028959425;52066.47933520616;52217.7389113052;52540.73729631327;52838.47161528336;56044;5386.622936394415;5393.298871146726;8208.671653133808;8260.215279548433;8736.78158046054;12622.495100195889;13196.934015330246;13404.262765547988;13468.393922273326;13566.321683915961;11498.655040348469;11707.707307317385;11730.413479325829;11789.233699809485;12221.755564888475;11280.153988451064;11727.296362218294;11807.881921180679;11876.287422754662;12303.44634491432;11837.69785323631;11875.465604048011;12005.339706315886;12288.262704237417;12416.006719462603;8251.257386835214;8325;8771.692990745294;8791.868121978303;8854.778630534289;10445.477726113815;11590.478428470908;11789.882101178879;11852.644420667393;12014.279143251433 10:33:44 INFO - PROCESS | 1354 | |3;mootools.html;1086.7880763251167;1089.9564017439302;1196.7068068323256;1273.3696820074065;1315.4935349890288;7009.719611215552;7575.431842611805;7789.065312162541;7794;7799.493032952854;7788.299053085221;7851.254130857574;7854.096778870432;7862.331701805353;7875.92124078759;2288.084766093559;2311.087120587367;2316.1893337331885;2318.3740390094663;2320.8027317678016;2247.5392544528413;2302.3208153594646;2325.976740232593;2328.7438381777993;2332.7667233276707;2221.8222542196586;2255.650374192003;2263.8302127340435;2274.158561332301;2277.4420267034598;2194.1113848891223;2207.3377986604037;2221.5890060338807;2227.888605569723;2228.74369447514;2224.677421773834;2242.338510139513;2243.5849367866995;2247.8876056197287;2250.8987095580737;7839.647215875242;7852.685892564291;7892;7900.80247993799;7905.802354941115;4967.478414766434;5141.922871156936;5156.948430515685;5209.088409528355;5213.061648903196;3199.808011519316;3363.6636336366414;3370.9831450842835;3426.400379933502;3431.673990970854;1122.5004872831594;1139.8575178102737;1140.5779861451233;1152.982705259422;1158.4960542164185;11469.885301146966;11520.94239528797;11544.249623774513;11566.884331156749;11601.76796464066;4186.225548273579;4410.735355878657;4474.574915383034;4486.214912390384;4581;9158.95420522893;9165.954170229239;9168.220701240336;9171.174594286545;9172.220361269234;5163.277141200235;5170.534651881274;5171.663841850268;5173.094708426011;5176.094183517869;3965.7818819965178;4262;4378.868633940987;4390.05613793036;4847.903041939141;3608.4948107265004;3623.673869351771;3690.2619476104887;3714.3871261242134;3730.8880733578035;1144.3134119528218;1154.682462322851;1165.4231155577875;1166.2302880099094;1185.6502331812137;640.4460141977249;739.7558805594141;739.985200295991;764.5259938837845;803.0804728585737;5336.893262134736;5513.393526712059;5661.49046585801;5676.716164191774;5783.2192653992015;415.61347946409524;419.69781757134814;423.9872803815891;429.85599824058664;436.89514516515806;3975.741576797499;4092.3656833190903;4100.384942258685;4105.815238314223;4106.178764247163;10237.795244095076;10288.434136122436;10401.635942741968;10406.739831504121;10408.427536485415;10318.587256509656;10321.380717156995;10321.535530901128;10327.793444131075;10353.741156470998;7077.893831592531;7330.523515971445;7347.8530429392185;7434.962825185839;7449.068866391701;5507.504324610804;5548.778048878;5628.1557766333735;5647.915281270702;5770.192173095686;9149.268058555434;9252;9297.907020929975;9352.766180845534;9395.953020234854;8242.216989386;9342;9343.579538920629;9454.669086581936;9534.09426104519;6688.230853451721;7229.963850180716;7392.44556658242;7432.3310902019075;7616.124145723313;7564.583947882919;7712.267334603203;7714.6914123434435;7886.605669716377;7964.880526792219;6723.562968407038;6815.216250131299;6837.145356830396;6837.453003759588;6844.110265665432;7171.191489574013;7187.065681461377;7251.746188883364;7312.232215617496;7390.113186417664;6246.625202487865;6288.591241569284;6333.113364128933;6340.873182536416;6359.17330747;4814.301926220748;4858.732769697701;4917.877053073702;4925.38432695913;4993.575546078624;4654.813807447799;4655.953440465552;4865.878353041202;4867;5119.846404607868 10:33:44 INFO - PROCESS | 1354 | |4;prototype.html;331.68982519049746;338.43143518888263;349.355439214649;353.0344507771245;355.848764275183;5046.318746969158;5131.4098878628965;5146.68759466336;5205.661631993918;5218.3998840133345;5033.421156566996;5139.6659217150855;5167.715775632339;5167.9483205167935;5180.481951804818;4118.320477121271;4121.505419349674;4129.421880936671;4135.77253251071;4159.6464300534335;3910.432987216852;4103.220388126247;4130.710850240484;4169.312063509517;4177.415161877339;4047.5547689754103;4053.756774593534;4055.513338399396;4055.817488213023;4067.4102255172984;4040.3131467650423;4041.2725709372303;4045.5347635022054;4045.9595404045876;4058.3360822062814;3436.896893093186;3530.717542596586;3555.8044307563073;3567.23304489536;3601;5012.448630650625;5014.674046187022;5018.949810501885;5031.32077169581;5035.269885866565;4581.61056310214;4593.369353879358;4595.172868883633;4610.515895830957;4611.976940115278;5117.692938423706;5356.1697936819855;5357.732113394315;5367.704776237344;5368.839149659007;3932.292187406266;3938.6171366323247;3944.0928586425;3946.625070618287;3953.367461206222;5566.524870909212;5584.776608935637;5586.469285417878;5591.427943146157;5608.523275521586;3963.960360396359;4015.698822588259;4036.5963403659985;4047;4057.69567282455;4058.127502586899;4078.1028173801715;4080.4497189256713;4084.8774536763945;4094.195476098882;4614.400127983407;4630.560096790799;4635.0301122023;4650.720956742606;4651.906961860812;5214.400343960493;5387.515123638891;5414.8917021659345;5442.510174084351;5472.5621950243885;1334.9666258343425;1346.6296768388772;1358.7146699193281;1363.6727185475613;1365.9795103073461;907.4373888189365;927.874736910522;939.5490164720973;942.6606421688186;944.6868852295315;4923.852284431401;4975.5522003019905;5015.4733752956145;5044.520770526794;5057.974710126426;5283.630145889751;5304.602154838402;5306.895466152344;5321.445706061112;5377.435369286247;4745.3593764842;5007;5017.523335283142;5035.219540971156;5084.6440749147205;2824.6892841787385;2826.9575956360673;2830.3348713052414;2850.7006764289868;2852.0445650707247;5534.1975413564805;5540.418256083134;5543.1685247213245;5559.388467268597;5565.8831054609545;5219.19102539107;5372.865678358073;5395.460453954652;5441.700706461183;5443.8094666686475;5416.458354164552;5505.449455054462;5530.917036244459;5532.889342213133;5547.944520554743;5266.657667251617;5293.470652934676;5304.655197412156;5330.786768529216;5344.625876188629;5008.6744361616375;5293.391260004994;5319.973400132974;5331.3868905076415;5339.25250464943;5516.806911758069;5524.535997960464;5525.143602741581;5541.584381171348;5558.24963629921;3809.257194846978;3899.3371126907928;3935.7244992850224;3942.245700663292;3997.480327557399;5483.230968360952;5483.506484416422;5498.202760599611;5498.5876059296515;5501.669899806025;5305.763484274667;5364.46355364476;5365.6244062916785;5367.570594352364;5410.97294513525;5214.374275087014;5302.522772950453;5346.331708536433;5367.812126575551;5380.192971054373;5293.470652934676;5318.7074710891275;5321.36143662763;5331.226972089103;5336.119540275966;5172.482751724948;5328.653637513549;5333.546648534762;5421.120991108034;5424.810131645373;5215.2007557392635;5270.683758974474;5279.234510995807;5280.577553795764;5281.630285879952 10:33:44 INFO - PROCESS | 1354 | |5;yui.html;672.5661948043509;717.3221305865956;729.2780147653822;746.8842329438935;783.3224261014223;13238.073334866564;14238.145711257319;14271.71456570868;14291.92854035731;14293;12329.753404931897;12333.260004399719;12345.197562158475;12428.378581070932;12431.502739890393;653.993460065398;674.1000763980068;758.2455456820471;774.2528460036092;784.0003994906483;775.51917810957;776.022212012865;779.1740754799902;779.9649015794274;780.4341852157197;807.9717209897655;811.9066307374668;812.0134037144868;812.7561731480532;813.048732982412;679.2629996453853;696.8397268628219;794.2494342846013;824.1428913929506;826.050042451186;608.8417011577022;609.1745684597352;609.9634021958697;610.008735804318;610.2402508876432;12257.816132758016;12306.200096993667;12308.07689423288;12332.691682707915;12402.19385739924;12315.75368492625;12533.561325353568;12582.81125783114;12592.370381480981;12746.29895355755;10988.450577471174;11002.834957475645;11007.779844403147;11031.944840275828;11205.21563490556;3913.099987002977;3913.236918800835;4017.4576432181575;4108.26051310764;4130.967258185454;61754;62600.29695397221;62732.37267627357;62814.0577891332;64204;9776.21197836542;9778.55996480146;10028.047335503115;10093.646722364829;10147.086762191439;17566.824331756776;17579.20893559793;17639.736648720027;17641.382551610634;17650.91174544119;6864.725410983605;7124.287571242834;7249.825052484233;7330.633468326562;7333.523320984225;4064.9390259146135;4196.769177695195;4327.069680018748;4376.387305777193;4388.29787234041;3091.474449343617;3178.141901686578;3182.618085829669;3182.6499085100622;3185.0763278649397;578.3118089473513;580.5239703443136;593.4688453833794;614.2567493333028;616.2851092732409;568.6313291139256;586.6392168816233;605.0863196573118;607.6263098194667;648.1800522339245;8540.14598540141;8731.126091390686;8810.603522841488;9142.908570914338;9320.394174378644;636.640298231507;648.4358608011061;653.6730437212466;653.8528831012984;689.6620655878684;3943.3690609502914;4211.0946146578635;4256.871199668241;4332.653387728974;4426.127138753591;83081.16918830856;84399;84666.57666711627;85951.57024214964;88604.11395885958;74201;77572.46755054472;77764;79759;79889;67309;67756.6612166936;69200.6539967297;71015.64492177506;72248.2775172252;8152.55336743439;8218.958905205436;8355.248027677539;8428.325733941392;8503.617337219963;46803.29795053009;46863.531364685914;47629.52370476251;47827.76086119547;48785.75607121942;58341.4165858336;65600.68798623905;66057.66971165114;66526.33473665202;66594.33405665882;11898.464569094238;11963;12216.816747748968;12281.815772763595;12530.812037819258;13379.732405352033;13615.659608509866;13827.377768000262;14046.438142474595;14095.365708542935;10041.849372259569;10053.597856085968;12906.096573239784;13447.46210151583;13917;12338.568150114703;12718.10973231865;12975.610731678065;12977.286249256003;13393.330333483482;12570.49718011306;13137.540186093442;13212.735745285232;13319.467221311426;13435.865641343462;10130.848037279595;10265.640702575374;10597.841032384365;10631.681049568526;10957.397343145885;10133.695989120339;10810.945945270223;10903.781924361627;11274.774504510027;11285 10:33:44 INFO - PROCESS | 1354 | __end_tp_report 10:33:44 INFO - PROCESS | 1354 | __start_cc_report 10:33:44 INFO - PROCESS | 1354 | _x_x_mozilla_cycle_collect,1338 10:33:44 INFO - PROCESS | 1354 | __end_cc_report 10:33:44 INFO - PROCESS | 1354 | __startTimestamp1479321224867__endTimestamp 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | ------- Summary: start ------- 10:33:44 INFO - PROCESS | 1354 | Number of tests: 6 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#0] dojo.html Cycles:165 Average:5291.79 Median:5510.37 stddev:592.84 (10.8%) stddev-sans-first:569.01 10:33:44 INFO - PROCESS | 1354 | Values: 3093.0 3108.7 3128.8 3162.6 3178.0 5276.0 5281.8 5363.8 5366.3 5386.0 5225.1 5228.1 5302.6 5309.5 5384.0 4724.0 4746.1 4790.4 4818.4 4893.7 4442.2 4861.6 4974.5 4999.7 5045.9 4729.1 4782.6 4812.3 4897.4 4914.6 4818.6 4820.2 4831.9 4860.2 4867.3 4785.9 4804.6 4808.3 4815.5 4850.7 5261.4 5276.4 5300.6 5329.4 5357.4 5646.3 5666.1 5695.0 5781.2 5786.5 5760.5 5770.2 5771.9 5779.8 5779.9 5358.1 5361.0 5364.9 5365.0 5365.7 5658.2 5691.9 5752.8 5756.7 5782.2 5610.7 5613.8 5620.2 5623.2 5659.3 5638.7 5658.3 5711.1 5711.9 5717.2 5542.5 5560.7 5608.0 5709.0 5712.3 5584.9 5613.0 5638.5 5686.7 5691.5 4362.7 4363.2 4363.3 4386.0 4399.1 3886.4 3896.3 3901.6 3915.6 3931.2 5371.2 5376.6 5392.9 5417.1 5460.5 5737.5 5761.9 5767.6 5767.8 5768.8 5394.3 5430.5 5449.0 5454.4 5461.5 4883.0 4892.8 4894.0 4899.1 4936.6 5864.5 5868.4 5869.1 5872.4 5906.0 5651.3 5655.8 5676.3 5682.3 5689.2 5799.1 5811.9 5848.2 5883.8 5886.3 5563.0 5607.6 5612.8 5652.8 5662.5 5662.2 5717.2 5724.8 5725.8 5727.4 5490.6 5525.0 5537.3 5580.0 5585.9 5543.6 5606.8 5612.0 5648.4 5659.9 5476.5 5482.6 5510.4 5515.9 5539.9 5494.2 5552.9 5602.7 5619.8 5658.7 5456.9 5487.9 5490.9 5528.4 5574.9 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#1] ext.html Cycles:180 Average:54748.34 Median:40900.40 stddev:108339.18 (264.9%) stddev-sans-first:108566.72 10:33:44 INFO - PROCESS | 1354 | Values: 565.6 584.2 585.5 590.9 599.2 25909.6 27621.9 27652.6 40875.0 42061.6 42471.8 42860.6 42866.0 42876.4 42907.6 8524.6 8657.4 8673.8 8676.7 8681.0 8064.6 8142.5 8145.1 8146.3 8149.2 8598.6 8657.5 8666.2 8667.8 8672.3 8654.7 8686.5 8694.8 8697.3 8703.0 8039.8 8092.2 8099.0 8100.5 8100.9 40925.8 40934.4 41352.4 41356.4 41400.6 3248.4 3354.3 3365.3 3600.2 3805.4 29433.7 30351.1 30412.7 30525.7 30538.0 3940.3 4063.3 4068.7 4102.0 4222.4 247069.0 248907.0 249004.0 249032.0 249346.0 54643.2 54854.5 55062.4 55062.4 55099.0 56130.7 56323.7 56660.0 57262.7 57281.0 14324.8 14711.0 14713.0 14722.0 14734.0 11125.6 11337.0 11343.5 11344.8 11351.5 14182.9 15136.4 15186.5 15221.0 15500.4 6254.4 6359.2 6437.7 6514.9 6563.5 886.6 970.6 994.0 1022.2 1024.2 29457.0 29604.0 30485.2 30587.8 30814.0 861.8 869.6 1066.2 1166.8 1212.3 15168.4 15761.7 15819.4 15875.3 16030.4 498418.0 499768.0 502238.0 502876.0 503111.0 55200.0 55272.0 55345.0 55375.2 55468.2 1198.5 1226.1 1248.1 1250.1 1250.5 23005.3 25049.5 25728.6 26710.3 26750.2 50507.2 51028.2 51177.5 51204.2 51262.7 425290.0 430421.9 432095.0 432174.0 432282.0 26331.2 26785.7 27354.3 34107.0 34289.1 44762.0 45123.2 45328.3 45562.8 45883.1 38565.4 39081.0 39197.6 39434.8 40969.0 37806.6 38134.0 38757.2 38776.2 40363.6 34882.1 35200.1 36122.0 40355.8 40766.6 31864.0 33537.5 35772.0 36229.3 37554.2 26898.7 26976.2 27371.3 27458.3 27667.0 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#2] jquery.html Cycles:180 Average:28623.74 Median:19792.97 stddev:81516.26 (411.8%) stddev-sans-first:81717.36 10:33:44 INFO - PROCESS | 1354 | Values: 382.5 401.6 402.2 404.9 417.1 13435.4 15282.2 18257.0 18724.7 19119.8 16846.3 17064.2 17291.4 17400.2 17420.1 5353.9 5587.7 5592.8 5598.6 5607.9 5363.3 5381.5 5469.8 5494.9 5496.9 5511.2 5515.9 5517.1 5522.9 5524.0 5264.2 5515.7 5521.1 5525.8 5525.9 4981.1 4982.5 4982.7 4983.9 4985.0 22315.4 22483.6 22487.0 22551.0 22733.4 2275.1 2336.8 2353.3 2399.1 2511.2 13132.6 13881.3 13929.7 14538.8 14639.6 1845.7 1866.4 1888.1 1896.8 1899.3 82805.6 82848.0 83846.2 86092.6 88183.0 9822.4 10367.4 10373.4 10738.9 10817.8 14984.9 15004.5 15009.2 15031.1 15039.2 7524.1 7579.2 7780.9 7884.5 7896.9 7081.9 7114.8 7146.5 7315.2 7319.1 6246.4 6423.6 6478.2 6484.7 6605.7 1830.2 1867.3 1898.8 1908.4 1964.5 936.6 953.2 989.8 1042.7 1074.4 18124.7 19191.1 19592.7 19711.6 20017.4 995.2 1028.9 1037.9 1040.3 1045.5 9971.0 10837.8 10940.9 10942.2 10967.4 478011.0 494916.0 497453.0 500904.0 504533.0 58875.1 88079.0 89016.6 89376.6 90200.0 820.2 841.4 842.1 843.3 843.6 14788.4 14793.3 14919.5 15044.5 15555.4 37143.4 39203.4 39290.4 39743.4 39855.2 52066.5 52217.7 52540.7 52838.5 56044.0 5386.6 5393.3 8208.7 8260.2 8736.8 12622.5 13196.9 13404.3 13468.4 13566.3 11498.7 11707.7 11730.4 11789.2 12221.8 11280.2 11727.3 11807.9 11876.3 12303.4 11837.7 11875.5 12005.3 12288.3 12416.0 8251.3 8325.0 8771.7 8791.9 8854.8 10445.5 11590.5 11789.9 11852.6 12014.3 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#3] mootools.html Cycles:180 Average:5363.65 Median:4892.44 stddev:3026.23 (61.9%) stddev-sans-first:3017.65 10:33:44 INFO - PROCESS | 1354 | Values: 1086.8 1090.0 1196.7 1273.4 1315.5 7009.7 7575.4 7789.1 7794.0 7799.5 7788.3 7851.3 7854.1 7862.3 7875.9 2288.1 2311.1 2316.2 2318.4 2320.8 2247.5 2302.3 2326.0 2328.7 2332.8 2221.8 2255.7 2263.8 2274.2 2277.4 2194.1 2207.3 2221.6 2227.9 2228.7 2224.7 2242.3 2243.6 2247.9 2250.9 7839.6 7852.7 7892.0 7900.8 7905.8 4967.5 5141.9 5156.9 5209.1 5213.1 3199.8 3363.7 3371.0 3426.4 3431.7 1122.5 1139.9 1140.6 1153.0 1158.5 11469.9 11520.9 11544.2 11566.9 11601.8 4186.2 4410.7 4474.6 4486.2 4581.0 9159.0 9166.0 9168.2 9171.2 9172.2 5163.3 5170.5 5171.7 5173.1 5176.1 3965.8 4262.0 4378.9 4390.1 4847.9 3608.5 3623.7 3690.3 3714.4 3730.9 1144.3 1154.7 1165.4 1166.2 1185.7 640.4 739.8 740.0 764.5 803.1 5336.9 5513.4 5661.5 5676.7 5783.2 415.6 419.7 424.0 429.9 436.9 3975.7 4092.4 4100.4 4105.8 4106.2 10237.8 10288.4 10401.6 10406.7 10408.4 10318.6 10321.4 10321.5 10327.8 10353.7 7077.9 7330.5 7347.9 7435.0 7449.1 5507.5 5548.8 5628.2 5647.9 5770.2 9149.3 9252.0 9297.9 9352.8 9396.0 8242.2 9342.0 9343.6 9454.7 9534.1 6688.2 7230.0 7392.4 7432.3 7616.1 7564.6 7712.3 7714.7 7886.6 7964.9 6723.6 6815.2 6837.1 6837.5 6844.1 7171.2 7187.1 7251.7 7312.2 7390.1 6246.6 6288.6 6333.1 6340.9 6359.2 4814.3 4858.7 4917.9 4925.4 4993.6 4654.8 4656.0 4865.9 4867.0 5119.8 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#4] prototype.html Cycles:180 Average:4501.85 Median:5143.18 stddev:1293.30 (25.1%) stddev-sans-first:1258.48 10:33:44 INFO - PROCESS | 1354 | Values: 331.7 338.4 349.4 353.0 355.8 5046.3 5131.4 5146.7 5205.7 5218.4 5033.4 5139.7 5167.7 5167.9 5180.5 4118.3 4121.5 4129.4 4135.8 4159.6 3910.4 4103.2 4130.7 4169.3 4177.4 4047.6 4053.8 4055.5 4055.8 4067.4 4040.3 4041.3 4045.5 4046.0 4058.3 3436.9 3530.7 3555.8 3567.2 3601.0 5012.4 5014.7 5018.9 5031.3 5035.3 4581.6 4593.4 4595.2 4610.5 4612.0 5117.7 5356.2 5357.7 5367.7 5368.8 3932.3 3938.6 3944.1 3946.6 3953.4 5566.5 5584.8 5586.5 5591.4 5608.5 3964.0 4015.7 4036.6 4047.0 4057.7 4058.1 4078.1 4080.4 4084.9 4094.2 4614.4 4630.6 4635.0 4650.7 4651.9 5214.4 5387.5 5414.9 5442.5 5472.6 1335.0 1346.6 1358.7 1363.7 1366.0 907.4 927.9 939.5 942.7 944.7 4923.9 4975.6 5015.5 5044.5 5058.0 5283.6 5304.6 5306.9 5321.4 5377.4 4745.4 5007.0 5017.5 5035.2 5084.6 2824.7 2827.0 2830.3 2850.7 2852.0 5534.2 5540.4 5543.2 5559.4 5565.9 5219.2 5372.9 5395.5 5441.7 5443.8 5416.5 5505.4 5530.9 5532.9 5547.9 5266.7 5293.5 5304.7 5330.8 5344.6 5008.7 5293.4 5320.0 5331.4 5339.3 5516.8 5524.5 5525.1 5541.6 5558.2 3809.3 3899.3 3935.7 3942.2 3997.5 5483.2 5483.5 5498.2 5498.6 5501.7 5305.8 5364.5 5365.6 5367.6 5411.0 5214.4 5302.5 5346.3 5367.8 5380.2 5293.5 5318.7 5321.4 5331.2 5336.1 5172.5 5328.7 5333.5 5421.1 5424.8 5215.2 5270.7 5279.2 5280.6 5281.6 10:33:44 INFO - PROCESS | 1354 | 10:33:44 INFO - PROCESS | 1354 | [#5] yui.html Cycles:180 Average:17486.05 Median:47728.64 stddev:23688.66 (49.6%) stddev-sans-first:23721.47 10:33:44 INFO - PROCESS | 1354 | Values: 672.6 717.3 729.3 746.9 783.3 13238.1 14238.1 14271.7 14291.9 14293.0 12329.8 12333.3 12345.2 12428.4 12431.5 654.0 674.1 758.2 774.3 784.0 775.5 776.0 779.2 780.0 780.4 808.0 811.9 812.0 812.8 813.0 679.3 696.8 794.2 824.1 826.1 608.8 609.2 610.0 610.0 610.2 12257.8 12306.2 12308.1 12332.7 12402.2 12315.8 12533.6 12582.8 12592.4 12746.3 10988.5 11002.8 11007.8 11031.9 11205.2 3913.1 3913.2 4017.5 4108.3 4131.0 61754.0 62600.3 62732.4 62814.1 64204.0 9776.2 9778.6 10028.0 10093.6 10147.1 17566.8 17579.2 17639.7 17641.4 17650.9 6864.7 7124.3 7249.8 7330.6 7333.5 4064.9 4196.8 4327.1 4376.4 4388.3 3091.5 3178.1 3182.6 3182.6 3185.1 578.3 580.5 593.5 614.3 616.3 568.6 586.6 605.1 607.6 648.2 8540.1 8731.1 8810.6 9142.9 9320.4 636.6 648.4 653.7 653.9 689.7 3943.4 4211.1 4256.9 4332.7 4426.1 83081.2 84399.0 84666.6 85951.6 88604.1 74201.0 77572.5 77764.0 79759.0 79889.0 67309.0 67756.7 69200.7 71015.6 72248.3 8152.6 8219.0 8355.2 8428.3 8503.6 46803.3 46863.5 47629.5 47827.8 48785.8 58341.4 65600.7 66057.7 66526.3 66594.3 11898.5 11963.0 12216.8 12281.8 12530.8 13379.7 13615.7 13827.4 14046.4 14095.4 10041.8 10053.6 12906.1 13447.5 13917.0 12338.6 12718.1 12975.6 12977.3 13393.3 12570.5 13137.5 13212.7 13319.5 13435.9 10130.8 10265.6 10597.8 10631.7 10957.4 10133.7 10810.9 10903.8 11274.8 11285.0 10:33:44 INFO - PROCESS | 1354 | -------- Summary: end -------- 10:33:44 INFO - PROCESS | 1354 | 10:33:45 INFO - TEST-INFO | 1354: exit 0 10:33:45 INFO - TEST-OK | dromaeo_css | took 1117730ms 10:33:45 INFO - TEST-START | kraken 10:33:45 INFO - operating with platform_type : linux_ 10:33:45 INFO - Initialising browser for kraken test... 10:33:45 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppeMt7U/profile http://localhost:45731/getInfo.html) 10:33:49 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 10:33:49 INFO - PROCESS | 1662 | colorDepth:24 10:33:49 INFO - PROCESS | 1662 | Browser inner width/height: 1024/697 10:33:49 INFO - PROCESS | 1662 | __metrics 10:33:50 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:33:50 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:50 INFO - PROCESS | 1662 | console.error: PushService: 10:33:50 INFO - PROCESS | 1662 | stateChangeProcessEnqueue: Error transitioning state 10:33:50 INFO - PROCESS | 1662 | UnknownError 10:33:51 INFO - TEST-INFO | 1662: exit 0 10:33:51 INFO - Browser initialized. 10:33:51 INFO - Running cycle 1/1 for kraken test... 10:33:51 INFO - TEST-INFO | started process 1747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppeMt7U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:03 INFO - PROCESS | 1747 | RSS: Main: 173268992 10:34:03 INFO - PROCESS | 1747 | 10:34:06 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:07 INFO - PROCESS | 1747 | RSS: Main: 230899712 10:34:07 INFO - PROCESS | 1747 | 10:34:09 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-dft) 10:34:10 INFO - PROCESS | 1747 | RSS: Main: 217169920 10:34:10 INFO - PROCESS | 1747 | 10:34:13 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-fft) 10:34:14 INFO - PROCESS | 1747 | RSS: Main: 298356736 10:34:14 INFO - PROCESS | 1747 | 10:34:16 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-oscillator) 10:34:17 INFO - PROCESS | 1747 | RSS: Main: 207732736 10:34:17 INFO - PROCESS | 1747 | 10:34:19 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:19 INFO - PROCESS | 1747 | RSS: Main: 213684224 10:34:19 INFO - PROCESS | 1747 | 10:34:22 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:23 INFO - PROCESS | 1747 | RSS: Main: 253079552 10:34:23 INFO - PROCESS | 1747 | 10:34:26 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:27 INFO - PROCESS | 1747 | RSS: Main: 247992320 10:34:27 INFO - PROCESS | 1747 | 10:34:30 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45731/tests/kraken/driver.html?testName=json-parse-financial) 10:34:30 INFO - PROCESS | 1747 | RSS: Main: 249425920 10:34:30 INFO - PROCESS | 1747 | 10:34:32 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:33 INFO - PROCESS | 1747 | RSS: Main: 212324352 10:34:33 INFO - PROCESS | 1747 | 10:34:34 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:35 INFO - PROCESS | 1747 | RSS: Main: 220405760 10:34:35 INFO - PROCESS | 1747 | 10:34:37 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:38 INFO - PROCESS | 1747 | RSS: Main: 229294080 10:34:38 INFO - PROCESS | 1747 | 10:34:40 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:41 INFO - PROCESS | 1747 | RSS: Main: 237690880 10:34:41 INFO - PROCESS | 1747 | 10:34:44 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:44 INFO - PROCESS | 1747 | RSS: Main: 234258432 10:34:44 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45731/tests/kraken/driver.html?testName=ai-astar) 10:34:46 INFO - PROCESS | 1747 | RSS: Main: 284626944 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | __start_tp_report 10:34:46 INFO - PROCESS | 1747 | _x_x_mozilla_page_load 10:34:46 INFO - PROCESS | 1747 | _x_x_mozilla_page_load_details 10:34:46 INFO - PROCESS | 1747 | |i|pagename|runs| 10:34:46 INFO - PROCESS | 1747 | |0;ai-astar;110;113;112;113;112;111;113;113;112;110 10:34:46 INFO - PROCESS | 1747 | |1;audio-beat-detection;160;127;132;168;125;122;123;141;150;129 10:34:46 INFO - PROCESS | 1747 | |2;audio-dft;161;163;160;162;162;163;162;163;165;161 10:34:46 INFO - PROCESS | 1747 | |3;audio-fft;74;75;75;115;75;76;76;78;114;75 10:34:46 INFO - PROCESS | 1747 | |4;audio-oscillator;83;82;105;83;83;84;101;84;84;116 10:34:46 INFO - PROCESS | 1747 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;116;117 10:34:46 INFO - PROCESS | 1747 | |6;imaging-darkroom;157;160;159;162;161;159;160;164;160;159 10:34:46 INFO - PROCESS | 1747 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 10:34:46 INFO - PROCESS | 1747 | |8;json-parse-financial;52;51;51;51;51;53;53;52;53;52 10:34:46 INFO - PROCESS | 1747 | |9;json-stringify-tinderbox;63;63;63;63;62;63;63;63;63;63 10:34:46 INFO - PROCESS | 1747 | |10;stanford-crypto-aes;79;78;79;79;81;79;80;89;78;80 10:34:46 INFO - PROCESS | 1747 | |11;stanford-crypto-ccm;133;130;135;131;133;139;132;145;179;137 10:34:46 INFO - PROCESS | 1747 | |12;stanford-crypto-pbkdf2;163;167;165;163;172;161;167;163;163;163 10:34:46 INFO - PROCESS | 1747 | |13;stanford-crypto-sha256-iterative;65;64;66;67;66;64;63;63;65;63 10:34:46 INFO - PROCESS | 1747 | __end_tp_report 10:34:46 INFO - PROCESS | 1747 | __start_cc_report 10:34:46 INFO - PROCESS | 1747 | _x_x_mozilla_cycle_collect,1665 10:34:46 INFO - PROCESS | 1747 | __end_cc_report 10:34:46 INFO - PROCESS | 1747 | __startTimestamp1479321286706__endTimestamp 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | ------- Summary: start ------- 10:34:46 INFO - PROCESS | 1747 | Number of tests: 14 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.20 (1.1%) stddev-sans-first:1.05 10:34:46 INFO - PROCESS | 1747 | Values: 110.0 113.0 112.0 113.0 112.0 111.0 113.0 113.0 112.0 110.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:136.50 stddev:16.41 (12.0%) stddev-sans-first:15.30 10:34:46 INFO - PROCESS | 1747 | Values: 160.0 127.0 132.0 168.0 125.0 122.0 123.0 141.0 150.0 129.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 10:34:46 INFO - PROCESS | 1747 | Values: 161.0 163.0 160.0 162.0 162.0 163.0 162.0 163.0 165.0 161.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:16.48 (22.0%) stddev-sans-first:17.13 10:34:46 INFO - PROCESS | 1747 | Values: 74.0 75.0 75.0 115.0 75.0 76.0 76.0 78.0 114.0 75.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:83.00 stddev:12.20 (14.7%) stddev-sans-first:12.63 10:34:46 INFO - PROCESS | 1747 | Values: 83.0 82.0 105.0 83.0 83.0 84.0 101.0 84.0 84.0 116.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:34:46 INFO - PROCESS | 1747 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#6] imaging-darkroom Cycles:10 Average:160.10 Median:160.00 stddev:1.91 (1.2%) stddev-sans-first:1.67 10:34:46 INFO - PROCESS | 1747 | Values: 157.0 160.0 159.0 162.0 161.0 159.0 160.0 164.0 160.0 159.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:34:46 INFO - PROCESS | 1747 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 10:34:46 INFO - PROCESS | 1747 | Values: 52.0 51.0 51.0 51.0 51.0 53.0 53.0 52.0 53.0 52.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:34:46 INFO - PROCESS | 1747 | Values: 63.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:3.22 (4.1%) stddev-sans-first:3.39 10:34:46 INFO - PROCESS | 1747 | Values: 79.0 78.0 79.0 79.0 81.0 79.0 80.0 89.0 78.0 80.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.00 stddev:14.61 (10.7%) stddev-sans-first:15.31 10:34:46 INFO - PROCESS | 1747 | Values: 133.0 130.0 135.0 131.0 133.0 139.0 132.0 145.0 179.0 137.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:164.00 stddev:3.20 (2.0%) stddev-sans-first:3.33 10:34:46 INFO - PROCESS | 1747 | Values: 163.0 167.0 165.0 163.0 172.0 161.0 167.0 163.0 163.0 163.0 10:34:46 INFO - PROCESS | 1747 | 10:34:46 INFO - PROCESS | 1747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 10:34:46 INFO - PROCESS | 1747 | Values: 65.0 64.0 66.0 67.0 66.0 64.0 63.0 63.0 65.0 63.0 10:34:46 INFO - PROCESS | 1747 | -------- Summary: end -------- 10:34:46 INFO - PROCESS | 1747 | 10:34:47 INFO - TEST-INFO | 1747: exit 0 10:34:47 INFO - TEST-OK | kraken | took 62100ms 10:34:47 INFO - SUITE-END | took 1179s 10:34:48 INFO - Completed test suite (00:19:40) 10:34:48 INFO - javascript benchmark 10:34:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.953605695914, 3108.673589273127, 3128.812271263723, 3162.6204855417354, 3178.0465860241934, 5275.973620131898, 5281.815136470224, 5363.812266570666, 5366.329208848894, 5386.0, 5225.059489291926, 5228.137357336044, 5302.575793936486, 5309.522143007129, 5384.0, 4724.0, 4746.145693775119, 4790.377250957371, 4818.445878723939, 4893.730844803535, 4442.234848484848, 4861.586765124968, 4974.452810190876, 4999.675021123633, 5045.873853153664, 4729.077829823186, 4782.641301902371, 4812.302216178669, 4897.436794768611, 4914.557689807899, 4818.614510839125, 4820.204666230068, 4831.9033619327765, 4860.198067318888, 4867.269909513566, 4785.947091639834, 4804.56758891698, 4808.278758186265, 4815.49437309081, 4850.708957462563, 5261.421243663194, 5276.366835979668, 5300.602454815904, 5329.413764485904, 5357.4106848246665, 5646.2942132233475, 5666.121751128581, 5695.03184458643, 5781.219535362757, 5786.5370770338695, 5760.481556659879, 5770.2210201622665, 5771.942280577183, 5779.826605201851, 5779.913301300442, 5358.115910874662, 5361.0, 5364.865878353034, 5365.0, 5365.651232669864, 5658.179563963285, 5691.857703557362, 5752.827415177551, 5756.740946657411, 5782.219400380979, 5610.691411972299, 5613.831585052455, 5620.185073164368, 5623.156526521055, 5659.3208814941645, 5638.718064096779, 5658.264425624642, 5711.086226203871, 5711.857203569944, 5717.199592057115, 5542.528885044736, 5560.749766260528, 5607.971960140173, 5709.0, 5712.257406537206, 5584.888302234014, 5613.0, 5638.464345887134, 5686.744096515667, 5691.459311365414, 4362.650987920959, 4363.2364336241035, 4363.323684828857, 4386.035072284092, 4399.098184872158, 3886.417037444406, 3896.279188350164, 3901.6293452122004, 3915.647591716759, 3931.2137572485044, 5371.194320851903, 5376.596755243372, 5392.946070539245, 5417.079096553595, 5460.5085542301385, 5737.540996720252, 5761.85595360111, 5767.596268261265, 5767.769289228384, 5768.826935191951, 5394.271773310631, 5430.484104010192, 5449.01917654826, 5454.372747134131, 5461.508464238158, 4882.951170488321, 4892.779824907817, 4893.996730670204, 4899.1426500363, 4936.6297527685565, 5864.472197502245, 5868.4424979626865, 5869.090291004901, 5872.442117998783, 5905.970470147622, 5651.265335506358, 5655.830325090254, 5676.262085928803, 5682.261306030189, 5689.203511508309, 5799.072148456226, 5811.883762324815, 5848.210491583582, 5883.823485295448, 5886.293644762484, 5563.0, 5607.635503692247, 5612.831615051555, 5652.830415087554, 5662.462066103713, 5662.150677398423, 5717.17101020358, 5724.771009159587, 5725.828225153252, 5727.427257274239, 5490.5882058844945, 5525.0, 5537.307836520435, 5580.0, 5585.888282234414, 5543.584231182596, 5606.831795046155, 5612.0, 5648.350439699487, 5659.915101273402, 5476.507114359727, 5482.616216864782, 5510.366307874646, 5515.917261241165, 5539.8892022160135, 5494.203340515683, 5552.916706249491, 5602.747876345493, 5619.80330688424, 5658.717064146694, 5456.945430545803, 5487.890242195213, 5490.862728431662, 5528.4471552846, 5574.860628484158], "value": 5252.596254228537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.572992390745, 584.2054805464568, 585.4906231578527, 590.9320428150764, 599.1641659884461, 25909.61135582968, 27621.88995035917, 27652.585211221824, 40875.0, 42061.57938420615, 42471.787641061754, 42860.571394286046, 42866.0, 42876.35685464721, 42907.57092429075, 8524.616392262347, 8657.393982421234, 8673.783155421102, 8676.696315628955, 8681.04508504064, 8064.556449395281, 8142.51144931303, 8145.063317718449, 8146.348292136615, 8149.225823546753, 8598.570071496431, 8657.480551166918, 8666.220040196382, 8667.826643467128, 8672.34957378196, 8654.697085602005, 8686.478811271343, 8694.826198463254, 8697.347698922606, 8702.956485217597, 8039.839203215903, 8092.1503242159315, 8098.959505202495, 8100.513969161869, 8100.878486822702, 40925.795371022956, 40934.38598420996, 41352.37971430431, 41356.37965430521, 41400.585994139976, 3248.4315244832296, 3354.26206234628, 3365.3437579671972, 3600.171960449085, 3805.353089974711, 29433.705662943525, 30351.089467316015, 30412.695873041208, 30525.69474305273, 30538.0, 3940.349842276021, 4063.349864021742, 4068.7355321903983, 4102.0, 4222.398887011814, 247069.0, 248907.0, 249004.0, 249031.9999999982, 249346.0, 54643.180352294745, 54854.45145548573, 55062.449375505734, 55062.449375506534, 55099.0, 56130.71934640382, 56323.71838140783, 56660.0, 57262.71368643214, 57281.0, 14324.785128223086, 14711.04378215434, 14713.0, 14722.0, 14734.0, 11125.610603628835, 11337.0, 11343.546258149747, 11344.773104537862, 11351.545938162546, 14182.85817141836, 15136.35113855071, 15186.46847360337, 15221.0, 15500.379984800707, 6254.405831446005, 6359.1733074700915, 6437.742490300336, 6514.869702606016, 6563.50773691975, 886.6054605700401, 970.6360114956891, 993.9701808945744, 1022.2435397805571, 1024.2215915903819, 29457.0, 29604.0, 30485.23786905345, 30587.847060764998, 30814.0, 861.7974775927652, 869.5912920927154, 1066.248294952057, 1166.848309719731, 1212.3271584270815, 15168.407317231531, 15761.68476630484, 15819.446319378767, 15875.285612147482, 16030.438934637232, 498418.0, 499768.0, 502238.0, 502876.0, 503111.0, 55200.0, 55272.0, 55345.0, 55375.169372459444, 55468.16797748037, 1198.4666823263738, 1226.1233218248994, 1248.1450206608502, 1250.0749445410331, 1250.5185503581006, 23005.309840704806, 25049.499010020063, 25728.61407078858, 26710.332241694112, 26750.197494075208, 50507.242391364896, 51028.23457648212, 51177.488225117275, 51204.231936520235, 51262.74368628133, 425290.0, 430421.893044435, 432095.0, 432174.0, 432282.0, 26331.21006369812, 26785.732142678324, 27354.31614209581, 34107.0, 34289.14277143091, 44762.0, 45123.23151527297, 45328.32007519824, 45562.772186138856, 45883.08233835371, 38565.42151867668, 39081.0, 39197.6080239194, 39434.80282598569, 40969.0, 37806.62193378031, 38134.0, 38757.22485550329, 38776.22447550977, 40363.596364035984, 34882.127946801535, 35200.11999700028, 36122.0, 40355.79822100871, 40766.59233407628, 31864.0, 33537.49693754644, 35772.0, 36229.27541449209, 37554.248915021, 26898.731012689623, 26976.190714278604, 27371.315717106434, 27458.313542161606, 27667.0], "value": 18621.689271425155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.5352197080547, 401.61244399154816, 402.21166513633284, 404.9028233224025, 417.1469345189088, 13435.395407206675, 15282.159481228542, 18256.995865227425, 18724.719129213074, 19119.808801911975, 16846.32614695414, 17064.23210955507, 17291.39480118196, 17400.21699023544, 17420.128993550334, 5353.9196912046355, 5587.664740115606, 5592.832215033555, 5598.552115830744, 5607.943920560783, 5363.275957745713, 5381.5425688816495, 5469.808556700516, 5494.890102197954, 5496.862578435551, 5511.22842802006, 5515.944840551603, 5517.117261238202, 5522.889542209154, 5524.0, 5264.184051472028, 5515.7242137892945, 5521.089020311644, 5525.778968841241, 5525.917111243334, 4981.12830254704, 4982.5017498250245, 4982.676126051795, 4983.900321993576, 4985.0, 22315.44211394712, 22483.550328993493, 22487.0, 22551.0, 22733.43166420836, 2275.0899640143907, 2336.778006089419, 2353.2704861492994, 2399.076355603088, 2511.1713134665515, 13132.606021819362, 13881.305934703325, 13929.721405571932, 14538.781918271234, 14639.63400914975, 1845.6954602490573, 1866.3561071430336, 1888.1408958923794, 1896.7723873135312, 1899.2782742557877, 82805.58597207036, 82848.0, 83846.16153838445, 86092.56953715254, 88183.0, 9822.410655360558, 10367.429791361397, 10373.429461379697, 10738.892611073945, 10817.783644327226, 14984.850151498564, 15004.549863504113, 15009.2495375233, 15031.098134111988, 15039.248037598076, 7524.097108347033, 7579.2420757924865, 7780.922190778133, 7884.526928384315, 7896.921030789734, 7081.92918070823, 7114.786556403316, 7146.5354751941995, 7315.195328513859, 7319.121705395387, 6246.437820596168, 6423.646699431482, 6478.1578394808375, 6484.708188131545, 6605.70274337656, 1830.249597664951, 1867.2810967777232, 1898.8258444081725, 1908.4370110817342, 1964.4597735622817, 936.5598168860624, 953.2326477185932, 989.8168838764708, 1042.74452759073, 1074.4412905289205, 18124.728129078074, 19191.136398862083, 19592.70610940837, 19711.60576788456, 20017.39947801539, 995.1690338567232, 1028.9125424338865, 1037.896210378956, 1040.3029969920171, 1045.4772613693153, 9971.0, 10837.83743243852, 10940.945295273472, 10942.17933654979, 10967.35181381589, 478011.0, 494916.0, 497453.0, 500904.0, 504533.0, 58875.11687324694, 88079.0, 89016.554917225, 89376.5531172353, 90200.0, 820.216693058128, 841.4110122913985, 842.1326034184799, 843.2663582683105, 843.5739951324542, 14788.408463661333, 14793.260336983323, 14919.477818276308, 15044.548663540112, 15555.377784888478, 37143.44284835675, 39203.41194882136, 39290.410643839794, 39743.44233201489, 39855.2028959425, 52066.47933520616, 52217.7389113052, 52540.73729631327, 52838.47161528336, 56044.0, 5386.622936394415, 5393.298871146726, 8208.671653133808, 8260.215279548433, 8736.78158046054, 12622.495100195889, 13196.934015330246, 13404.262765547988, 13468.393922273326, 13566.321683915961, 11498.655040348469, 11707.707307317385, 11730.413479325829, 11789.233699809485, 12221.755564888475, 11280.153988451064, 11727.296362218294, 11807.881921180679, 11876.287422754662, 12303.44634491432, 11837.69785323631, 11875.465604048011, 12005.339706315886, 12288.262704237417, 12416.006719462603, 8251.257386835214, 8325.0, 8771.692990745294, 8791.868121978303, 8854.778630534289, 10445.477726113815, 11590.478428470908, 11789.882101178879, 11852.644420667393, 12014.279143251433], "value": 9024.27584366452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1086.7880763251167, 1089.9564017439302, 1196.7068068323256, 1273.3696820074065, 1315.4935349890288, 7009.719611215552, 7575.431842611805, 7789.065312162541, 7794.0, 7799.493032952854, 7788.299053085221, 7851.254130857574, 7854.096778870432, 7862.331701805353, 7875.92124078759, 2288.084766093559, 2311.087120587367, 2316.1893337331885, 2318.3740390094663, 2320.8027317678016, 2247.5392544528413, 2302.3208153594646, 2325.976740232593, 2328.7438381777993, 2332.7667233276707, 2221.8222542196586, 2255.650374192003, 2263.8302127340435, 2274.158561332301, 2277.4420267034598, 2194.1113848891223, 2207.3377986604037, 2221.5890060338807, 2227.888605569723, 2228.74369447514, 2224.677421773834, 2242.338510139513, 2243.5849367866995, 2247.8876056197287, 2250.8987095580737, 7839.647215875242, 7852.685892564291, 7892.0, 7900.80247993799, 7905.802354941115, 4967.478414766434, 5141.922871156936, 5156.948430515685, 5209.088409528355, 5213.061648903196, 3199.808011519316, 3363.6636336366414, 3370.9831450842835, 3426.400379933502, 3431.673990970854, 1122.5004872831594, 1139.8575178102737, 1140.5779861451233, 1152.982705259422, 1158.4960542164185, 11469.885301146966, 11520.94239528797, 11544.249623774513, 11566.884331156749, 11601.76796464066, 4186.225548273579, 4410.735355878657, 4474.574915383034, 4486.214912390384, 4581.0, 9158.95420522893, 9165.954170229239, 9168.220701240336, 9171.174594286545, 9172.220361269234, 5163.277141200235, 5170.534651881274, 5171.663841850268, 5173.094708426011, 5176.094183517869, 3965.7818819965178, 4262.0, 4378.868633940987, 4390.05613793036, 4847.903041939141, 3608.4948107265004, 3623.673869351771, 3690.2619476104887, 3714.3871261242134, 3730.8880733578035, 1144.3134119528218, 1154.682462322851, 1165.4231155577875, 1166.2302880099094, 1185.6502331812137, 640.4460141977249, 739.7558805594141, 739.985200295991, 764.5259938837845, 803.0804728585737, 5336.893262134736, 5513.393526712059, 5661.49046585801, 5676.716164191774, 5783.2192653992015, 415.61347946409524, 419.69781757134814, 423.9872803815891, 429.85599824058664, 436.89514516515806, 3975.741576797499, 4092.3656833190903, 4100.384942258685, 4105.815238314223, 4106.178764247163, 10237.795244095076, 10288.434136122436, 10401.635942741968, 10406.739831504121, 10408.427536485415, 10318.587256509656, 10321.380717156995, 10321.535530901128, 10327.793444131075, 10353.741156470998, 7077.893831592531, 7330.523515971445, 7347.8530429392185, 7434.962825185839, 7449.068866391701, 5507.504324610804, 5548.778048878, 5628.1557766333735, 5647.915281270702, 5770.192173095686, 9149.268058555434, 9252.0, 9297.907020929975, 9352.766180845534, 9395.953020234854, 8242.216989386, 9342.0, 9343.579538920629, 9454.669086581936, 9534.09426104519, 6688.230853451721, 7229.963850180716, 7392.44556658242, 7432.3310902019075, 7616.124145723313, 7564.583947882919, 7712.267334603203, 7714.6914123434435, 7886.605669716377, 7964.880526792219, 6723.562968407038, 6815.216250131299, 6837.145356830396, 6837.453003759588, 6844.110265665432, 7171.191489574013, 7187.065681461377, 7251.746188883364, 7312.232215617496, 7390.113186417664, 6246.625202487865, 6288.591241569284, 6333.113364128933, 6340.873182536416, 6359.17330747, 4814.301926220748, 4858.732769697701, 4917.877053073702, 4925.38432695913, 4993.575546078624, 4654.813807447799, 4655.953440465552, 4865.878353041202, 4867.0, 5119.846404607868], "value": 4224.322796562013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.68982519049746, 338.43143518888263, 349.355439214649, 353.0344507771245, 355.848764275183, 5046.318746969158, 5131.4098878628965, 5146.68759466336, 5205.661631993918, 5218.3998840133345, 5033.421156566996, 5139.6659217150855, 5167.715775632339, 5167.9483205167935, 5180.481951804818, 4118.320477121271, 4121.505419349674, 4129.421880936671, 4135.77253251071, 4159.6464300534335, 3910.432987216852, 4103.220388126247, 4130.710850240484, 4169.312063509517, 4177.415161877339, 4047.5547689754103, 4053.756774593534, 4055.513338399396, 4055.817488213023, 4067.4102255172984, 4040.3131467650423, 4041.2725709372303, 4045.5347635022054, 4045.9595404045876, 4058.3360822062814, 3436.896893093186, 3530.717542596586, 3555.8044307563073, 3567.23304489536, 3601.0, 5012.448630650625, 5014.674046187022, 5018.949810501885, 5031.32077169581, 5035.269885866565, 4581.61056310214, 4593.369353879358, 4595.172868883633, 4610.515895830957, 4611.976940115278, 5117.692938423706, 5356.1697936819855, 5357.732113394315, 5367.704776237344, 5368.839149659007, 3932.292187406266, 3938.6171366323247, 3944.0928586425, 3946.625070618287, 3953.367461206222, 5566.524870909212, 5584.776608935637, 5586.469285417878, 5591.427943146157, 5608.523275521586, 3963.960360396359, 4015.698822588259, 4036.5963403659985, 4047.0, 4057.69567282455, 4058.127502586899, 4078.1028173801715, 4080.4497189256713, 4084.8774536763945, 4094.195476098882, 4614.400127983407, 4630.560096790799, 4635.0301122023, 4650.720956742606, 4651.906961860812, 5214.400343960493, 5387.515123638891, 5414.8917021659345, 5442.510174084351, 5472.5621950243885, 1334.9666258343425, 1346.6296768388772, 1358.7146699193281, 1363.6727185475613, 1365.9795103073461, 907.4373888189365, 927.874736910522, 939.5490164720973, 942.6606421688186, 944.6868852295315, 4923.852284431401, 4975.5522003019905, 5015.4733752956145, 5044.520770526794, 5057.974710126426, 5283.630145889751, 5304.602154838402, 5306.895466152344, 5321.445706061112, 5377.435369286247, 4745.3593764842, 5007.0, 5017.523335283142, 5035.219540971156, 5084.6440749147205, 2824.6892841787385, 2826.9575956360673, 2830.3348713052414, 2850.7006764289868, 2852.0445650707247, 5534.1975413564805, 5540.418256083134, 5543.1685247213245, 5559.388467268597, 5565.8831054609545, 5219.19102539107, 5372.865678358073, 5395.460453954652, 5441.700706461183, 5443.8094666686475, 5416.458354164552, 5505.449455054462, 5530.917036244459, 5532.889342213133, 5547.944520554743, 5266.657667251617, 5293.470652934676, 5304.655197412156, 5330.786768529216, 5344.625876188629, 5008.6744361616375, 5293.391260004994, 5319.973400132974, 5331.3868905076415, 5339.25250464943, 5516.806911758069, 5524.535997960464, 5525.143602741581, 5541.584381171348, 5558.24963629921, 3809.257194846978, 3899.3371126907928, 3935.7244992850224, 3942.245700663292, 3997.480327557399, 5483.230968360952, 5483.506484416422, 5498.202760599611, 5498.5876059296515, 5501.669899806025, 5305.763484274667, 5364.46355364476, 5365.6244062916785, 5367.570594352364, 5410.97294513525, 5214.374275087014, 5302.522772950453, 5346.331708536433, 5367.812126575551, 5380.192971054373, 5293.470652934676, 5318.7074710891275, 5321.36143662763, 5331.226972089103, 5336.119540275966, 5172.482751724948, 5328.653637513549, 5333.546648534762, 5421.120991108034, 5424.810131645373, 5215.2007557392635, 5270.683758974474, 5279.234510995807, 5280.577553795764, 5281.630285879952], "value": 4095.5593748283345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5661948043509, 717.3221305865956, 729.2780147653822, 746.8842329438935, 783.3224261014223, 13238.073334866564, 14238.145711257319, 14271.71456570868, 14291.92854035731, 14293.0, 12329.753404931897, 12333.260004399719, 12345.197562158475, 12428.378581070932, 12431.502739890393, 653.993460065398, 674.1000763980068, 758.2455456820471, 774.2528460036092, 784.0003994906483, 775.51917810957, 776.022212012865, 779.1740754799902, 779.9649015794274, 780.4341852157197, 807.9717209897655, 811.9066307374668, 812.0134037144868, 812.7561731480532, 813.048732982412, 679.2629996453853, 696.8397268628219, 794.2494342846013, 824.1428913929506, 826.050042451186, 608.8417011577022, 609.1745684597352, 609.9634021958697, 610.008735804318, 610.2402508876432, 12257.816132758016, 12306.200096993667, 12308.07689423288, 12332.691682707915, 12402.19385739924, 12315.75368492625, 12533.561325353568, 12582.81125783114, 12592.370381480981, 12746.29895355755, 10988.450577471174, 11002.834957475645, 11007.779844403147, 11031.944840275828, 11205.21563490556, 3913.099987002977, 3913.236918800835, 4017.4576432181575, 4108.26051310764, 4130.967258185454, 61754.0, 62600.29695397221, 62732.37267627357, 62814.0577891332, 64204.0, 9776.21197836542, 9778.55996480146, 10028.047335503115, 10093.646722364829, 10147.086762191439, 17566.824331756776, 17579.20893559793, 17639.736648720027, 17641.382551610634, 17650.91174544119, 6864.725410983605, 7124.287571242834, 7249.825052484233, 7330.633468326562, 7333.523320984225, 4064.9390259146135, 4196.769177695195, 4327.069680018748, 4376.387305777193, 4388.29787234041, 3091.474449343617, 3178.141901686578, 3182.618085829669, 3182.6499085100622, 3185.0763278649397, 578.3118089473513, 580.5239703443136, 593.4688453833794, 614.2567493333028, 616.2851092732409, 568.6313291139256, 586.6392168816233, 605.0863196573118, 607.6263098194667, 648.1800522339245, 8540.14598540141, 8731.126091390686, 8810.603522841488, 9142.908570914338, 9320.394174378644, 636.640298231507, 648.4358608011061, 653.6730437212466, 653.8528831012984, 689.6620655878684, 3943.3690609502914, 4211.0946146578635, 4256.871199668241, 4332.653387728974, 4426.127138753591, 83081.16918830856, 84399.0, 84666.57666711627, 85951.57024214964, 88604.11395885958, 74201.0, 77572.46755054472, 77764.0, 79759.0, 79889.0, 67309.0, 67756.6612166936, 69200.6539967297, 71015.64492177506, 72248.2775172252, 8152.55336743439, 8218.958905205436, 8355.248027677539, 8428.325733941392, 8503.617337219963, 46803.29795053009, 46863.531364685914, 47629.52370476251, 47827.76086119547, 48785.75607121942, 58341.4165858336, 65600.68798623905, 66057.66971165114, 66526.33473665202, 66594.33405665882, 11898.464569094238, 11963.0, 12216.816747748968, 12281.815772763595, 12530.812037819258, 13379.732405352033, 13615.659608509866, 13827.377768000262, 14046.438142474595, 14095.365708542935, 10041.849372259569, 10053.597856085968, 12906.096573239784, 13447.46210151583, 13917.0, 12338.568150114703, 12718.10973231865, 12975.610731678065, 12977.286249256003, 13393.330333483482, 12570.49718011306, 13137.540186093442, 13212.735745285232, 13319.467221311426, 13435.865641343462, 10130.848037279595, 10265.640702575374, 10597.841032384365, 10631.681049568526, 10957.397343145885, 10133.695989120339, 10810.945945270223, 10903.781924361627, 11274.774504510027, 11285.0], "value": 6779.261816105663, "unit": "score"}], "name": "dromaeo_css", "value": 6852.528097862732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 113.0, 112.0, 111.0, 113.0, 113.0, 112.0, 110.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 132.0, 168.0, 125.0, 122.0, 123.0, 141.0, 150.0, 129.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 162.0, 163.0, 162.0, 163.0, 165.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 115.0, 75.0, 76.0, 76.0, 78.0, 114.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 83.0, 83.0, 84.0, 101.0, 84.0, 84.0, 116.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 159.0, 162.0, 161.0, 159.0, 160.0, 164.0, 160.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 53.0, 53.0, 52.0, 53.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 79.0, 81.0, 79.0, 80.0, 89.0, 78.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 135.0, 131.0, 133.0, 139.0, 132.0, 145.0, 179.0, 137.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 165.0, 163.0, 172.0, 161.0, 167.0, 163.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 67.0, 66.0, 64.0, 63.0, 63.0, 65.0, 63.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1521.0, "alertThreshold": 2.0}]} 10:34:48 INFO - Return code: 0 10:34:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:48 INFO - # TBPL SUCCESS # 10:34:48 INFO - Running post-action listener: _resource_record_post_action 10:34:48 INFO - [mozharness: 2016-11-16 18:34:48.492949Z] Finished run-tests step (success) 10:34:48 INFO - Running post-run listener: _resource_record_post_run 10:34:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403591168; Read time: 8; Write time: 231200 10:34:48 INFO - TinderboxPrint: CPU usage
13.0% 10:34:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:34:48 INFO - TinderboxPrint: I/O write bytes / time
403,591,168 / 231,200 10:34:48 INFO - TinderboxPrint: CPU idle
8,302.7 (86.9%) 10:34:48 INFO - TinderboxPrint: CPU user
1,197.9 (12.5%) 10:34:48 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115011584; Read time: 0; Write time: 63388 10:34:48 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288243712; Read time: 0; Write time: 167812 10:34:49 INFO - Running post-run listener: _upload_blobber_files 10:34:49 INFO - Blob upload gear active. 10:34:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:50 INFO - (blobuploader) - INFO - Done attempting. 10:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:51 INFO - (blobuploader) - INFO - Done attempting. 10:34:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:54 INFO - (blobuploader) - INFO - Done attempting. 10:34:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:54 INFO - Return code: 0 10:34:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05c1ea2ba1ebad273aaab5b0fdb754da28484f7944eee7e21cdd907a908f25ffe7f8b052da040d60bdf4e8990271e06a448d181afab569c38dbe5fdc2ba36452", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4c7671d2de46a16fcded5427b406000acbbda4d65640d18eedd1ac4191290b0e27949682de6654a1b54b73248e44e2867c926f796ffba9ae107be26d4c6c21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1abe64b812294549e8cf07cefa9db30d2f9988d8d6d67f49537977a5df2cfb77a59ee1f4caf22ea2241a212e5d33e7c3c1d5dbb458ba83d90192a47c798e555f"} 10:34:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:54 INFO - Contents: 10:34:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05c1ea2ba1ebad273aaab5b0fdb754da28484f7944eee7e21cdd907a908f25ffe7f8b052da040d60bdf4e8990271e06a448d181afab569c38dbe5fdc2ba36452", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4c7671d2de46a16fcded5427b406000acbbda4d65640d18eedd1ac4191290b0e27949682de6654a1b54b73248e44e2867c926f796ffba9ae107be26d4c6c21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1abe64b812294549e8cf07cefa9db30d2f9988d8d6d67f49537977a5df2cfb77a59ee1f4caf22ea2241a212e5d33e7c3c1d5dbb458ba83d90192a47c798e555f"} 10:34:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:54 INFO - Copying logs to upload dir... 10:34:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.283526 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-16 10:34:54.272067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 10:34:54.276051) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05c1ea2ba1ebad273aaab5b0fdb754da28484f7944eee7e21cdd907a908f25ffe7f8b052da040d60bdf4e8990271e06a448d181afab569c38dbe5fdc2ba36452", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4c7671d2de46a16fcded5427b406000acbbda4d65640d18eedd1ac4191290b0e27949682de6654a1b54b73248e44e2867c926f796ffba9ae107be26d4c6c21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1abe64b812294549e8cf07cefa9db30d2f9988d8d6d67f49537977a5df2cfb77a59ee1f4caf22ea2241a212e5d33e7c3c1d5dbb458ba83d90192a47c798e555f"} build_url:https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/L7K0xapEQrSe4U_BLJsNVg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05c1ea2ba1ebad273aaab5b0fdb754da28484f7944eee7e21cdd907a908f25ffe7f8b052da040d60bdf4e8990271e06a448d181afab569c38dbe5fdc2ba36452", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f4c7671d2de46a16fcded5427b406000acbbda4d65640d18eedd1ac4191290b0e27949682de6654a1b54b73248e44e2867c926f796ffba9ae107be26d4c6c21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1abe64b812294549e8cf07cefa9db30d2f9988d8d6d67f49537977a5df2cfb77a59ee1f4caf22ea2241a212e5d33e7c3c1d5dbb458ba83d90192a47c798e555f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 10:34:54.301595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:34:54.301925) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1479319847.121038-502599927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 10:34:54.386828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 10:34:54.387109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 10:34:54.387385) ========= ========= Total master_lag: 0.18 =========