builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1475597648.05 results: success (0) buildid: 20161004074700 builduid: b414711556344b2fb447aedc4a43b893 revision: 604451ab58290450155779b6692a92f30d76717d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.046351) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.046872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.047164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.062198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.062546) ========= 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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 09:14:08-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-04 09:14:08 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.207587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.207914) ========= 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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018770 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:08.261115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 09:14:08.261441) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 604451ab58290450155779b6692a92f30d76717d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 604451ab58290450155779b6692a92f30d76717d --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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 09:14:08,761 truncating revision to first 12 chars 2016-10-04 09:14:08,761 Setting DEBUG logging. 2016-10-04 09:14:08,761 attempt 1/10 2016-10-04 09:14:08,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/604451ab5829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 09:14:10,104 unpacking tar archive at: autoland-604451ab5829/testing/mozharness/ program finished with exit code 0 elapsedTime=1.717645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 09:14:09.995583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:09.996046) ========= script_repo_revision: 604451ab58290450155779b6692a92f30d76717d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:09.996462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:09.996760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:14:10.005952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 09:14:10.006263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:10 INFO - MultiFileLogger online at 20161004 09:14:10 in /builds/slave/test 09:14:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:14:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:14:10 INFO - {'append_to_log': False, 09:14:10 INFO - 'base_work_dir': '/builds/slave/test', 09:14:10 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:14:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:14:10 INFO - 'branch': 'Autoland-Non-PGO', 09:14:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:10 INFO - 'config_files': ('talos/linux_config.py',), 09:14:10 INFO - 'default_actions': ('clobber', 09:14:10 INFO - 'read-buildbot-config', 09:14:10 INFO - 'download-and-extract', 09:14:10 INFO - 'populate-webroot', 09:14:10 INFO - 'create-virtualenv', 09:14:10 INFO - 'install', 09:14:10 INFO - 'run-tests'), 09:14:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:10 INFO - 'download_minidump_stackwalk': True, 09:14:10 INFO - 'download_symbols': 'ondemand', 09:14:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:10 INFO - 'installer_path': 'installer.exe', 09:14:10 INFO - 'log_level': 'info', 09:14:10 INFO - 'log_name': 'talos', 09:14:10 INFO - 'log_to_console': True, 09:14:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:10 INFO - 'opt_config_files': (), 09:14:10 INFO - 'pip_index': False, 09:14:10 INFO - 'sps_profile': False, 09:14:10 INFO - 'sps_profile_interval': 0, 09:14:10 INFO - 'suite': 'dromaeojs', 09:14:10 INFO - 'system_bits': '32', 09:14:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:10 INFO - 'title': 'talos-linux64-ix-046', 09:14:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:10 INFO - 'use_talos_json': True, 09:14:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:14:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:10 INFO - 'work_dir': 'build'} 09:14:10 INFO - [mozharness: 2016-10-04 16:14:10.606201Z] Running clobber step. 09:14:10 INFO - Running pre-action listener: _resource_record_pre_action 09:14:10 INFO - Running main action method: clobber 09:14:10 INFO - rmtree: /builds/slave/test/build 09:14:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:14:11 INFO - Running post-action listener: _resource_record_post_action 09:14:11 INFO - [mozharness: 2016-10-04 16:14:11.591227Z] Finished clobber step (success) 09:14:11 INFO - [mozharness: 2016-10-04 16:14:11.591328Z] Running read-buildbot-config step. 09:14:11 INFO - Running pre-action listener: _resource_record_pre_action 09:14:11 INFO - Running main action method: read_buildbot_config 09:14:11 INFO - Using buildbot properties: 09:14:11 INFO - { 09:14:11 INFO - "project": "", 09:14:11 INFO - "product": "firefox", 09:14:11 INFO - "script_repo_revision": "production", 09:14:11 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:14:11 INFO - "repository": "", 09:14:11 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:14:11 INFO - "buildid": "20161004074700", 09:14:11 INFO - "pgo_build": "False", 09:14:11 INFO - "basedir": "/builds/slave/test", 09:14:11 INFO - "buildnumber": 768, 09:14:11 INFO - "slavename": "talos-linux64-ix-046", 09:14:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:14:11 INFO - "platform": "ubuntu64_hw", 09:14:11 INFO - "scheduler": "tests-autoland-linux64-talos", 09:14:11 INFO - "branch": "autoland", 09:14:11 INFO - "repo_path": "integration/autoland", 09:14:11 INFO - "revision": "604451ab58290450155779b6692a92f30d76717d", 09:14:11 INFO - "stage_platform": "linux64", 09:14:11 INFO - "builduid": "b414711556344b2fb447aedc4a43b893", 09:14:11 INFO - "slavebuilddir": "test" 09:14:11 INFO - } 09:14:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:14:11 INFO - Running post-action listener: _resource_record_post_action 09:14:11 INFO - [mozharness: 2016-10-04 16:14:11.594025Z] Finished read-buildbot-config step (success) 09:14:11 INFO - [mozharness: 2016-10-04 16:14:11.594114Z] Running download-and-extract step. 09:14:11 INFO - Running pre-action listener: _resource_record_pre_action 09:14:11 INFO - Running main action method: download_and_extract 09:14:11 INFO - mkdir: /builds/slave/test/build/tests 09:14:11 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')]} 09:14:11 INFO - trying https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:14:11 INFO - Downloading https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:14:12 INFO - Downloaded 1361 bytes. 09:14:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:14:12 INFO - Using the following test package requirements: 09:14:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:14:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'jsshell-linux-x86_64.zip'], 09:14:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:14:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:14:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:14:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:14:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:12 INFO - Fetch https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:12 INFO - Http code: 200 09:14:12 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 09:14:12 INFO - x-amz-cf-id: VwEl8wNCyf1cjlvBJ_lCG-PnW5IvHZ3ZfTvVlefCvrmj2SDak7LS9w== 09:14:12 INFO - x-amz-version-id: JWHEbxhaUqqsiNwlUBXXBWM9RFLvaydu 09:14:13 INFO - Expected file size: 20421209 09:14:13 INFO - Obtained file size: 20421209 09:14:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:14:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:14:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:17 INFO - Fetch https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:14:17 INFO - Http code: 200 09:14:17 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 09:14:17 INFO - x-amz-cf-id: ZuX1-eqeT9pLDs5qUEtUoiEuZsm9wxq2VYLON7RYK1BvMbAr7WELvw== 09:14:17 INFO - x-amz-version-id: JWHEbxhaUqqsiNwlUBXXBWM9RFLvaydu 09:14:17 INFO - Expected file size: 20421209 09:14:17 INFO - Obtained file size: 20421209 09:14:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:14:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:22 INFO - Fetch https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:14:22 INFO - Http code: 200 09:14:22 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:14:22 INFO - x-amz-cf-id: 9mFLdEhrMWzOaL6Xc-bILDkyO9N6Xo5Rk5k6qU9l3j4ORgz93D3nsw== 09:14:22 INFO - x-amz-version-id: CtFX9Ccy5mI9X6CLQ.Jz_s3C_yjKkiv8 09:14:23 INFO - Expected file size: 14409006 09:14:23 INFO - Obtained file size: 14409006 09:14:23 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')]} 09:14:23 INFO - trying https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:23 INFO - Downloading https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:14:25 INFO - Downloaded 55793894 bytes. 09:14:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:25 INFO - mkdir: /builds/slave/test/properties 09:14:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:14:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:14:25 INFO - Contents: 09:14:25 INFO - build_url:https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:14:25 INFO - Running post-action listener: _resource_record_post_action 09:14:25 INFO - Running post-action listener: set_extra_try_arguments 09:14:25 INFO - [mozharness: 2016-10-04 16:14:25.845343Z] Finished download-and-extract step (success) 09:14:25 INFO - [mozharness: 2016-10-04 16:14:25.845573Z] Running populate-webroot step. 09:14:25 INFO - Running pre-action listener: _resource_record_pre_action 09:14:25 INFO - Running main action method: populate_webroot 09:14:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:25 INFO - '--tppagecycles', 09:14:25 INFO - '7'], 09:14:25 INFO - 'tests': ['tsvgm']}}, 09:14:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:14:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:14:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:14:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['damp', 'tps']}, 09:14:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'tests': ['damp', 'tps']}, 09:14:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['dromaeo_dom']}, 09:14:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['basic_compositor_video']}, 09:14:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:14:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'other-e10s': {'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['a11yr', 09:14:25 INFO - 'ts_paint', 09:14:25 INFO - 'tpaint', 09:14:25 INFO - 'sessionrestore', 09:14:25 INFO - 'sessionrestore_no_auto_restore', 09:14:25 INFO - 'tabpaint']}, 09:14:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['tsvgx', 09:14:25 INFO - 'tsvgr_opacity', 09:14:25 INFO - 'tart', 09:14:25 INFO - 'tscrollx', 09:14:25 INFO - 'cart']}, 09:14:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:14:25 INFO - 'tsvgr_opacity', 09:14:25 INFO - 'tart', 09:14:25 INFO - 'tscrollx', 09:14:25 INFO - 'cart']}, 09:14:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'talos_options': ['--disable-e10s'], 09:14:25 INFO - 'tests': ['tp5o']}, 09:14:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'tests': ['tp5o']}, 09:14:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'talos_options': ['--disable-e10s', 09:14:25 INFO - '--xperf_path', 09:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:25 INFO - 'tests': ['tp5n']}, 09:14:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:25 INFO - 'talos_options': ['--xperf_path', 09:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:25 INFO - 'tests': ['tp5n']}}, 09:14:25 INFO - 'talos.zip': {'path': '', 09:14:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:25 INFO - Running post-action listener: _resource_record_post_action 09:14:25 INFO - [mozharness: 2016-10-04 16:14:25.862883Z] Finished populate-webroot step (success) 09:14:25 INFO - [mozharness: 2016-10-04 16:14:25.862972Z] Running create-virtualenv step. 09:14:25 INFO - Running pre-action listener: _resource_record_pre_action 09:14:25 INFO - Running main action method: create_virtualenv 09:14:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:14:25 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 09:14:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:14:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:25 INFO - Using real prefix '/usr' 09:14:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:28 INFO - Installing pip.................done. 09:14:28 INFO - Return code: 0 09:14:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:14:28 INFO - Reading from file tmpfile_stdout 09:14:28 INFO - Output received: 09:14:28 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) 09:14:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:14:28 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')]} 09:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:28 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')]} 09:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:28 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:28 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 09:14:28 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 09:14:28 INFO - Using env: {'DISPLAY': ':0', 09:14:28 INFO - 'HOME': '/home/cltbld', 09:14:28 INFO - 'LANG': 'en_US.UTF-8', 09:14:28 INFO - 'LANGUAGE': 'en_US:en', 09:14:28 INFO - 'LOGNAME': 'cltbld', 09:14:28 INFO - 'MAIL': '/var/mail/cltbld', 09:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:28 INFO - 'MOZ_NO_REMOTE': '1', 09:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:28 INFO - 'NO_EM_RESTART': '1', 09:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:28 INFO - 'PWD': '/builds/slave/test', 09:14:28 INFO - 'SHELL': '/bin/bash', 09:14:28 INFO - 'SHLVL': '1', 09:14:28 INFO - 'TERM': 'linux', 09:14:28 INFO - 'TMOUT': '86400', 09:14:28 INFO - 'USER': 'cltbld', 09:14:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:28 INFO - '_': '/tools/buildbot/bin/python'} 09:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:28 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 09:14:28 INFO - Cleaning up... 09:14:28 INFO - Return code: 0 09:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:14:28 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')]} 09:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:28 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')]} 09:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:28 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:28 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 09:14:28 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 09:14:28 INFO - Using env: {'DISPLAY': ':0', 09:14:28 INFO - 'HOME': '/home/cltbld', 09:14:28 INFO - 'LANG': 'en_US.UTF-8', 09:14:28 INFO - 'LANGUAGE': 'en_US:en', 09:14:28 INFO - 'LOGNAME': 'cltbld', 09:14:28 INFO - 'MAIL': '/var/mail/cltbld', 09:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:28 INFO - 'MOZ_NO_REMOTE': '1', 09:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:28 INFO - 'NO_EM_RESTART': '1', 09:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:28 INFO - 'PWD': '/builds/slave/test', 09:14:28 INFO - 'SHELL': '/bin/bash', 09:14:28 INFO - 'SHLVL': '1', 09:14:28 INFO - 'TERM': 'linux', 09:14:28 INFO - 'TMOUT': '86400', 09:14:28 INFO - 'USER': 'cltbld', 09:14:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:28 INFO - '_': '/tools/buildbot/bin/python'} 09:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:29 INFO - Downloading/unpacking psutil>=3.1.1 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:31 INFO - Installing collected packages: psutil 09:14:31 INFO - Running setup.py install for psutil 09:14:31 INFO - building 'psutil._psutil_linux' extension 09:14:31 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 09:14:31 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 09:14:31 INFO - building 'psutil._psutil_posix' extension 09:14:31 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 09:14:31 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 09:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:31 INFO - Successfully installed psutil 09:14:31 INFO - Cleaning up... 09:14:31 INFO - Return code: 0 09:14:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09: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 mozsystemmonitor==0.3 09:14:31 INFO - Using env: {'DISPLAY': ':0', 09:14:31 INFO - 'HOME': '/home/cltbld', 09:14:31 INFO - 'LANG': 'en_US.UTF-8', 09:14:31 INFO - 'LANGUAGE': 'en_US:en', 09:14:31 INFO - 'LOGNAME': 'cltbld', 09:14:31 INFO - 'MAIL': '/var/mail/cltbld', 09:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:31 INFO - 'MOZ_NO_REMOTE': '1', 09:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:31 INFO - 'NO_EM_RESTART': '1', 09:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:31 INFO - 'PWD': '/builds/slave/test', 09:14:31 INFO - 'SHELL': '/bin/bash', 09:14:31 INFO - 'SHLVL': '1', 09:14:31 INFO - 'TERM': 'linux', 09:14:31 INFO - 'TMOUT': '86400', 09:14:31 INFO - 'USER': 'cltbld', 09:14:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:31 INFO - '_': '/tools/buildbot/bin/python'} 09:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09: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 09: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 09: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 09: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 09: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 09: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 09:14:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:14:33 INFO - Installing collected packages: mozsystemmonitor 09:14:33 INFO - Running setup.py install for mozsystemmonitor 09:14:33 INFO - Successfully installed mozsystemmonitor 09:14:33 INFO - Cleaning up... 09:14:33 INFO - Return code: 0 09:14:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:14:33 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')]} 09:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:33 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')]} 09:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:33 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:33 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 09:14:33 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 09:14:33 INFO - Using env: {'DISPLAY': ':0', 09:14:33 INFO - 'HOME': '/home/cltbld', 09:14:33 INFO - 'LANG': 'en_US.UTF-8', 09:14:33 INFO - 'LANGUAGE': 'en_US:en', 09:14:33 INFO - 'LOGNAME': 'cltbld', 09:14:33 INFO - 'MAIL': '/var/mail/cltbld', 09:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:33 INFO - 'MOZ_NO_REMOTE': '1', 09:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:33 INFO - 'NO_EM_RESTART': '1', 09:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:33 INFO - 'PWD': '/builds/slave/test', 09:14:33 INFO - 'SHELL': '/bin/bash', 09:14:33 INFO - 'SHLVL': '1', 09:14:33 INFO - 'TERM': 'linux', 09:14:33 INFO - 'TMOUT': '86400', 09:14:33 INFO - 'USER': 'cltbld', 09:14:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:33 INFO - '_': '/tools/buildbot/bin/python'} 09:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:34 INFO - Downloading/unpacking jsonschema==2.5.1 09: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 09: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 09: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 09: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 09: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 09: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 09:14:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09: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 09: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 09: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 09: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 09: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 09: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 09:14:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:36 INFO - warning: no files found matching '*.txt' 09:14:36 INFO - no previously-included directories found matching 'build' 09:14:36 INFO - no previously-included directories found matching 'dist' 09:14:36 INFO - no previously-included directories found matching '.git*' 09:14:36 INFO - Installing collected packages: jsonschema, functools32 09:14:36 INFO - Running setup.py install for functools32 09:14:36 INFO - warning: no files found matching '*.txt' 09:14:36 INFO - no previously-included directories found matching 'build' 09:14:36 INFO - no previously-included directories found matching 'dist' 09:14:36 INFO - no previously-included directories found matching '.git*' 09:14:36 INFO - Successfully installed jsonschema functools32 09:14:36 INFO - Cleaning up... 09:14:36 INFO - Return code: 0 09:14:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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', '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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09: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 functools32==3.2.3-2 09:14:36 INFO - Using env: {'DISPLAY': ':0', 09:14:36 INFO - 'HOME': '/home/cltbld', 09:14:36 INFO - 'LANG': 'en_US.UTF-8', 09:14:36 INFO - 'LANGUAGE': 'en_US:en', 09:14:36 INFO - 'LOGNAME': 'cltbld', 09:14:36 INFO - 'MAIL': '/var/mail/cltbld', 09:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:36 INFO - 'MOZ_NO_REMOTE': '1', 09:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:36 INFO - 'NO_EM_RESTART': '1', 09:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:36 INFO - 'PWD': '/builds/slave/test', 09:14:36 INFO - 'SHELL': '/bin/bash', 09:14:36 INFO - 'SHLVL': '1', 09:14:36 INFO - 'TERM': 'linux', 09:14:36 INFO - 'TMOUT': '86400', 09:14:36 INFO - 'USER': 'cltbld', 09:14:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:36 INFO - '_': '/tools/buildbot/bin/python'} 09:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:14:36 INFO - Cleaning up... 09:14:36 INFO - Return code: 0 09:14:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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', '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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09: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 blobuploader==1.2.4 09:14:36 INFO - Using env: {'DISPLAY': ':0', 09:14:36 INFO - 'HOME': '/home/cltbld', 09:14:36 INFO - 'LANG': 'en_US.UTF-8', 09:14:36 INFO - 'LANGUAGE': 'en_US:en', 09:14:36 INFO - 'LOGNAME': 'cltbld', 09:14:36 INFO - 'MAIL': '/var/mail/cltbld', 09:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:36 INFO - 'MOZ_NO_REMOTE': '1', 09:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:36 INFO - 'NO_EM_RESTART': '1', 09:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:36 INFO - 'PWD': '/builds/slave/test', 09:14:36 INFO - 'SHELL': '/bin/bash', 09:14:36 INFO - 'SHLVL': '1', 09:14:36 INFO - 'TERM': 'linux', 09:14:36 INFO - 'TMOUT': '86400', 09:14:36 INFO - 'USER': 'cltbld', 09:14:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:36 INFO - '_': '/tools/buildbot/bin/python'} 09:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:36 INFO - Downloading/unpacking blobuploader==1.2.4 09: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 09: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 09: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 09: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 09: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 09: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 09:14:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:14:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:14:39 INFO - Downloading docopt-0.6.1.tar.gz 09:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:39 INFO - Running setup.py install for blobuploader 09:14:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:14:39 INFO - Running setup.py install for requests 09:14:40 INFO - Running setup.py install for docopt 09:14:40 INFO - Successfully installed blobuploader requests docopt 09:14:40 INFO - Cleaning up... 09:14:40 INFO - Return code: 0 09:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:40 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')]} 09:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:40 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')]} 09:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:40 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:40 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 09:14:40 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 09:14:40 INFO - Using env: {'DISPLAY': ':0', 09:14:40 INFO - 'HOME': '/home/cltbld', 09:14:40 INFO - 'LANG': 'en_US.UTF-8', 09:14:40 INFO - 'LANGUAGE': 'en_US:en', 09:14:40 INFO - 'LOGNAME': 'cltbld', 09:14:40 INFO - 'MAIL': '/var/mail/cltbld', 09:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:40 INFO - 'MOZ_NO_REMOTE': '1', 09:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:40 INFO - 'NO_EM_RESTART': '1', 09:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:40 INFO - 'PWD': '/builds/slave/test', 09:14:40 INFO - 'SHELL': '/bin/bash', 09:14:40 INFO - 'SHLVL': '1', 09:14:40 INFO - 'TERM': 'linux', 09:14:40 INFO - 'TMOUT': '86400', 09:14:40 INFO - 'USER': 'cltbld', 09:14:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:40 INFO - '_': '/tools/buildbot/bin/python'} 09:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:40 INFO - Running setup.py (path:/tmp/pip-yJZn7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:40 INFO - Running setup.py (path:/tmp/pip-Dgu_0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:40 INFO - Running setup.py (path:/tmp/pip-AKDGct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:40 INFO - Running setup.py (path:/tmp/pip-b58WIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:40 INFO - Running setup.py (path:/tmp/pip-S_CE41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:40 INFO - Running setup.py (path:/tmp/pip-Zmdlsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:40 INFO - Running setup.py (path:/tmp/pip-R4C1Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:41 INFO - Running setup.py (path:/tmp/pip-5k2uwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:41 INFO - Running setup.py (path:/tmp/pip-bi1L_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:41 INFO - Running setup.py (path:/tmp/pip-eypm2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:41 INFO - Running setup.py (path:/tmp/pip-juEwe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:41 INFO - Running setup.py (path:/tmp/pip-E4xxWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:41 INFO - Running setup.py (path:/tmp/pip-bjUH6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:41 INFO - Running setup.py (path:/tmp/pip-uVdF2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:41 INFO - Running setup.py (path:/tmp/pip-8szKom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:41 INFO - Running setup.py (path:/tmp/pip-vfyM58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:41 INFO - Running setup.py (path:/tmp/pip-XbA2og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:41 INFO - Running setup.py install for manifestparser 09:14:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:41 INFO - Running setup.py install for mozcrash 09:14:41 INFO - Running setup.py install for mozdebug 09:14:42 INFO - Running setup.py install for mozdevice 09:14:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for mozfile 09:14:42 INFO - Running setup.py install for mozhttpd 09:14:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for mozinfo 09:14:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for mozInstall 09:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for mozleak 09:14:42 INFO - Running setup.py install for mozlog 09:14:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for moznetwork 09:14:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:42 INFO - Running setup.py install for mozprocess 09:14:42 INFO - Running setup.py install for mozprofile 09:14:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:43 INFO - Running setup.py install for mozrunner 09:14:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:43 INFO - Running setup.py install for mozscreenshot 09:14:43 INFO - Running setup.py install for moztest 09:14:43 INFO - Running setup.py install for mozversion 09:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:43 INFO - Cleaning up... 09:14:43 INFO - Return code: 0 09:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:43 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')]} 09:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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')]} 09:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:43 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:43 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 09:14:43 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 09:14:43 INFO - Using env: {'DISPLAY': ':0', 09:14:43 INFO - 'HOME': '/home/cltbld', 09:14:43 INFO - 'LANG': 'en_US.UTF-8', 09:14:43 INFO - 'LANGUAGE': 'en_US:en', 09:14:43 INFO - 'LOGNAME': 'cltbld', 09:14:43 INFO - 'MAIL': '/var/mail/cltbld', 09:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:43 INFO - 'MOZ_NO_REMOTE': '1', 09:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:43 INFO - 'NO_EM_RESTART': '1', 09:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:43 INFO - 'PWD': '/builds/slave/test', 09:14:43 INFO - 'SHELL': '/bin/bash', 09:14:43 INFO - 'SHLVL': '1', 09:14:43 INFO - 'TERM': 'linux', 09:14:43 INFO - 'TMOUT': '86400', 09:14:43 INFO - 'USER': 'cltbld', 09:14:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:43 INFO - '_': '/tools/buildbot/bin/python'} 09:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:43 INFO - Running setup.py (path:/tmp/pip-vxGgtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:43 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)) 09:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:43 INFO - Running setup.py (path:/tmp/pip-vEro2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:43 INFO - Running setup.py (path:/tmp/pip-cUK3iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:43 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)) 09:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:43 INFO - Running setup.py (path:/tmp/pip-4vXs9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:44 INFO - Running setup.py (path:/tmp/pip-nXmt9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:44 INFO - Running setup.py (path:/tmp/pip-xQXUpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:44 INFO - Running setup.py (path:/tmp/pip-ZIm3In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:44 INFO - Running setup.py (path:/tmp/pip-XLtS0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:44 INFO - Running setup.py (path:/tmp/pip-gFYHl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:44 INFO - Running setup.py (path:/tmp/pip-Q7K7LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:44 INFO - Running setup.py (path:/tmp/pip-3HNnqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:44 INFO - Running setup.py (path:/tmp/pip-n7NU8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:44 INFO - Running setup.py (path:/tmp/pip-0nd8LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:44 INFO - Running setup.py (path:/tmp/pip-d6CEYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:44 INFO - Running setup.py (path:/tmp/pip-G7SmU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:44 INFO - Running setup.py (path:/tmp/pip-G0F9gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:44 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)) 09:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:44 INFO - Running setup.py (path:/tmp/pip-y0WH23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:44 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)) 09:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:14:44 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)) 09:14:44 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)) 09:14:44 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)) 09:14:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:45 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 09:14:46 INFO - Downloading blessings-1.6.tar.gz 09:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:46 INFO - Installing collected packages: blessings 09:14:46 INFO - Running setup.py install for blessings 09:14:47 INFO - Successfully installed blessings 09:14:47 INFO - Cleaning up... 09:14:47 INFO - Return code: 0 09:14:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:47 INFO - Reading from file tmpfile_stdout 09:14:47 INFO - Current package versions: 09:14:47 INFO - argparse == 1.2.1 09:14:47 INFO - blessings == 1.6 09:14:47 INFO - blobuploader == 1.2.4 09:14:47 INFO - docopt == 0.6.1 09:14:47 INFO - functools32 == 3.2.3-2 09:14:47 INFO - jsonschema == 2.5.1 09:14:47 INFO - manifestparser == 1.1 09:14:47 INFO - mozInstall == 1.12 09:14:47 INFO - mozcrash == 0.17 09:14:47 INFO - mozdebug == 0.1 09:14:47 INFO - mozdevice == 0.48 09:14:47 INFO - mozfile == 1.2 09:14:47 INFO - mozhttpd == 0.7 09:14:47 INFO - mozinfo == 0.9 09:14:47 INFO - mozleak == 0.1 09:14:47 INFO - mozlog == 3.4 09:14:47 INFO - moznetwork == 0.27 09:14:47 INFO - mozprocess == 0.23 09:14:47 INFO - mozprofile == 0.28 09:14:47 INFO - mozrunner == 6.12 09:14:47 INFO - mozscreenshot == 0.1 09:14:47 INFO - mozsystemmonitor == 0.3 09:14:47 INFO - moztest == 0.7 09:14:47 INFO - mozversion == 1.4 09:14:47 INFO - psutil == 3.1.1 09:14:47 INFO - requests == 1.2.3 09:14:47 INFO - wsgiref == 0.1.2 09:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:47 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')]} 09:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:47 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')]} 09:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:47 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:47 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 09:14:47 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 09:14:47 INFO - Using env: {'DISPLAY': ':0', 09:14:47 INFO - 'HOME': '/home/cltbld', 09:14:47 INFO - 'LANG': 'en_US.UTF-8', 09:14:47 INFO - 'LANGUAGE': 'en_US:en', 09:14:47 INFO - 'LOGNAME': 'cltbld', 09:14:47 INFO - 'MAIL': '/var/mail/cltbld', 09:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:47 INFO - 'MOZ_NO_REMOTE': '1', 09:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:47 INFO - 'NO_EM_RESTART': '1', 09:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:47 INFO - 'PWD': '/builds/slave/test', 09:14:47 INFO - 'SHELL': '/bin/bash', 09:14:47 INFO - 'SHLVL': '1', 09:14:47 INFO - 'TERM': 'linux', 09:14:47 INFO - 'TMOUT': '86400', 09:14:47 INFO - 'USER': 'cltbld', 09:14:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:47 INFO - '_': '/tools/buildbot/bin/python'} 09:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09:14:47 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)) 09: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 mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:14:47 INFO - Cleaning up... 09:14:47 INFO - Return code: 0 09:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:47 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')]} 09:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:47 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')]} 09:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:47 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 0x7fb42ab68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', '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 09:14:47 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 09:14:47 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 09:14:47 INFO - Using env: {'DISPLAY': ':0', 09:14:47 INFO - 'HOME': '/home/cltbld', 09:14:47 INFO - 'LANG': 'en_US.UTF-8', 09:14:47 INFO - 'LANGUAGE': 'en_US:en', 09:14:47 INFO - 'LOGNAME': 'cltbld', 09:14:47 INFO - 'MAIL': '/var/mail/cltbld', 09:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:47 INFO - 'MOZ_NO_REMOTE': '1', 09:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:47 INFO - 'NO_EM_RESTART': '1', 09:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:47 INFO - 'PWD': '/builds/slave/test', 09:14:47 INFO - 'SHELL': '/bin/bash', 09:14:47 INFO - 'SHLVL': '1', 09:14:47 INFO - 'TERM': 'linux', 09:14:47 INFO - 'TMOUT': '86400', 09:14:47 INFO - 'USER': 'cltbld', 09:14:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:47 INFO - '_': '/tools/buildbot/bin/python'} 09:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:47 INFO - Cleaning up... 09:14:47 INFO - Return code: 0 09:14:47 INFO - Running post-action listener: _resource_record_post_action 09:14:47 INFO - Running post-action listener: _start_resource_monitoring 09:14:47 INFO - Starting resource monitoring. 09:14:47 INFO - [mozharness: 2016-10-04 16:14:47.840766Z] Finished create-virtualenv step (success) 09:14:47 INFO - [mozharness: 2016-10-04 16:14:47.841273Z] Running install step. 09:14:47 INFO - Running pre-action listener: _resource_record_pre_action 09:14:47 INFO - Running main action method: install 09:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:48 INFO - Reading from file tmpfile_stdout 09:14:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:48 INFO - Reading from file tmpfile_stdout 09:14:48 INFO - Output received: 09:14:48 INFO - Usage: mozinstall [options] installer 09:14:48 INFO - Options: 09:14:48 INFO - -h, --help show this help message and exit 09:14:48 INFO - -d DEST, --destination=DEST 09:14:48 INFO - Directory to install application into. [default: 09:14:48 INFO - "/builds/slave/test"] 09:14:48 INFO - --app=APP Application being installed. [default: firefox] 09:14:48 INFO - mkdir: /builds/slave/test/build/application 09:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:15:04 INFO - Reading from file tmpfile_stdout 09:15:04 INFO - Output received: 09:15:04 INFO - /builds/slave/test/build/application/firefox/firefox 09:15:04 INFO - Running post-action listener: _resource_record_post_action 09:15:04 INFO - [mozharness: 2016-10-04 16:15:04.269004Z] Finished install step (success) 09:15:04 INFO - [mozharness: 2016-10-04 16:15:04.269251Z] Running run-tests step. 09:15:04 INFO - Running pre-action listener: _resource_record_pre_action 09:15:04 INFO - Running main action method: run_tests 09:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:15:04 INFO - Python 2.7.3 09:15:04 INFO - Return code: 0 09:15:04 INFO - grabbing minidump binary from tooltool 09:15:04 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')]} 09:15:04 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 0x144ff60>, '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 0x1450d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14511d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:15:04 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 09:15:04 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 09:15:04 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 09:15:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:04 INFO - Return code: 0 09:15:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:15:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:15:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:15:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:15:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 09:15:04 INFO - Using env: {'DISPLAY': ':0', 09:15:04 INFO - 'HOME': '/home/cltbld', 09:15:04 INFO - 'LANG': 'en_US.UTF-8', 09:15:04 INFO - 'LANGUAGE': 'en_US:en', 09:15:04 INFO - 'LOGNAME': 'cltbld', 09:15:04 INFO - 'MAIL': '/var/mail/cltbld', 09:15:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:04 INFO - 'MOZ_NO_REMOTE': '1', 09:15:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:04 INFO - 'NO_EM_RESTART': '1', 09:15:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:04 INFO - 'PWD': '/builds/slave/test', 09:15:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:04 INFO - 'SHELL': '/bin/bash', 09:15:04 INFO - 'SHLVL': '1', 09:15:04 INFO - 'TERM': 'linux', 09:15:04 INFO - 'TMOUT': '86400', 09:15:04 INFO - 'USER': 'cltbld', 09:15:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609', 09:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:04 INFO - '_': '/tools/buildbot/bin/python'} 09:15:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:15:04 INFO - mozversion application_buildid: 20161004074700 09:15:04 INFO - mozversion application_changeset: 604451ab58290450155779b6692a92f30d76717d 09:15:04 INFO - mozversion application_display_name: Nightly 09:15:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:04 INFO - mozversion application_name: Firefox 09:15:04 INFO - mozversion application_remotingname: firefox 09:15:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:15:04 INFO - mozversion application_vendor: Mozilla 09:15:04 INFO - mozversion application_version: 52.0a1 09:15:04 INFO - mozversion platform_buildid: 20161004074700 09:15:04 INFO - mozversion platform_changeset: 604451ab58290450155779b6692a92f30d76717d 09:15:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:15:04 INFO - mozversion platform_version: 52.0a1 09:15:04 INFO - using testdate: 1475597704 09:15:04 INFO - actual date: 1475597704 09:15:04 INFO - starting webserver on 'localhost:57337' 09:15:04 INFO - SUITE-START | Running 2 tests 09:15:04 INFO - TEST-START | dromaeo_css 09:15:04 INFO - operating with platform_type : linux_ 09:15:04 INFO - Initialising browser for dromaeo_css test... 09:15:04 INFO - TEST-INFO | started process 16375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVEsus/profile http://localhost:57337/getInfo.html) 09:15:09 INFO - PROCESS | 16375 | __metrics Screen width/height:1600/1200 09:15:09 INFO - PROCESS | 16375 | colorDepth:24 09:15:09 INFO - PROCESS | 16375 | Browser inner width/height: 1024/697 09:15:09 INFO - PROCESS | 16375 | __metrics 09:15:09 INFO - PROCESS | 16375 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:15:09 INFO - PROCESS | 16375 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:10 INFO - PROCESS | 16375 | console.error: PushService: 09:15:10 INFO - PROCESS | 16375 | stateChangeProcessEnqueue: Error transitioning state 09:15:10 INFO - PROCESS | 16375 | UnknownError 09:15:10 INFO - TEST-INFO | 16375: exit 0 09:15:10 INFO - Browser initialized. 09:15:10 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:10 INFO - TEST-INFO | started process 16456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVEsus/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:23 INFO - PROCESS | 16456 | RSS: Main: 175083520 09:15:23 INFO - PROCESS | 16456 | 09:16:15 INFO - PROCESS | 16456 | 1475597775009 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] 09:18:27 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57337/tests/dromaeo/cssquery-ext.html) 09:18:29 INFO - PROCESS | 16456 | RSS: Main: 283213824 09:18:29 INFO - PROCESS | 16456 | 09:21:31 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-ext.html (next: http://localhost:57337/tests/dromaeo/cssquery-jquery.html) 09:21:32 INFO - PROCESS | 16456 | RSS: Main: 274825216 09:21:32 INFO - PROCESS | 16456 | 09:24:34 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57337/tests/dromaeo/cssquery-mootools.html) 09:24:35 INFO - PROCESS | 16456 | RSS: Main: 249802752 09:24:35 INFO - PROCESS | 16456 | 09:27:37 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57337/tests/dromaeo/cssquery-prototype.html) 09:27:38 INFO - PROCESS | 16456 | RSS: Main: 219680768 09:27:38 INFO - PROCESS | 16456 | 09:30:41 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57337/tests/dromaeo/cssquery-yui.html) 09:30:41 INFO - PROCESS | 16456 | RSS: Main: 221106176 09:30:41 INFO - PROCESS | 16456 | 09:33:44 INFO - PROCESS | 16456 | Cycle 1(1): loaded http://localhost:57337/tests/dromaeo/cssquery-yui.html (next: http://localhost:57337/tests/dromaeo/cssquery-dojo.html) 09:33:45 INFO - PROCESS | 16456 | RSS: Main: 320671744 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | __start_tp_report 09:33:45 INFO - PROCESS | 16456 | _x_x_mozilla_page_load 09:33:45 INFO - PROCESS | 16456 | _x_x_mozilla_page_load_details 09:33:45 INFO - PROCESS | 16456 | |i|pagename|runs| 09:33:45 INFO - PROCESS | 16456 | |0;dojo.html;2504.4365017870978;2524.3310522711495;2552.6171074338854;2559.2578152335814;2578.9484210315795;4414.29371300592;4474.0380818124095;4585.816567337307;4590.655700822435;4596.28757542581;4502.077074199789;4548.226801443754;4592.380028696125;4617.330487079372;4667.043256132493;4152.231837110145;4189.392538081992;4237.70336076474;4258.361245813122;4262.72292301001;4203.138356636882;4211.557786432427;4218.831246750126;4244.702870799046;4274.893127671802;4233.618974292313;4245.10852720929;4285.035866929947;4302.677299202556;4304.827806887721;4111.60939710727;4147.357159640261;4154.335306350969;4201.642860356873;4210.810513526899;4118.814653340577;4139.130782535671;4165;4171.353440216772;4180.91638167238;4479.910401791946;4493.303537951622;4525.570070843265;4564.794584243684;4589.128065667513;4816.759162041919;4845.491223421525;4849.539293767087;4850.83022094225;4904.337914381585;4693.788779504896;4747.311639812242;4879.121758083544;4893.04585605807;4960.007998400334;4514.729116253068;4517.938284503205;4540.5913467787395;4552;4583.312503124492;4919.2867034279825;4947.925781113287;4957.90084198314;4962.851114466572;5020.422651395063;4632.2356811126465;4766.856994290177;4775.785089670973;4776.761161941889;4838.056578967138;4735.384400028043;4774.522547745267;4823.614110871122;4825.252085926687;4909.484504127086;4792.305115758196;4794.904101917942;4803.135435621622;4850.490698476609;4854.757262136879;4759.452662943737;4762.333273341735;4776.450708168605;4777.593904518086;4829.058333624909;4073.714839961174;4113.732607380571;4120.443740095049;4128.298189307825;4151.315033019579;3624.7100231981904;3627.582827974764;3662.4689420033947;3668.596454390015;3712.0348709335226;4197.118605092965;4205.747655140702;4206.8737937861915;4245.8513952012145;4262.360645903139;4727.314539391838;4801.879953001203;4815.855524334275;4841.370621819141;4848.684835485682;4189.601987811153;4231.132617813341;4258.787060646955;4268.0823622921225;4272.658187345005;4414.4702635683925;4421.137878113737;4430.158269928703;4479.843205487792;4482.081173359454;4494.528074552256;4552.339910712994;4610.700304480198;4613.492515823324;4613.677042606985;4805.231163013901;4858.222684370484;4860.1008813369635;4867.318575399518;4901.117798796251;4567.954320456753;4590.05903789729;4596.379488768974;4599.333096700892;4654.86035418938;4720.386349774507;4768.022555376209;4781.115493633689;4785.736784476748;4801.807927682854;4805.063012712488;4838.95161048385;4839.612830973443;4854.320395144753;4920.45874953762;4719.976400117977;4727.834525791581;4732.053589282226;4733.5266473352385;4782.497837726988;4617.79219935097;4726.669133160645;4737.549932756383;4743.644226683082;4789.7605119743175;4577.56513131252;4610.193216187221;4628.236341003697;4632.02727427244;4699.718016918996;4737.194676905004;4737.620990320697;4742.264948932921;4746.905061898812;4799.448063472745;4528.841490547815;4651.186042442627;4652.371929789435;4657.976710116428;4712.740799256074 09:33:45 INFO - PROCESS | 16456 | |1;ext.html;552.4999875113024;553.1951011278587;553.3581045986656;570.0110308614553;570.6319423971538;28006.71993280069;30451;30480.69519304809;37810;39239.80380098095;39397.212055758864;39794.403083953766;39800.40299395504;39831;39836.203275934466;7443.478956473049;7588.089429268495;7591.5445073295505;7592.658330375147;7592.696292148307;7195.172555156146;7395.519291246079;9495.335326527145;9689.370190937567;9691.612335506607;9829.508524573743;9871.457069861155;9903.25725570585;9911.207103431709;9928.205743540535;9733.853992190123;9768.804623907554;9784.951075244613;9819.919808821023;9840.852387214198;9612.89451713055;9745.756356091084;9770.071843174886;9784.706458806248;9785.119339259501;35951;36101.638983610355;36179;36181;36184.63815361865;2762.958555621667;2787.080263513036;2811.2550174203852;2870.942581148386;3092.041467145192;26329.868350658315;26714.5992810108;26903.32741681454;27450.5882411764;27792.444151117066;3242.789218700777;3299.7195238404765;3385.8814941477176;3404.5233667286598;3410.5225268462436;246128;248322;248839;248947;249013;52567;53012.469875300754;53037.469625304024;53098.73450632722;53117;31374.86251374844;32625;32655.183620409203;34249.48625770616;50072;14499.637509062359;14940.32768525419;14962.326695298738;14982.026168299026;14991.625209369635;8477.364197685198;10643.893561064446;10647.84028239577;10653.57385704563;10654.254202205771;14836.480723174853;16789;17335.91332043357;17516.824831751775;18238.90880545589;6741.730330786713;6824;6835.658217089126;6845.14435695538;6954.860902781916;772.9652165652559;888.0542222532981;910.9842525583927;937.9062093790567;946.9583458196067;26000.86999565028;27180.864095679393;27811;27867.860660696566;27873.721262787112;897.9955100224588;913.9771505712278;921.6267411698273;982.5283863745442;1014.8173328800887;13555.59333220005;14391.424343026161;14825;14846.851531484763;15552.74404518787;373270;375749;376298;376542;377052;47635;48076;48085;48103.278450823265;48147.277790832464;1187.5427960235372;1193.3138445393934;1209.1354681402838;1214.1622280626339;1219.664592237142;26000.739992599832;27257.591136132578;27512.449751005268;27716.722832772222;28040.579391309555;40516.594834051284;41150.176996459304;41158;41188;41195;257393;257604;258072;258539;311995;20943.685844712036;21712.457188570414;23570;24545.87727061353;24557;37522.437163442024;38817.6118238814;38907;42481;42990.57009429991;33603.66396336005;33737.83131084329;34100.488492673125;34101.82949085239;34134.781239219374;33572.496412553344;34043.31913361768;34126.31747364989;34226.144346390545;34674.65325346714;32318.35363292768;33723.66276337205;33815.49276760801;34036.48945265872;34126.488102677984;28919.566206506497;30951;31075.75696972096;31232.843835780677;31298.843505782326;24213.394665133514;24316.27051188467;24472;24647.260582182564;24680.13619523308 09:33:45 INFO - PROCESS | 16456 | |2;jquery.html;337.32703257002254;349.55780937114537;360.2524761120674;361.8299399282336;362.88931875777894;11983.460744266507;15417.768733468993;16224.432144874901;16229.107399093045;17359.39242126526;16101.758473622906;16167.43413980511;16845;16970.23633936473;16990.915045424787;4766.285057241407;4807.375041244651;4943.728094954785;5183.766730497118;5184.948150518503;4953.6037117030555;5074.086664400406;5079.212722028073;5079.669821461612;5086.364204474441;4874.439439464454;5039.521245481674;5042.546170844642;5048.419431765339;5050.393952725678;5033.974830125844;5104.846854594368;5105.438401775802;5109.872253193663;5112.923306150411;4358.564143585648;4578.473475550321;4581.954180458186;4582.358469814195;4584.770761461914;19892.403227903185;20052.899735501374;20062.498437539034;20200.585958982876;20228.393148205578;1686.949391518244;1793.4978206102312;1824.4800231933834;1862.832345088935;2364.633481810305;12314.938425307906;12869.163504372185;13335.466581336736;13410.46358145673;13529.458821647122;1542.4755583101687;1604.4143887480986;1613.2337139858591;1647.0776365235386;1703.7018521758766;67168.9999999995;67170.66414667896;67237;67682.3231767681;68135.65932170357;8150.307223886036;8306.958465207636;8337.166283371615;9616.75958101053;9647.855282170773;13077.607671769862;13189.934050329879;13190.076694631476;13190.802137967747;13199.340032998503;7224.349808517153;7390.926090739132;7444.516106453063;7448.553086814808;7575.5454672718715;7054.541454805421;7074.115735533059;7182.209956904736;7304.671289791972;7318.3047610476915;5900.321463031806;5920;5942.108683697394;6062.484688801413;6070.362611925772;1615.8061032675919;1705.2326453096157;1763.4621440460783;1773.361589827661;1778.2442461953617;649.6297110646981;816.2775943290112;821.6713314674179;839.8908141941508;875.0986483921571;16885.662286754443;17066.658666826595;17187.828121718623;17452.47642570725;17925.28298868031;874.9387542871938;881.2421317666801;904.4166512599337;911.7811725186041;921.6221349246777;9206.410772803487;9858.359206651545;9987.951265117059;9988.800223995479;10105.736782902137;370373;371723;376258;379029;379818;66121.33878661152;68206;68591.65704171547;68795;69711;853.1425916953422;860.0926023045622;873.7116751472126;876.5967654878827;877.1360210192955;15226;15350.309236084626;15672.686546269239;15891.523254302389;15955.122468264357;34653;34841.47737783885;35042.09410682455;35418.11454713653;36214.45678314775;50457;51673.48326516687;52001.7399912998;53902.73048634732;54396;7241.384482319062;7544.585047822203;7739.490799294083;7847.254510821463;7940.325072368682;8547.57262136903;11401.429928503376;11515.8272625909;11521.596744113916;12223.572174973833;5273.471585781148;9458.013817098212;10094.394336339843;10318.277720559488;10370.325928814604;9681.903180968382;10246.897531024595;10362.481875906326;10389.220808439548;10542.947285263524;10050.346727462691;10324.48377581133;10399.128156931825;10665.46672666348;10723.678289651323;7287.635618218962;7396.889046664197;7479.850402992019;7553.4712570121765;7750.294935114266;9428.434293942386;10141.746456338651;10237.18102551809;10289.3311934724;10894.182936279652 09:33:45 INFO - PROCESS | 16456 | |3;mootools.html;1297.1568480487686;1317.9736405271894;1337.7391408675305;1608.329663042564;1664.8418400251971;6593.802185934418;6883.827904302395;6937.653117344132;7485.588292643909;7516.3235308822195;7142.8571428571395;7417.184109747924;7420.628968551578;7628.199039100898;7630.198829122932;1947.6202140582627;1978.8021197880241;1987.4137129546818;1988.413418041674;1990.3829812758092;1708.2654458582804;1760.3398725477946;1900.3158862809446;1948.3278268997174;1957.5693347463607;1911.2068491575978;1983.0976905508032;1988.3438465306415;2000.5298754792611;2001.6997450382487;1941.5728539721238;1955.6675365187882;1961.8626696131205;1964.0866996846391;1972.5068732816796;1949.220311875247;1993.7906519815356;1998.9100490477963;2001.0495014867968;2001.909914053871;7647.694092236359;7708.884366734504;7712.035995500562;7716.729914452967;7724.266194711493;4225.323948168279;4340.175366680321;4344.978275108636;4345.50026746925;4348.869533913956;2620.344913771557;2788.177487641151;2793.9301517462227;2796.622455968459;2798.0906205483298;785.2461636828651;835.1231207232443;848.0417128644654;848.2789628815519;860.9784755381103;9876.40741555509;9906.216880961423;9914.45470499115;9920.603175872957;9942.502874856229;3587.3812117154102;3723.795191264452;3869.7678139311734;3878.7672739635714;3883.10688541637;8582.570871456526;8582.699605513777;8583.65665373378;8638.13618638131;8639.222469977733;4347.978260108743;4390.143921935192;4394.231009573376;4403.141387429485;4414.977925110354;3964.623360780721;3991.980040099781;4006.4390985262085;4007.8797636070963;4015.4980627421573;3182.7612929030415;3313.1551454378978;3319.850606722703;3365.9663403365653;3391.7117045050954;898.8921329440509;911.1799380557419;1003.9698809035741;1014.3964341216964;1018.5467466977124;626.37675512865;693.7537174303151;762.7673559564275;765.3303359560384;796.2952786783738;4528.864134075983;4670.112678591125;4730.787114579852;4766.856994290108;4838.879028024327;763.9388848892075;765.0666187251544;774.5585016540631;825.3026192867018;845.1252953193415;3084.352286019961;3196.7922085064397;3227.5320078588943;3232.046546268856;3235.433799085151;8428;8499.575021248913;8777.561121943878;8790.120987901159;8899.73300800977;8930.598123084477;8933.776655583533;8934.28525717941;8943.865842012376;8944.418612790278;6850.862982740317;7035.085438893014;7040.542364746275;7067.469939754539;7073.434125269966;4753.524647535219;4970.353853998957;4996.150654388835;5120.820771272987;5151.793928242978;8094.392920530866;8316.251537361666;8342.541160236246;8440.51004953528;8442.282405995558;8226.177382261725;8508.191721786421;8542.701005464778;8601.526916019679;8606.913930860612;6204.689765511796;6317.30509643948;6359.841003974938;6369.20384951881;6374.107624932421;6797.150356205474;6903.0680858083515;6904.896426553505;6909.378155965987;6911.965440172767;6102.4812890902995;6152.446279834658;6179.969100154471;6254.437100660963;6462.903056454063;6072.240969878765;6189.597676151036;6223.96888015557;6249.250089989048;6255.374462553708;6050.21347224858;6162.352952940056;6168.42705110194;6171.352008039091;6173.382661733791;4224.366345048267;4243.490781106164;4291.249031419551;4327.091310824636;4407.603315701603;4235.576442355739;4403.691741578187;4475.194464996332;4489.855086952806;4490.57339552742 09:33:45 INFO - PROCESS | 16456 | |4;prototype.html;264.23899170389274;274.0449533376185;275.6815877661302;285.53030265213727;292.96045033920416;4629.652776041802;4778.283257511366;4837.153498137825;4852.830150944717;4864.83244021435;4606.769661516919;4707.411573553306;4738.170820106477;4750.809967601301;4755;3559.1635965548076;3744.2511497700434;3758.1732018955786;3774.2074164425503;3776.4705294355695;3626.2747450509873;3685.4287585424304;3734.8319325630277;3753.9968025579565;3768.152165762709;3722.88831335059;3732.4401339798974;3740.1397678533817;3750.0437388465903;3767.3783825668734;3738.840959302625;3755.530558680165;3778.4143457763953;3783.6405541473514;3788.3559794834946;3270.9018729438153;3304.983475082633;3310.5034244863223;3327.8835240766457;3336.8665253389836;4624.011674979757;4637.652176086774;4641.3270075839155;4645.7909394077005;4674.368960190399;4279.8074086665865;4281.272183728743;4283.1433713257165;4295.926018495376;4298.892527686801;4802.327674125625;4983.405310300705;4989.600831933437;5005.273180752634;5012.498750124995;3544.85820567177;3546.6985306249;3548.7515873888838;3554.2180720241504;3554.91112722184;5200.843974680728;5225.137852254412;5226.8693282667855;5226.876221612371;5234.293370394986;3516.4373700207843;3592.407252803258;3609.639036096369;3634.727395445352;3635.5092062571744;3649.2883887641656;3650.452432135201;3650.580183278957;3659.396199627032;3673.9081522961606;4175.707700460938;4176.58234176586;4194;4199.139176468817;4200.319872051143;4743.691660042086;4892.3884514435695;5008.69947803133;5014.52362025607;5023.522765337287;1210.0336952452265;1238.2694210415898;1239.1635645938954;1247.3950134184913;1249.993750031244;779.5772714795521;798.0582912163702;819.6229734322278;825.3850881093624;825.451075035095;3973.7218394712672;3984.30274701926;3993.660538854172;3998.800059997047;4003.298598095798;4526.95473045272;4532.682712210114;4533.569310915458;4548.226801443696;4569.885752856205;3978.4430179774854;3993.600639935983;3998.28030954431;3999.4000899865255;4002.239574480839;2276.0052934966243;2414.541237164968;2421.757824217564;2427.041318679147;2433.683621129242;4274.700770946004;4292.849750258789;4327.398862420861;4342.739435633809;4356.956430435655;4591.334256532851;4595.770211489412;4603.49361570227;4606.3743666109995;4613.677042606985;4077.531083925327;4137.606927341898;4257.765822879772;4271.615554600101;4292.635126014324;4469.351943968171;4493.707908985905;4494.528074552256;4497.415336006298;4510.007798284372;4431.933520997123;4442.155990361821;4443.466783985813;4450.265706158448;4471.239889218776;4263.317869140923;4264.87205383839;4271.9786401067795;4282.865040764138;4496.550344965477;3664.37705590045;3741.4948981888188;3774.358359079018;3774.679152272088;3780.8109594520715;4938.75306234694;5159.374796938952;5170.6380553360905;5173.249878767482;5194.168932970707;4859.3682821233015;4939.209726443752;5024.120778863611;5027.371578552681;5043.722595257296;5039;5039.0929632666475;5040.571551418024;5052.494750524918;5052.9494705052475;4830.975845120752;4968.403791545038;4972.552470277692;4979.452260251442;4996.400431948189;5006.199008158677;5050.3182070420025;5053.393592768891;5073.188289873602;5074.771635276347;4957.652964292465;4971.179755340473;4972.9254061188385;4976.552110310089;4980.203167493184 09:33:45 INFO - PROCESS | 16456 | |5;yui.html;617.5056363600087;667.7095463473387;699.3041923286331;709.8225443639091;722.5195245161967;12946.676333091666;13692.794608080862;13706.588802335946;13756.793648095287;13763.243021633805;12949.74100517989;13095.47618095275;13108;13121.67195820105;13137.27744974026;604.8336707405455;616.3866952382364;709.3367701199395;724.380654540367;731.297953964195;754.4680999895061;754.641545265997;757.2843662738715;757.7537300377372;758.0713625808396;793.3811626931004;793.4921650143913;794.8211652378227;794.8489786940463;794.8489786940492;624.7844493649684;644.5423749138071;755.8526087412956;773.3967505345782;790.7192946503966;580.1153241306998;580.2485780913685;580.2630659063009;580.7299605683378;580.9302883653946;12430.689232769162;12556.246625202517;12579.308138052404;12594.307313097775;12647.936760316139;11980.760384792342;12384.504619815196;12497.93751031248;12715.87284127156;12722.07392299767;11297;11357;11526.654200373918;11660.76678466426;11842.526298948032;3883.902902427462;3893.7274390792654;3906.101596632762;4072.1448495815916;4072.694547908889;59967;60767.69616151891;61190.38809611891;61407.69296153491;61824.38175618276;9601.37591056579;9697.787776527934;9762.121409073075;9876.160526355341;9964.601415943425;18137.455876323467;18142.5464363392;18172.63654726898;18184.36354727578;18184.636307274046;6530.542861999709;6589.736410543621;6598.769043083565;6686.933130668728;6782.8304292392095;3190.744740420761;3273.9836300818342;3339.7662163648797;3395.7792743471596;3424.9845811033642;2673.8395696258285;2751.821131626438;2757.6139340492346;2766.8478233696937;2769.473799978038;467.9321498382715;470.5153691697557;480.5602873370826;482.39218584583676;487.6220928780153;477.4366247827597;480.28677414040123;510.39008384979593;527.3223907279128;543.741722681731;7131.393831524275;7392.112946446353;7458;7465.328120469184;7499.6250187490405;511.4297558222555;512.272572946417;529.2854646227562;534.6150771444553;538.2590992601436;3459.6540345965204;3515.9296814063578;3522.2955408917805;3546.840392182358;3567;93898.53050734839;96357;99775.50112249538;99905.50047249862;100708.49645751725;81049.59475202704;82196.17803822005;82676;83304;84649.57675211584;73855;75789.24210757822;76237;76348.61825690947;76482.61758691171;6684.565503242274;6758.121444212417;6777.186737591323;6798.286179951034;7072.68172932209;44213.557864420945;45041;45247.547524524336;45466.31800522929;45854.31218531658;41448.792756036026;58263.12605310839;60326.396736032075;61508.384916150266;65920.6703966477;10789.244752867538;10897.891021090005;10931.617393391192;11699.356535390294;11774.587889423829;11353;12536.185147965352;13341.399637016164;13668.384922678304;13960.860391395956;11263.549458021587;11330.94334528322;11342;11915.880841191478;12089.093318001362;11555.942220289182;11795.587154449553;12315.384230788246;12494.625161244814;12534.561290354794;10892.346459212473;11012.559497620327;11203.271787333797;11236.66290011301;11813.350265735467;9477.336586439158;9710.641007781429;9897.752556186153;10070.546825392728;10175.28772985884;9983.900160998297;9990.950045250018;10028.749281268027;10074.496275186359;10097.495125243562 09:33:45 INFO - PROCESS | 16456 | __end_tp_report 09:33:45 INFO - PROCESS | 16456 | __start_cc_report 09:33:45 INFO - PROCESS | 16456 | _x_x_mozilla_cycle_collect,1089 09:33:45 INFO - PROCESS | 16456 | __end_cc_report 09:33:45 INFO - PROCESS | 16456 | __startTimestamp1475598825200__endTimestamp 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | ------- Summary: start ------- 09:33:45 INFO - PROCESS | 16456 | Number of tests: 6 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#0] dojo.html Cycles:165 Average:4492.19 Median:4610.70 stddev:454.18 (9.9%) stddev-sans-first:427.96 09:33:45 INFO - PROCESS | 16456 | Values: 2504.4 2524.3 2552.6 2559.3 2578.9 4414.3 4474.0 4585.8 4590.7 4596.3 4502.1 4548.2 4592.4 4617.3 4667.0 4152.2 4189.4 4237.7 4258.4 4262.7 4203.1 4211.6 4218.8 4244.7 4274.9 4233.6 4245.1 4285.0 4302.7 4304.8 4111.6 4147.4 4154.3 4201.6 4210.8 4118.8 4139.1 4165.0 4171.4 4180.9 4479.9 4493.3 4525.6 4564.8 4589.1 4816.8 4845.5 4849.5 4850.8 4904.3 4693.8 4747.3 4879.1 4893.0 4960.0 4514.7 4517.9 4540.6 4552.0 4583.3 4919.3 4947.9 4957.9 4962.9 5020.4 4632.2 4766.9 4775.8 4776.8 4838.1 4735.4 4774.5 4823.6 4825.3 4909.5 4792.3 4794.9 4803.1 4850.5 4854.8 4759.5 4762.3 4776.5 4777.6 4829.1 4073.7 4113.7 4120.4 4128.3 4151.3 3624.7 3627.6 3662.5 3668.6 3712.0 4197.1 4205.7 4206.9 4245.9 4262.4 4727.3 4801.9 4815.9 4841.4 4848.7 4189.6 4231.1 4258.8 4268.1 4272.7 4414.5 4421.1 4430.2 4479.8 4482.1 4494.5 4552.3 4610.7 4613.5 4613.7 4805.2 4858.2 4860.1 4867.3 4901.1 4568.0 4590.1 4596.4 4599.3 4654.9 4720.4 4768.0 4781.1 4785.7 4801.8 4805.1 4839.0 4839.6 4854.3 4920.5 4720.0 4727.8 4732.1 4733.5 4782.5 4617.8 4726.7 4737.5 4743.6 4789.8 4577.6 4610.2 4628.2 4632.0 4699.7 4737.2 4737.6 4742.3 4746.9 4799.4 4528.8 4651.2 4652.4 4658.0 4712.7 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#1] ext.html Cycles:180 Average:44465.05 Median:34114.07 stddev:79662.39 (233.5%) stddev-sans-first:79817.64 09:33:45 INFO - PROCESS | 16456 | Values: 552.5 553.2 553.4 570.0 570.6 28006.7 30451.0 30480.7 37810.0 39239.8 39397.2 39794.4 39800.4 39831.0 39836.2 7443.5 7588.1 7591.5 7592.7 7592.7 7195.2 7395.5 9495.3 9689.4 9691.6 9829.5 9871.5 9903.3 9911.2 9928.2 9733.9 9768.8 9785.0 9819.9 9840.9 9612.9 9745.8 9770.1 9784.7 9785.1 35951.0 36101.6 36179.0 36181.0 36184.6 2763.0 2787.1 2811.3 2870.9 3092.0 26329.9 26714.6 26903.3 27450.6 27792.4 3242.8 3299.7 3385.9 3404.5 3410.5 246128.0 248322.0 248839.0 248947.0 249013.0 52567.0 53012.5 53037.5 53098.7 53117.0 31374.9 32625.0 32655.2 34249.5 50072.0 14499.6 14940.3 14962.3 14982.0 14991.6 8477.4 10643.9 10647.8 10653.6 10654.3 14836.5 16789.0 17335.9 17516.8 18238.9 6741.7 6824.0 6835.7 6845.1 6954.9 773.0 888.1 911.0 937.9 947.0 26000.9 27180.9 27811.0 27867.9 27873.7 898.0 914.0 921.6 982.5 1014.8 13555.6 14391.4 14825.0 14846.9 15552.7 373270.0 375749.0 376298.0 376542.0 377052.0 47635.0 48076.0 48085.0 48103.3 48147.3 1187.5 1193.3 1209.1 1214.2 1219.7 26000.7 27257.6 27512.4 27716.7 28040.6 40516.6 41150.2 41158.0 41188.0 41195.0 257393.0 257604.0 258072.0 258539.0 311995.0 20943.7 21712.5 23570.0 24545.9 24557.0 37522.4 38817.6 38907.0 42481.0 42990.6 33603.7 33737.8 34100.5 34101.8 34134.8 33572.5 34043.3 34126.3 34226.1 34674.7 32318.4 33723.7 33815.5 34036.5 34126.5 28919.6 30951.0 31075.8 31232.8 31298.8 24213.4 24316.3 24472.0 24647.3 24680.1 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#2] jquery.html Cycles:180 Average:23569.59 Median:4675.53 stddev:61881.98 (1323.5%) stddev-sans-first:62030.99 09:33:45 INFO - PROCESS | 16456 | Values: 337.3 349.6 360.3 361.8 362.9 11983.5 15417.8 16224.4 16229.1 17359.4 16101.8 16167.4 16845.0 16970.2 16990.9 4766.3 4807.4 4943.7 5183.8 5184.9 4953.6 5074.1 5079.2 5079.7 5086.4 4874.4 5039.5 5042.5 5048.4 5050.4 5034.0 5104.8 5105.4 5109.9 5112.9 4358.6 4578.5 4582.0 4582.4 4584.8 19892.4 20052.9 20062.5 20200.6 20228.4 1686.9 1793.5 1824.5 1862.8 2364.6 12314.9 12869.2 13335.5 13410.5 13529.5 1542.5 1604.4 1613.2 1647.1 1703.7 67169.0 67170.7 67237.0 67682.3 68135.7 8150.3 8307.0 8337.2 9616.8 9647.9 13077.6 13189.9 13190.1 13190.8 13199.3 7224.3 7390.9 7444.5 7448.6 7575.5 7054.5 7074.1 7182.2 7304.7 7318.3 5900.3 5920.0 5942.1 6062.5 6070.4 1615.8 1705.2 1763.5 1773.4 1778.2 649.6 816.3 821.7 839.9 875.1 16885.7 17066.7 17187.8 17452.5 17925.3 874.9 881.2 904.4 911.8 921.6 9206.4 9858.4 9988.0 9988.8 10105.7 370373.0 371723.0 376258.0 379029.0 379818.0 66121.3 68206.0 68591.7 68795.0 69711.0 853.1 860.1 873.7 876.6 877.1 15226.0 15350.3 15672.7 15891.5 15955.1 34653.0 34841.5 35042.1 35418.1 36214.5 50457.0 51673.5 52001.7 53902.7 54396.0 7241.4 7544.6 7739.5 7847.3 7940.3 8547.6 11401.4 11515.8 11521.6 12223.6 5273.5 9458.0 10094.4 10318.3 10370.3 9681.9 10246.9 10362.5 10389.2 10542.9 10050.3 10324.5 10399.1 10665.5 10723.7 7287.6 7396.9 7479.9 7553.5 7750.3 9428.4 10141.7 10237.2 10289.3 10894.2 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#3] mootools.html Cycles:180 Average:4797.52 Median:6127.46 stddev:2713.49 (44.3%) stddev-sans-first:2708.35 09:33:45 INFO - PROCESS | 16456 | Values: 1297.2 1318.0 1337.7 1608.3 1664.8 6593.8 6883.8 6937.7 7485.6 7516.3 7142.9 7417.2 7420.6 7628.2 7630.2 1947.6 1978.8 1987.4 1988.4 1990.4 1708.3 1760.3 1900.3 1948.3 1957.6 1911.2 1983.1 1988.3 2000.5 2001.7 1941.6 1955.7 1961.9 1964.1 1972.5 1949.2 1993.8 1998.9 2001.0 2001.9 7647.7 7708.9 7712.0 7716.7 7724.3 4225.3 4340.2 4345.0 4345.5 4348.9 2620.3 2788.2 2793.9 2796.6 2798.1 785.2 835.1 848.0 848.3 861.0 9876.4 9906.2 9914.5 9920.6 9942.5 3587.4 3723.8 3869.8 3878.8 3883.1 8582.6 8582.7 8583.7 8638.1 8639.2 4348.0 4390.1 4394.2 4403.1 4415.0 3964.6 3992.0 4006.4 4007.9 4015.5 3182.8 3313.2 3319.9 3366.0 3391.7 898.9 911.2 1004.0 1014.4 1018.5 626.4 693.8 762.8 765.3 796.3 4528.9 4670.1 4730.8 4766.9 4838.9 763.9 765.1 774.6 825.3 845.1 3084.4 3196.8 3227.5 3232.0 3235.4 8428.0 8499.6 8777.6 8790.1 8899.7 8930.6 8933.8 8934.3 8943.9 8944.4 6850.9 7035.1 7040.5 7067.5 7073.4 4753.5 4970.4 4996.2 5120.8 5151.8 8094.4 8316.3 8342.5 8440.5 8442.3 8226.2 8508.2 8542.7 8601.5 8606.9 6204.7 6317.3 6359.8 6369.2 6374.1 6797.2 6903.1 6904.9 6909.4 6912.0 6102.5 6152.4 6180.0 6254.4 6462.9 6072.2 6189.6 6224.0 6249.3 6255.4 6050.2 6162.4 6168.4 6171.4 6173.4 4224.4 4243.5 4291.2 4327.1 4407.6 4235.6 4403.7 4475.2 4489.9 4490.6 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#4] prototype.html Cycles:180 Average:4008.59 Median:4313.15 stddev:1160.30 (26.9%) stddev-sans-first:1129.01 09:33:45 INFO - PROCESS | 16456 | Values: 264.2 274.0 275.7 285.5 293.0 4629.7 4778.3 4837.2 4852.8 4864.8 4606.8 4707.4 4738.2 4750.8 4755.0 3559.2 3744.3 3758.2 3774.2 3776.5 3626.3 3685.4 3734.8 3754.0 3768.2 3722.9 3732.4 3740.1 3750.0 3767.4 3738.8 3755.5 3778.4 3783.6 3788.4 3270.9 3305.0 3310.5 3327.9 3336.9 4624.0 4637.7 4641.3 4645.8 4674.4 4279.8 4281.3 4283.1 4295.9 4298.9 4802.3 4983.4 4989.6 5005.3 5012.5 3544.9 3546.7 3548.8 3554.2 3554.9 5200.8 5225.1 5226.9 5226.9 5234.3 3516.4 3592.4 3609.6 3634.7 3635.5 3649.3 3650.5 3650.6 3659.4 3673.9 4175.7 4176.6 4194.0 4199.1 4200.3 4743.7 4892.4 5008.7 5014.5 5023.5 1210.0 1238.3 1239.2 1247.4 1250.0 779.6 798.1 819.6 825.4 825.5 3973.7 3984.3 3993.7 3998.8 4003.3 4527.0 4532.7 4533.6 4548.2 4569.9 3978.4 3993.6 3998.3 3999.4 4002.2 2276.0 2414.5 2421.8 2427.0 2433.7 4274.7 4292.8 4327.4 4342.7 4357.0 4591.3 4595.8 4603.5 4606.4 4613.7 4077.5 4137.6 4257.8 4271.6 4292.6 4469.4 4493.7 4494.5 4497.4 4510.0 4431.9 4442.2 4443.5 4450.3 4471.2 4263.3 4264.9 4272.0 4282.9 4496.6 3664.4 3741.5 3774.4 3774.7 3780.8 4938.8 5159.4 5170.6 5173.2 5194.2 4859.4 4939.2 5024.1 5027.4 5043.7 5039.0 5039.1 5040.6 5052.5 5052.9 4831.0 4968.4 4972.6 4979.5 4996.4 5006.2 5050.3 5053.4 5073.2 5074.8 4957.7 4971.2 4972.9 4976.6 4980.2 09:33:45 INFO - PROCESS | 16456 | 09:33:45 INFO - PROCESS | 16456 | [#5] yui.html Cycles:180 Average:17518.58 Median:480.42 stddev:25150.18 (5235.0%) stddev-sans-first:25188.72 09:33:45 INFO - PROCESS | 16456 | Values: 617.5 667.7 699.3 709.8 722.5 12946.7 13692.8 13706.6 13756.8 13763.2 12949.7 13095.5 13108.0 13121.7 13137.3 604.8 616.4 709.3 724.4 731.3 754.5 754.6 757.3 757.8 758.1 793.4 793.5 794.8 794.8 794.8 624.8 644.5 755.9 773.4 790.7 580.1 580.2 580.3 580.7 580.9 12430.7 12556.2 12579.3 12594.3 12647.9 11980.8 12384.5 12497.9 12715.9 12722.1 11297.0 11357.0 11526.7 11660.8 11842.5 3883.9 3893.7 3906.1 4072.1 4072.7 59967.0 60767.7 61190.4 61407.7 61824.4 9601.4 9697.8 9762.1 9876.2 9964.6 18137.5 18142.5 18172.6 18184.4 18184.6 6530.5 6589.7 6598.8 6686.9 6782.8 3190.7 3274.0 3339.8 3395.8 3425.0 2673.8 2751.8 2757.6 2766.8 2769.5 467.9 470.5 480.6 482.4 487.6 477.4 480.3 510.4 527.3 543.7 7131.4 7392.1 7458.0 7465.3 7499.6 511.4 512.3 529.3 534.6 538.3 3459.7 3515.9 3522.3 3546.8 3567.0 93898.5 96357.0 99775.5 99905.5 100708.5 81049.6 82196.2 82676.0 83304.0 84649.6 73855.0 75789.2 76237.0 76348.6 76482.6 6684.6 6758.1 6777.2 6798.3 7072.7 44213.6 45041.0 45247.5 45466.3 45854.3 41448.8 58263.1 60326.4 61508.4 65920.7 10789.2 10897.9 10931.6 11699.4 11774.6 11353.0 12536.2 13341.4 13668.4 13960.9 11263.5 11330.9 11342.0 11915.9 12089.1 11555.9 11795.6 12315.4 12494.6 12534.6 10892.3 11012.6 11203.3 11236.7 11813.4 9477.3 9710.6 9897.8 10070.5 10175.3 9983.9 9991.0 10028.7 10074.5 10097.5 09:33:45 INFO - PROCESS | 16456 | -------- Summary: end -------- 09:33:45 INFO - PROCESS | 16456 | 09:33:46 INFO - TEST-INFO | 16456: exit 0 09:33:46 INFO - TEST-OK | dromaeo_css | took 1121719ms 09:33:46 INFO - TEST-START | kraken 09:33:46 INFO - operating with platform_type : linux_ 09:33:46 INFO - Initialising browser for kraken test... 09:33:46 INFO - TEST-INFO | started process 16766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78GUOd/profile http://localhost:57337/getInfo.html) 09:33:50 INFO - PROCESS | 16766 | __metrics Screen width/height:1600/1200 09:33:50 INFO - PROCESS | 16766 | colorDepth:24 09:33:50 INFO - PROCESS | 16766 | Browser inner width/height: 1024/697 09:33:50 INFO - PROCESS | 16766 | __metrics 09:33:51 INFO - PROCESS | 16766 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:51 INFO - PROCESS | 16766 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:51 INFO - PROCESS | 16766 | console.error: PushService: 09:33:51 INFO - PROCESS | 16766 | stateChangeProcessEnqueue: Error transitioning state 09:33:51 INFO - PROCESS | 16766 | UnknownError 09:33:52 INFO - TEST-INFO | 16766: exit 0 09:33:52 INFO - Browser initialized. 09:33:52 INFO - Running cycle 1/1 for kraken test... 09:33:52 INFO - TEST-INFO | started process 16846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp78GUOd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:04 INFO - PROCESS | 16846 | RSS: Main: 178601984 09:34:04 INFO - PROCESS | 16846 | 09:34:07 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:08 INFO - PROCESS | 16846 | RSS: Main: 242565120 09:34:08 INFO - PROCESS | 16846 | 09:34:11 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-dft) 09:34:11 INFO - PROCESS | 16846 | RSS: Main: 218554368 09:34:11 INFO - PROCESS | 16846 | 09:34:15 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-fft) 09:34:15 INFO - PROCESS | 16846 | RSS: Main: 301043712 09:34:15 INFO - PROCESS | 16846 | 09:34:17 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57337/tests/kraken/driver.html?testName=audio-oscillator) 09:34:18 INFO - PROCESS | 16846 | RSS: Main: 212066304 09:34:18 INFO - PROCESS | 16846 | 09:34:20 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:21 INFO - PROCESS | 16846 | RSS: Main: 215052288 09:34:21 INFO - PROCESS | 16846 | 09:34:24 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:25 INFO - PROCESS | 16846 | RSS: Main: 251019264 09:34:25 INFO - PROCESS | 16846 | 09:34:28 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57337/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:29 INFO - PROCESS | 16846 | RSS: Main: 250417152 09:34:29 INFO - PROCESS | 16846 | 09:34:32 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57337/tests/kraken/driver.html?testName=json-parse-financial) 09:34:32 INFO - PROCESS | 16846 | RSS: Main: 249704448 09:34:32 INFO - PROCESS | 16846 | 09:34:34 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:35 INFO - PROCESS | 16846 | RSS: Main: 212107264 09:34:35 INFO - PROCESS | 16846 | 09:34:37 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:37 INFO - PROCESS | 16846 | RSS: Main: 219688960 09:34:37 INFO - PROCESS | 16846 | 09:34:39 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:40 INFO - PROCESS | 16846 | RSS: Main: 228589568 09:34:40 INFO - PROCESS | 16846 | 09:34:43 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:44 INFO - PROCESS | 16846 | RSS: Main: 236507136 09:34:44 INFO - PROCESS | 16846 | 09:34:47 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:47 INFO - PROCESS | 16846 | RSS: Main: 233398272 09:34:47 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:57337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57337/tests/kraken/driver.html?testName=ai-astar) 09:34:49 INFO - PROCESS | 16846 | RSS: Main: 283435008 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | __start_tp_report 09:34:49 INFO - PROCESS | 16846 | _x_x_mozilla_page_load 09:34:49 INFO - PROCESS | 16846 | _x_x_mozilla_page_load_details 09:34:49 INFO - PROCESS | 16846 | |i|pagename|runs| 09:34:49 INFO - PROCESS | 16846 | |0;ai-astar;113;116;115;114;115;114;115;115;114;115 09:34:49 INFO - PROCESS | 16846 | |1;audio-beat-detection;156;133;130;179;131;131;129;127;164;128 09:34:49 INFO - PROCESS | 16846 | |2;audio-dft;161;161;161;162;162;160;160;162;162;163 09:34:49 INFO - PROCESS | 16846 | |3;audio-fft;76;77;79;110;78;78;77;78;109;76 09:34:49 INFO - PROCESS | 16846 | |4;audio-oscillator;85;85;116;85;83;83;103;83;83;113 09:34:49 INFO - PROCESS | 16846 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;117 09:34:49 INFO - PROCESS | 16846 | |6;imaging-darkroom;147;148;146;146;147;147;146;145;146;146 09:34:49 INFO - PROCESS | 16846 | |7;imaging-desaturate;95;95;94;95;95;95;94;95;95;96 09:34:49 INFO - PROCESS | 16846 | |8;json-parse-financial;65;71;63;64;65;65;65;67;66;66 09:34:49 INFO - PROCESS | 16846 | |9;json-stringify-tinderbox;65;66;66;66;66;65;67;67;66;66 09:34:49 INFO - PROCESS | 16846 | |10;stanford-crypto-aes;83;84;89;87;83;84;88;83;92;84 09:34:49 INFO - PROCESS | 16846 | |11;stanford-crypto-ccm;140;144;147;140;138;137;141;139;180;142 09:34:49 INFO - PROCESS | 16846 | |12;stanford-crypto-pbkdf2;179;175;175;177;177;179;176;183;181;178 09:34:49 INFO - PROCESS | 16846 | |13;stanford-crypto-sha256-iterative;75;71;72;71;72;69;69;75;72;69 09:34:49 INFO - PROCESS | 16846 | __end_tp_report 09:34:49 INFO - PROCESS | 16846 | __start_cc_report 09:34:49 INFO - PROCESS | 16846 | _x_x_mozilla_cycle_collect,1945 09:34:49 INFO - PROCESS | 16846 | __end_cc_report 09:34:49 INFO - PROCESS | 16846 | __startTimestamp1475598889760__endTimestamp 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | ------- Summary: start ------- 09:34:49 INFO - PROCESS | 16846 | Number of tests: 14 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.84 (0.7%) stddev-sans-first:0.67 09:34:49 INFO - PROCESS | 16846 | Values: 113.0 116.0 115.0 114.0 115.0 114.0 115.0 115.0 114.0 115.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:132.00 stddev:18.53 (14.0%) stddev-sans-first:18.82 09:34:49 INFO - PROCESS | 16846 | Values: 156.0 133.0 130.0 179.0 131.0 131.0 129.0 127.0 164.0 128.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:34:49 INFO - PROCESS | 16846 | Values: 161.0 161.0 161.0 162.0 162.0 160.0 160.0 162.0 162.0 163.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.50 stddev:13.58 (17.5%) stddev-sans-first:14.11 09:34:49 INFO - PROCESS | 16846 | Values: 76.0 77.0 79.0 110.0 78.0 78.0 77.0 78.0 109.0 76.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:13.37 (16.1%) stddev-sans-first:13.95 09:34:49 INFO - PROCESS | 16846 | Values: 85.0 85.0 116.0 85.0 83.0 83.0 103.0 83.0 83.0 113.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:34:49 INFO - PROCESS | 16846 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 09:34:49 INFO - PROCESS | 16846 | Values: 147.0 148.0 146.0 146.0 147.0 147.0 146.0 145.0 146.0 146.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:34:49 INFO - PROCESS | 16846 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.50 stddev:2.16 (3.3%) stddev-sans-first:2.28 09:34:49 INFO - PROCESS | 16846 | Values: 65.0 71.0 63.0 64.0 65.0 65.0 65.0 67.0 66.0 66.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 09:34:49 INFO - PROCESS | 16846 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 67.0 67.0 66.0 66.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.13 (3.7%) stddev-sans-first:3.16 09:34:49 INFO - PROCESS | 16846 | Values: 83.0 84.0 89.0 87.0 83.0 84.0 88.0 83.0 92.0 84.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:141.50 stddev:12.71 (9.0%) stddev-sans-first:13.36 09:34:49 INFO - PROCESS | 16846 | Values: 140.0 144.0 147.0 140.0 138.0 137.0 141.0 139.0 180.0 142.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:178.50 stddev:2.58 (1.4%) stddev-sans-first:2.71 09:34:49 INFO - PROCESS | 16846 | Values: 179.0 175.0 175.0 177.0 177.0 179.0 176.0 183.0 181.0 178.0 09:34:49 INFO - PROCESS | 16846 | 09:34:49 INFO - PROCESS | 16846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:2.22 (3.1%) stddev-sans-first:1.96 09:34:49 INFO - PROCESS | 16846 | Values: 75.0 71.0 72.0 71.0 72.0 69.0 69.0 75.0 72.0 69.0 09:34:49 INFO - PROCESS | 16846 | -------- Summary: end -------- 09:34:49 INFO - PROCESS | 16846 | 09:34:51 INFO - TEST-INFO | 16846: exit 0 09:34:51 INFO - TEST-OK | kraken | took 64797ms 09:34:51 INFO - SUITE-END | took 1186s 09:34:51 INFO - Completed test suite (00:19:46) 09:34:51 INFO - javascript benchmark 09:34:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2504.4365017870978, 2524.3310522711495, 2552.6171074338854, 2559.2578152335814, 2578.9484210315795, 4414.29371300592, 4474.0380818124095, 4585.816567337307, 4590.655700822435, 4596.28757542581, 4502.077074199789, 4548.226801443754, 4592.380028696125, 4617.330487079372, 4667.043256132493, 4152.231837110145, 4189.392538081992, 4237.70336076474, 4258.361245813122, 4262.72292301001, 4203.138356636882, 4211.557786432427, 4218.831246750126, 4244.702870799046, 4274.893127671802, 4233.618974292313, 4245.10852720929, 4285.035866929947, 4302.677299202556, 4304.827806887721, 4111.60939710727, 4147.357159640261, 4154.335306350969, 4201.642860356873, 4210.810513526899, 4118.814653340577, 4139.130782535671, 4165.0, 4171.353440216772, 4180.91638167238, 4479.910401791946, 4493.303537951622, 4525.570070843265, 4564.794584243684, 4589.128065667513, 4816.759162041919, 4845.491223421525, 4849.539293767087, 4850.83022094225, 4904.337914381585, 4693.788779504896, 4747.311639812242, 4879.121758083544, 4893.04585605807, 4960.007998400334, 4514.729116253068, 4517.938284503205, 4540.5913467787395, 4552.0, 4583.312503124492, 4919.2867034279825, 4947.925781113287, 4957.90084198314, 4962.851114466572, 5020.422651395063, 4632.2356811126465, 4766.856994290177, 4775.785089670973, 4776.761161941889, 4838.056578967138, 4735.384400028043, 4774.522547745267, 4823.614110871122, 4825.252085926687, 4909.484504127086, 4792.305115758196, 4794.904101917942, 4803.135435621622, 4850.490698476609, 4854.757262136879, 4759.452662943737, 4762.333273341735, 4776.450708168605, 4777.593904518086, 4829.058333624909, 4073.714839961174, 4113.732607380571, 4120.443740095049, 4128.298189307825, 4151.315033019579, 3624.7100231981904, 3627.582827974764, 3662.4689420033947, 3668.596454390015, 3712.0348709335226, 4197.118605092965, 4205.747655140702, 4206.8737937861915, 4245.8513952012145, 4262.360645903139, 4727.314539391838, 4801.879953001203, 4815.855524334275, 4841.370621819141, 4848.684835485682, 4189.601987811153, 4231.132617813341, 4258.787060646955, 4268.0823622921225, 4272.658187345005, 4414.4702635683925, 4421.137878113737, 4430.158269928703, 4479.843205487792, 4482.081173359454, 4494.528074552256, 4552.339910712994, 4610.700304480198, 4613.492515823324, 4613.677042606985, 4805.231163013901, 4858.222684370484, 4860.1008813369635, 4867.318575399518, 4901.117798796251, 4567.954320456753, 4590.05903789729, 4596.379488768974, 4599.333096700892, 4654.86035418938, 4720.386349774507, 4768.022555376209, 4781.115493633689, 4785.736784476748, 4801.807927682854, 4805.063012712488, 4838.95161048385, 4839.612830973443, 4854.320395144753, 4920.45874953762, 4719.976400117977, 4727.834525791581, 4732.053589282226, 4733.5266473352385, 4782.497837726988, 4617.79219935097, 4726.669133160645, 4737.549932756383, 4743.644226683082, 4789.7605119743175, 4577.56513131252, 4610.193216187221, 4628.236341003697, 4632.02727427244, 4699.718016918996, 4737.194676905004, 4737.620990320697, 4742.264948932921, 4746.905061898812, 4799.448063472745, 4528.841490547815, 4651.186042442627, 4652.371929789435, 4657.976710116428, 4712.740799256074], "value": 4463.900009749936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4999875113024, 553.1951011278587, 553.3581045986656, 570.0110308614553, 570.6319423971538, 28006.71993280069, 30451.0, 30480.69519304809, 37810.0, 39239.80380098095, 39397.212055758864, 39794.403083953766, 39800.40299395504, 39831.0, 39836.203275934466, 7443.478956473049, 7588.089429268495, 7591.5445073295505, 7592.658330375147, 7592.696292148307, 7195.172555156146, 7395.519291246079, 9495.335326527145, 9689.370190937567, 9691.612335506607, 9829.508524573743, 9871.457069861155, 9903.25725570585, 9911.207103431709, 9928.205743540535, 9733.853992190123, 9768.804623907554, 9784.951075244613, 9819.919808821023, 9840.852387214198, 9612.89451713055, 9745.756356091084, 9770.071843174886, 9784.706458806248, 9785.119339259501, 35951.0, 36101.638983610355, 36179.0, 36181.0, 36184.63815361865, 2762.958555621667, 2787.080263513036, 2811.2550174203852, 2870.942581148386, 3092.041467145192, 26329.868350658315, 26714.5992810108, 26903.32741681454, 27450.5882411764, 27792.444151117066, 3242.789218700777, 3299.7195238404765, 3385.8814941477176, 3404.5233667286598, 3410.5225268462436, 246128.0, 248322.0, 248839.0, 248947.0, 249013.0, 52567.0, 53012.469875300754, 53037.469625304024, 53098.73450632722, 53117.0, 31374.86251374844, 32625.0, 32655.183620409203, 34249.48625770616, 50072.0, 14499.637509062359, 14940.32768525419, 14962.326695298738, 14982.026168299026, 14991.625209369635, 8477.364197685198, 10643.893561064446, 10647.84028239577, 10653.57385704563, 10654.254202205771, 14836.480723174853, 16789.0, 17335.91332043357, 17516.824831751775, 18238.90880545589, 6741.730330786713, 6824.0, 6835.658217089126, 6845.14435695538, 6954.860902781916, 772.9652165652559, 888.0542222532981, 910.9842525583927, 937.9062093790567, 946.9583458196067, 26000.86999565028, 27180.864095679393, 27811.0, 27867.860660696566, 27873.721262787112, 897.9955100224588, 913.9771505712278, 921.6267411698273, 982.5283863745442, 1014.8173328800887, 13555.59333220005, 14391.424343026161, 14825.0, 14846.851531484763, 15552.74404518787, 373270.0, 375749.0, 376298.0, 376542.0, 377052.0, 47635.0, 48076.0, 48085.0, 48103.278450823265, 48147.277790832464, 1187.5427960235372, 1193.3138445393934, 1209.1354681402838, 1214.1622280626339, 1219.664592237142, 26000.739992599832, 27257.591136132578, 27512.449751005268, 27716.722832772222, 28040.579391309555, 40516.594834051284, 41150.176996459304, 41158.0, 41188.0, 41195.0, 257393.0, 257604.0, 258072.0, 258539.0, 311995.0, 20943.685844712036, 21712.457188570414, 23570.0, 24545.87727061353, 24557.0, 37522.437163442024, 38817.6118238814, 38907.0, 42481.0, 42990.57009429991, 33603.66396336005, 33737.83131084329, 34100.488492673125, 34101.82949085239, 34134.781239219374, 33572.496412553344, 34043.31913361768, 34126.31747364989, 34226.144346390545, 34674.65325346714, 32318.35363292768, 33723.66276337205, 33815.49276760801, 34036.48945265872, 34126.488102677984, 28919.566206506497, 30951.0, 31075.75696972096, 31232.843835780677, 31298.843505782326, 24213.394665133514, 24316.27051188467, 24472.0, 24647.260582182564, 24680.13619523308], "value": 17041.664856688967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.32703257002254, 349.55780937114537, 360.2524761120674, 361.8299399282336, 362.88931875777894, 11983.460744266507, 15417.768733468993, 16224.432144874901, 16229.107399093045, 17359.39242126526, 16101.758473622906, 16167.43413980511, 16845.0, 16970.23633936473, 16990.915045424787, 4766.285057241407, 4807.375041244651, 4943.728094954785, 5183.766730497118, 5184.948150518503, 4953.6037117030555, 5074.086664400406, 5079.212722028073, 5079.669821461612, 5086.364204474441, 4874.439439464454, 5039.521245481674, 5042.546170844642, 5048.419431765339, 5050.393952725678, 5033.974830125844, 5104.846854594368, 5105.438401775802, 5109.872253193663, 5112.923306150411, 4358.564143585648, 4578.473475550321, 4581.954180458186, 4582.358469814195, 4584.770761461914, 19892.403227903185, 20052.899735501374, 20062.498437539034, 20200.585958982876, 20228.393148205578, 1686.949391518244, 1793.4978206102312, 1824.4800231933834, 1862.832345088935, 2364.633481810305, 12314.938425307906, 12869.163504372185, 13335.466581336736, 13410.46358145673, 13529.458821647122, 1542.4755583101687, 1604.4143887480986, 1613.2337139858591, 1647.0776365235386, 1703.7018521758766, 67168.9999999995, 67170.66414667896, 67237.0, 67682.3231767681, 68135.65932170357, 8150.307223886036, 8306.958465207636, 8337.166283371615, 9616.75958101053, 9647.855282170773, 13077.607671769862, 13189.934050329879, 13190.076694631476, 13190.802137967747, 13199.340032998503, 7224.349808517153, 7390.926090739132, 7444.516106453063, 7448.553086814808, 7575.5454672718715, 7054.541454805421, 7074.115735533059, 7182.209956904736, 7304.671289791972, 7318.3047610476915, 5900.321463031806, 5920.0, 5942.108683697394, 6062.484688801413, 6070.362611925772, 1615.8061032675919, 1705.2326453096157, 1763.4621440460783, 1773.361589827661, 1778.2442461953617, 649.6297110646981, 816.2775943290112, 821.6713314674179, 839.8908141941508, 875.0986483921571, 16885.662286754443, 17066.658666826595, 17187.828121718623, 17452.47642570725, 17925.28298868031, 874.9387542871938, 881.2421317666801, 904.4166512599337, 911.7811725186041, 921.6221349246777, 9206.410772803487, 9858.359206651545, 9987.951265117059, 9988.800223995479, 10105.736782902137, 370373.0, 371723.0, 376258.0, 379029.0, 379818.0, 66121.33878661152, 68206.0, 68591.65704171547, 68795.0, 69711.0, 853.1425916953422, 860.0926023045622, 873.7116751472126, 876.5967654878827, 877.1360210192955, 15226.0, 15350.309236084626, 15672.686546269239, 15891.523254302389, 15955.122468264357, 34653.0, 34841.47737783885, 35042.09410682455, 35418.11454713653, 36214.45678314775, 50457.0, 51673.48326516687, 52001.7399912998, 53902.73048634732, 54396.0, 7241.384482319062, 7544.585047822203, 7739.490799294083, 7847.254510821463, 7940.325072368682, 8547.57262136903, 11401.429928503376, 11515.8272625909, 11521.596744113916, 12223.572174973833, 5273.471585781148, 9458.013817098212, 10094.394336339843, 10318.277720559488, 10370.325928814604, 9681.903180968382, 10246.897531024595, 10362.481875906326, 10389.220808439548, 10542.947285263524, 10050.346727462691, 10324.48377581133, 10399.128156931825, 10665.46672666348, 10723.678289651323, 7287.635618218962, 7396.889046664197, 7479.850402992019, 7553.4712570121765, 7750.294935114266, 9428.434293942386, 10141.746456338651, 10237.18102551809, 10289.3311934724, 10894.182936279652], "value": 8079.192910978365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.1568480487686, 1317.9736405271894, 1337.7391408675305, 1608.329663042564, 1664.8418400251971, 6593.802185934418, 6883.827904302395, 6937.653117344132, 7485.588292643909, 7516.3235308822195, 7142.8571428571395, 7417.184109747924, 7420.628968551578, 7628.199039100898, 7630.198829122932, 1947.6202140582627, 1978.8021197880241, 1987.4137129546818, 1988.413418041674, 1990.3829812758092, 1708.2654458582804, 1760.3398725477946, 1900.3158862809446, 1948.3278268997174, 1957.5693347463607, 1911.2068491575978, 1983.0976905508032, 1988.3438465306415, 2000.5298754792611, 2001.6997450382487, 1941.5728539721238, 1955.6675365187882, 1961.8626696131205, 1964.0866996846391, 1972.5068732816796, 1949.220311875247, 1993.7906519815356, 1998.9100490477963, 2001.0495014867968, 2001.909914053871, 7647.694092236359, 7708.884366734504, 7712.035995500562, 7716.729914452967, 7724.266194711493, 4225.323948168279, 4340.175366680321, 4344.978275108636, 4345.50026746925, 4348.869533913956, 2620.344913771557, 2788.177487641151, 2793.9301517462227, 2796.622455968459, 2798.0906205483298, 785.2461636828651, 835.1231207232443, 848.0417128644654, 848.2789628815519, 860.9784755381103, 9876.40741555509, 9906.216880961423, 9914.45470499115, 9920.603175872957, 9942.502874856229, 3587.3812117154102, 3723.795191264452, 3869.7678139311734, 3878.7672739635714, 3883.10688541637, 8582.570871456526, 8582.699605513777, 8583.65665373378, 8638.13618638131, 8639.222469977733, 4347.978260108743, 4390.143921935192, 4394.231009573376, 4403.141387429485, 4414.977925110354, 3964.623360780721, 3991.980040099781, 4006.4390985262085, 4007.8797636070963, 4015.4980627421573, 3182.7612929030415, 3313.1551454378978, 3319.850606722703, 3365.9663403365653, 3391.7117045050954, 898.8921329440509, 911.1799380557419, 1003.9698809035741, 1014.3964341216964, 1018.5467466977124, 626.37675512865, 693.7537174303151, 762.7673559564275, 765.3303359560384, 796.2952786783738, 4528.864134075983, 4670.112678591125, 4730.787114579852, 4766.856994290108, 4838.879028024327, 763.9388848892075, 765.0666187251544, 774.5585016540631, 825.3026192867018, 845.1252953193415, 3084.352286019961, 3196.7922085064397, 3227.5320078588943, 3232.046546268856, 3235.433799085151, 8428.0, 8499.575021248913, 8777.561121943878, 8790.120987901159, 8899.73300800977, 8930.598123084477, 8933.776655583533, 8934.28525717941, 8943.865842012376, 8944.418612790278, 6850.862982740317, 7035.085438893014, 7040.542364746275, 7067.469939754539, 7073.434125269966, 4753.524647535219, 4970.353853998957, 4996.150654388835, 5120.820771272987, 5151.793928242978, 8094.392920530866, 8316.251537361666, 8342.541160236246, 8440.51004953528, 8442.282405995558, 8226.177382261725, 8508.191721786421, 8542.701005464778, 8601.526916019679, 8606.913930860612, 6204.689765511796, 6317.30509643948, 6359.841003974938, 6369.20384951881, 6374.107624932421, 6797.150356205474, 6903.0680858083515, 6904.896426553505, 6909.378155965987, 6911.965440172767, 6102.4812890902995, 6152.446279834658, 6179.969100154471, 6254.437100660963, 6462.903056454063, 6072.240969878765, 6189.597676151036, 6223.96888015557, 6249.250089989048, 6255.374462553708, 6050.21347224858, 6162.352952940056, 6168.42705110194, 6171.352008039091, 6173.382661733791, 4224.366345048267, 4243.490781106164, 4291.249031419551, 4327.091310824636, 4407.603315701603, 4235.576442355739, 4403.691741578187, 4475.194464996332, 4489.855086952806, 4490.57339552742], "value": 3830.705767518071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.23899170389274, 274.0449533376185, 275.6815877661302, 285.53030265213727, 292.96045033920416, 4629.652776041802, 4778.283257511366, 4837.153498137825, 4852.830150944717, 4864.83244021435, 4606.769661516919, 4707.411573553306, 4738.170820106477, 4750.809967601301, 4755.0, 3559.1635965548076, 3744.2511497700434, 3758.1732018955786, 3774.2074164425503, 3776.4705294355695, 3626.2747450509873, 3685.4287585424304, 3734.8319325630277, 3753.9968025579565, 3768.152165762709, 3722.88831335059, 3732.4401339798974, 3740.1397678533817, 3750.0437388465903, 3767.3783825668734, 3738.840959302625, 3755.530558680165, 3778.4143457763953, 3783.6405541473514, 3788.3559794834946, 3270.9018729438153, 3304.983475082633, 3310.5034244863223, 3327.8835240766457, 3336.8665253389836, 4624.011674979757, 4637.652176086774, 4641.3270075839155, 4645.7909394077005, 4674.368960190399, 4279.8074086665865, 4281.272183728743, 4283.1433713257165, 4295.926018495376, 4298.892527686801, 4802.327674125625, 4983.405310300705, 4989.600831933437, 5005.273180752634, 5012.498750124995, 3544.85820567177, 3546.6985306249, 3548.7515873888838, 3554.2180720241504, 3554.91112722184, 5200.843974680728, 5225.137852254412, 5226.8693282667855, 5226.876221612371, 5234.293370394986, 3516.4373700207843, 3592.407252803258, 3609.639036096369, 3634.727395445352, 3635.5092062571744, 3649.2883887641656, 3650.452432135201, 3650.580183278957, 3659.396199627032, 3673.9081522961606, 4175.707700460938, 4176.58234176586, 4194.0, 4199.139176468817, 4200.319872051143, 4743.691660042086, 4892.3884514435695, 5008.69947803133, 5014.52362025607, 5023.522765337287, 1210.0336952452265, 1238.2694210415898, 1239.1635645938954, 1247.3950134184913, 1249.993750031244, 779.5772714795521, 798.0582912163702, 819.6229734322278, 825.3850881093624, 825.451075035095, 3973.7218394712672, 3984.30274701926, 3993.660538854172, 3998.800059997047, 4003.298598095798, 4526.95473045272, 4532.682712210114, 4533.569310915458, 4548.226801443696, 4569.885752856205, 3978.4430179774854, 3993.600639935983, 3998.28030954431, 3999.4000899865255, 4002.239574480839, 2276.0052934966243, 2414.541237164968, 2421.757824217564, 2427.041318679147, 2433.683621129242, 4274.700770946004, 4292.849750258789, 4327.398862420861, 4342.739435633809, 4356.956430435655, 4591.334256532851, 4595.770211489412, 4603.49361570227, 4606.3743666109995, 4613.677042606985, 4077.531083925327, 4137.606927341898, 4257.765822879772, 4271.615554600101, 4292.635126014324, 4469.351943968171, 4493.707908985905, 4494.528074552256, 4497.415336006298, 4510.007798284372, 4431.933520997123, 4442.155990361821, 4443.466783985813, 4450.265706158448, 4471.239889218776, 4263.317869140923, 4264.87205383839, 4271.9786401067795, 4282.865040764138, 4496.550344965477, 3664.37705590045, 3741.4948981888188, 3774.358359079018, 3774.679152272088, 3780.8109594520715, 4938.75306234694, 5159.374796938952, 5170.6380553360905, 5173.249878767482, 5194.168932970707, 4859.3682821233015, 4939.209726443752, 5024.120778863611, 5027.371578552681, 5043.722595257296, 5039.0, 5039.0929632666475, 5040.571551418024, 5052.494750524918, 5052.9494705052475, 4830.975845120752, 4968.403791545038, 4972.552470277692, 4979.452260251442, 4996.400431948189, 5006.199008158677, 5050.3182070420025, 5053.393592768891, 5073.188289873602, 5074.771635276347, 4957.652964292465, 4971.179755340473, 4972.9254061188385, 4976.552110310089, 4980.203167493184], "value": 3636.1613288045864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.5056363600087, 667.7095463473387, 699.3041923286331, 709.8225443639091, 722.5195245161967, 12946.676333091666, 13692.794608080862, 13706.588802335946, 13756.793648095287, 13763.243021633805, 12949.74100517989, 13095.47618095275, 13108.0, 13121.67195820105, 13137.27744974026, 604.8336707405455, 616.3866952382364, 709.3367701199395, 724.380654540367, 731.297953964195, 754.4680999895061, 754.641545265997, 757.2843662738715, 757.7537300377372, 758.0713625808396, 793.3811626931004, 793.4921650143913, 794.8211652378227, 794.8489786940463, 794.8489786940492, 624.7844493649684, 644.5423749138071, 755.8526087412956, 773.3967505345782, 790.7192946503966, 580.1153241306998, 580.2485780913685, 580.2630659063009, 580.7299605683378, 580.9302883653946, 12430.689232769162, 12556.246625202517, 12579.308138052404, 12594.307313097775, 12647.936760316139, 11980.760384792342, 12384.504619815196, 12497.93751031248, 12715.87284127156, 12722.07392299767, 11297.0, 11357.0, 11526.654200373918, 11660.76678466426, 11842.526298948032, 3883.902902427462, 3893.7274390792654, 3906.101596632762, 4072.1448495815916, 4072.694547908889, 59967.0, 60767.69616151891, 61190.38809611891, 61407.69296153491, 61824.38175618276, 9601.37591056579, 9697.787776527934, 9762.121409073075, 9876.160526355341, 9964.601415943425, 18137.455876323467, 18142.5464363392, 18172.63654726898, 18184.36354727578, 18184.636307274046, 6530.542861999709, 6589.736410543621, 6598.769043083565, 6686.933130668728, 6782.8304292392095, 3190.744740420761, 3273.9836300818342, 3339.7662163648797, 3395.7792743471596, 3424.9845811033642, 2673.8395696258285, 2751.821131626438, 2757.6139340492346, 2766.8478233696937, 2769.473799978038, 467.9321498382715, 470.5153691697557, 480.5602873370826, 482.39218584583676, 487.6220928780153, 477.4366247827597, 480.28677414040123, 510.39008384979593, 527.3223907279128, 543.741722681731, 7131.393831524275, 7392.112946446353, 7458.0, 7465.328120469184, 7499.6250187490405, 511.4297558222555, 512.272572946417, 529.2854646227562, 534.6150771444553, 538.2590992601436, 3459.6540345965204, 3515.9296814063578, 3522.2955408917805, 3546.840392182358, 3567.0, 93898.53050734839, 96357.0, 99775.50112249538, 99905.50047249862, 100708.49645751725, 81049.59475202704, 82196.17803822005, 82676.0, 83304.0, 84649.57675211584, 73855.0, 75789.24210757822, 76237.0, 76348.61825690947, 76482.61758691171, 6684.565503242274, 6758.121444212417, 6777.186737591323, 6798.286179951034, 7072.68172932209, 44213.557864420945, 45041.0, 45247.547524524336, 45466.31800522929, 45854.31218531658, 41448.792756036026, 58263.12605310839, 60326.396736032075, 61508.384916150266, 65920.6703966477, 10789.244752867538, 10897.891021090005, 10931.617393391192, 11699.356535390294, 11774.587889423829, 11353.0, 12536.185147965352, 13341.399637016164, 13668.384922678304, 13960.860391395956, 11263.549458021587, 11330.94334528322, 11342.0, 11915.880841191478, 12089.093318001362, 11555.942220289182, 11795.587154449553, 12315.384230788246, 12494.625161244814, 12534.561290354794, 10892.346459212473, 11012.559497620327, 11203.271787333797, 11236.66290011301, 11813.350265735467, 9477.336586439158, 9710.641007781429, 9897.752556186153, 10070.546825392728, 10175.28772985884, 9983.900160998297, 9990.950045250018, 10028.749281268027, 10074.496275186359, 10097.495125243562], "value": 6352.4466796572515, "unit": "score"}], "name": "dromaeo_css", "value": 6155.3388104399955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 130.0, 179.0, 131.0, 131.0, 129.0, 127.0, 164.0, 128.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 160.0, 160.0, 162.0, 162.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 110.0, 78.0, 78.0, 77.0, 78.0, 109.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 83.0, 83.0, 103.0, 83.0, 83.0, 113.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 63.0, 64.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 89.0, 87.0, 83.0, 84.0, 88.0, 83.0, 92.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 147.0, 140.0, 138.0, 137.0, 141.0, 139.0, 180.0, 142.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 175.0, 177.0, 177.0, 179.0, 176.0, 183.0, 181.0, 178.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 71.0, 72.0, 71.0, 72.0, 69.0, 69.0, 75.0, 72.0, 69.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1562.7, "alertThreshold": 2.0}]} 09:34:51 INFO - Return code: 0 09:34:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:51 INFO - # TBPL SUCCESS # 09:34:51 INFO - Running post-action listener: _resource_record_post_action 09:34:51 INFO - [mozharness: 2016-10-04 16:34:51.571071Z] Finished run-tests step (success) 09:34:51 INFO - Running post-run listener: _resource_record_post_run 09:34:51 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408162304; Read time: 8; Write time: 285936 09:34:51 INFO - TinderboxPrint: CPU usage
13.1% 09:34:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:34:51 INFO - TinderboxPrint: I/O write bytes / time
408,162,304 / 285,936 09:34:51 INFO - TinderboxPrint: CPU idle
8,341.9 (86.9%) 09:34:51 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 09:34:51 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99991552; Read time: 0; Write time: 83380 09:34:51 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291561472; Read time: 0; Write time: 196052 09:34:52 INFO - Running post-run listener: _upload_blobber_files 09:34:52 INFO - Blob upload gear active. 09:34:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:52 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 09:34:52 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:34:52 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:34:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:34:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:34:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:53 INFO - (blobuploader) - INFO - Done attempting. 09:34:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:34:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:54 INFO - (blobuploader) - INFO - Done attempting. 09:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:57 INFO - (blobuploader) - INFO - Done attempting. 09:34:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:57 INFO - Return code: 0 09:34:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/37b6049950293b1b63a1ce369a1afc844673eb4824cee6aaf323b1e7082cb3154a121b562e2b77ad801396662fbae1725aa9fb74190fdfcff2f09ce01d22a20a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fed9b4d1c38df1aa02bc59a68261da41455ed9d2853cac99f781f7093c4eff92c6fc513b2fa0e3955ab594cc9fe12564d270d0398f9c4db792b4bfa15bab402a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8052a5412cf6f7f6cd13e2e6f535aa9775260c4b197694216f10091cdaa3e2118e43722e91dc6762febbdb954865497d3fe57faeb95d3111dc488c87554accf9"} 09:34:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:57 INFO - Contents: 09:34:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/37b6049950293b1b63a1ce369a1afc844673eb4824cee6aaf323b1e7082cb3154a121b562e2b77ad801396662fbae1725aa9fb74190fdfcff2f09ce01d22a20a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fed9b4d1c38df1aa02bc59a68261da41455ed9d2853cac99f781f7093c4eff92c6fc513b2fa0e3955ab594cc9fe12564d270d0398f9c4db792b4bfa15bab402a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8052a5412cf6f7f6cd13e2e6f535aa9775260c4b197694216f10091cdaa3e2118e43722e91dc6762febbdb954865497d3fe57faeb95d3111dc488c87554accf9"} 09:34:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:57 INFO - Copying logs to upload dir... 09:34:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.977790 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-04 09:34:57.003933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:34:57.007239) ========= 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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/37b6049950293b1b63a1ce369a1afc844673eb4824cee6aaf323b1e7082cb3154a121b562e2b77ad801396662fbae1725aa9fb74190fdfcff2f09ce01d22a20a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fed9b4d1c38df1aa02bc59a68261da41455ed9d2853cac99f781f7093c4eff92c6fc513b2fa0e3955ab594cc9fe12564d270d0398f9c4db792b4bfa15bab402a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8052a5412cf6f7f6cd13e2e6f535aa9775260c4b197694216f10091cdaa3e2118e43722e91dc6762febbdb954865497d3fe57faeb95d3111dc488c87554accf9"} build_url:https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/X4gvdNTsSw6DVdH8arQW6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/37b6049950293b1b63a1ce369a1afc844673eb4824cee6aaf323b1e7082cb3154a121b562e2b77ad801396662fbae1725aa9fb74190fdfcff2f09ce01d22a20a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fed9b4d1c38df1aa02bc59a68261da41455ed9d2853cac99f781f7093c4eff92c6fc513b2fa0e3955ab594cc9fe12564d270d0398f9c4db792b4bfa15bab402a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8052a5412cf6f7f6cd13e2e6f535aa9775260c4b197694216f10091cdaa3e2118e43722e91dc6762febbdb954865497d3fe57faeb95d3111dc488c87554accf9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:34:57.032973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:34:57.033322) ========= 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=652eb03db935cfc1c15ebda0000001ad-1475597365.217101-232599609 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:34:57.116980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:34:57.117387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:34:57.118200) ========= ========= Total master_lag: 0.18 =========