builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1475292358.68 results: success (0) buildid: 20160930153002 builduid: a9986f52e76f44238df4b55372e17ed1 revision: ac89a649cbb96c6e50446b0df901e9d7d8963f24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.681780) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.682333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.682671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.737020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.737366) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 20:25:59-- 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% 111M=0s 2016-09-30 20:25:59 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.890423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.890740) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018460 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.952764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:58.953543) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ac89a649cbb96c6e50446b0df901e9d7d8963f24 --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 ac89a649cbb96c6e50446b0df901e9d7d8963f24 --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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 20:25:59,750 truncating revision to first 12 chars 2016-09-30 20:25:59,750 Setting DEBUG logging. 2016-09-30 20:25:59,750 attempt 1/10 2016-09-30 20:25:59,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ac89a649cbb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 20:26:00,043 unpacking tar archive at: autoland-ac89a649cbb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661515 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:59.648939) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:59.649274) ========= script_repo_revision: ac89a649cbb96c6e50446b0df901e9d7d8963f24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:59.649679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:59.649984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 20:25:59.662234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 20:25:59.662552) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:26:00 INFO - MultiFileLogger online at 20160930 20:26:00 in /builds/slave/test 20:26:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:26:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:26:00 INFO - {'append_to_log': False, 20:26:00 INFO - 'base_work_dir': '/builds/slave/test', 20:26:00 INFO - 'blob_upload_branch': 'Autoland', 20:26:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:26:00 INFO - 'branch': 'Autoland', 20:26:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:26:00 INFO - 'config_files': ('talos/linux_config.py',), 20:26:00 INFO - 'default_actions': ('clobber', 20:26:00 INFO - 'read-buildbot-config', 20:26:00 INFO - 'download-and-extract', 20:26:00 INFO - 'populate-webroot', 20:26:00 INFO - 'create-virtualenv', 20:26:00 INFO - 'install', 20:26:00 INFO - 'run-tests'), 20:26:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:26:00 INFO - 'download_minidump_stackwalk': True, 20:26:00 INFO - 'download_symbols': 'ondemand', 20:26:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:26:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:26:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:26:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:26:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:26:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:26:00 INFO - 'installer_path': 'installer.exe', 20:26:00 INFO - 'log_level': 'info', 20:26:00 INFO - 'log_name': 'talos', 20:26:00 INFO - 'log_to_console': True, 20:26:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:26:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:26:00 INFO - 'opt_config_files': (), 20:26:00 INFO - 'pip_index': False, 20:26:00 INFO - 'sps_profile': False, 20:26:00 INFO - 'sps_profile_interval': 0, 20:26:00 INFO - 'suite': 'dromaeojs', 20:26:00 INFO - 'system_bits': '32', 20:26:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:26:00 INFO - 'title': 'talos-linux64-ix-060', 20:26:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:26:00 INFO - 'use_talos_json': True, 20:26:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:26:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:26:00 INFO - 'work_dir': 'build'} 20:26:00 INFO - [mozharness: 2016-10-01 03:26:00.558817Z] Running clobber step. 20:26:00 INFO - Running pre-action listener: _resource_record_pre_action 20:26:00 INFO - Running main action method: clobber 20:26:00 INFO - rmtree: /builds/slave/test/build 20:26:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:26:01 INFO - Running post-action listener: _resource_record_post_action 20:26:01 INFO - [mozharness: 2016-10-01 03:26:01.557855Z] Finished clobber step (success) 20:26:01 INFO - [mozharness: 2016-10-01 03:26:01.557957Z] Running read-buildbot-config step. 20:26:01 INFO - Running pre-action listener: _resource_record_pre_action 20:26:01 INFO - Running main action method: read_buildbot_config 20:26:01 INFO - Using buildbot properties: 20:26:01 INFO - { 20:26:01 INFO - "project": "", 20:26:01 INFO - "product": "firefox", 20:26:01 INFO - "script_repo_revision": "production", 20:26:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 20:26:01 INFO - "repository": "", 20:26:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 20:26:01 INFO - "buildid": "20160930153002", 20:26:01 INFO - "pgo_build": "True", 20:26:01 INFO - "basedir": "/builds/slave/test", 20:26:01 INFO - "buildnumber": 298, 20:26:01 INFO - "slavename": "talos-linux64-ix-060", 20:26:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:26:01 INFO - "platform": "ubuntu64_hw", 20:26:01 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 20:26:01 INFO - "branch": "autoland", 20:26:01 INFO - "repo_path": "integration/autoland", 20:26:01 INFO - "revision": "ac89a649cbb96c6e50446b0df901e9d7d8963f24", 20:26:01 INFO - "stage_platform": "linux64-pgo", 20:26:01 INFO - "builduid": "a9986f52e76f44238df4b55372e17ed1", 20:26:01 INFO - "slavebuilddir": "test" 20:26:01 INFO - } 20:26:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:26:01 INFO - Running post-action listener: _resource_record_post_action 20:26:01 INFO - [mozharness: 2016-10-01 03:26:01.560386Z] Finished read-buildbot-config step (success) 20:26:01 INFO - [mozharness: 2016-10-01 03:26:01.560475Z] Running download-and-extract step. 20:26:01 INFO - Running pre-action listener: _resource_record_pre_action 20:26:01 INFO - Running main action method: download_and_extract 20:26:01 INFO - mkdir: /builds/slave/test/build/tests 20:26:01 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')]} 20:26:01 INFO - trying https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/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 20:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/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 20:26:02 INFO - Downloaded 1361 bytes. 20:26:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:26:02 INFO - Using the following test package requirements: 20:26:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:26:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:26:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:26:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'jsshell-linux-x86_64.zip'], 20:26:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:26:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:26:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:26:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:26:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:26:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:26:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:26:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:26:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:26:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:26:02 INFO - Http code: 200 20:26:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 20:26:02 INFO - x-amz-cf-id: Rp9_I8KJj2NGUUzvswURAvhu80uQdnqognwMgU9T5pUNuT7cAnwWDA== 20:26:02 INFO - x-amz-version-id: .4zHcHQAvFgw_g4OhYUuwqdq4YyICbCf 20:26:02 INFO - Expected file size: 21989283 20:26:02 INFO - Obtained file size: 21989283 20:26:07 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 20:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:26:07 INFO - Http code: 200 20:26:07 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 20:26:07 INFO - x-amz-cf-id: 7fnR9hivgsKb4Q2l2WVylAxirvUYgzpv_n11U8FFSY8FhvxxUMHciw== 20:26:07 INFO - x-amz-version-id: .4zHcHQAvFgw_g4OhYUuwqdq4YyICbCf 20:26:07 INFO - Expected file size: 21989283 20:26:07 INFO - Obtained file size: 21989283 20:26:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:26:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:26:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:26:13 INFO - Http code: 200 20:26:13 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 20:26:13 INFO - x-amz-cf-id: anwgVZy3M7baljc1EpYC4ll7EVxbjvfWErFwSTNsxVvTvxspRjwbdQ== 20:26:13 INFO - x-amz-version-id: mW0o.k2xgISbAhawS.6Ov9jnnd0nCT6E 20:26:13 INFO - Expected file size: 14408522 20:26:13 INFO - Obtained file size: 14408522 20:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:13 INFO - trying https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/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 20:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/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 20:26:15 INFO - Downloaded 59719444 bytes. 20:26:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:15 INFO - mkdir: /builds/slave/test/properties 20:26:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:26:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:26:15 INFO - Contents: 20:26:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:16 INFO - Running post-action listener: _resource_record_post_action 20:26:16 INFO - Running post-action listener: set_extra_try_arguments 20:26:16 INFO - [mozharness: 2016-10-01 03:26:16.437050Z] Finished download-and-extract step (success) 20:26:16 INFO - [mozharness: 2016-10-01 03:26:16.437276Z] Running populate-webroot step. 20:26:16 INFO - Running pre-action listener: _resource_record_pre_action 20:26:16 INFO - Running main action method: populate_webroot 20:26:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:26:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:26:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:26:16 INFO - '--tppagecycles', 20:26:16 INFO - '7'], 20:26:16 INFO - 'tests': ['tsvgm']}}, 20:26:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:26:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:26:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:26:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:26:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['damp', 'tps']}, 20:26:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'tests': ['damp', 'tps']}, 20:26:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['dromaeo_dom']}, 20:26:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:26:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['basic_compositor_video']}, 20:26:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:26:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['a11yr', 20:26:16 INFO - 'ts_paint', 20:26:16 INFO - 'tpaint', 20:26:16 INFO - 'sessionrestore', 20:26:16 INFO - 'sessionrestore_no_auto_restore', 20:26:16 INFO - 'tabpaint']}, 20:26:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['tsvgx', 20:26:16 INFO - 'tsvgr_opacity', 20:26:16 INFO - 'tart', 20:26:16 INFO - 'tscrollx', 20:26:16 INFO - 'cart']}, 20:26:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:26:16 INFO - 'tsvgr_opacity', 20:26:16 INFO - 'tart', 20:26:16 INFO - 'tscrollx', 20:26:16 INFO - 'cart']}, 20:26:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'talos_options': ['--disable-e10s'], 20:26:16 INFO - 'tests': ['tp5o']}, 20:26:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'tests': ['tp5o']}, 20:26:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'talos_options': ['--disable-e10s', 20:26:16 INFO - '--xperf_path', 20:26:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:16 INFO - 'tests': ['tp5n']}, 20:26:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:16 INFO - 'talos_options': ['--xperf_path', 20:26:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:16 INFO - 'tests': ['tp5n']}}, 20:26:16 INFO - 'talos.zip': {'path': '', 20:26:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:26:16 INFO - Running post-action listener: _resource_record_post_action 20:26:16 INFO - [mozharness: 2016-10-01 03:26:16.453387Z] Finished populate-webroot step (success) 20:26:16 INFO - [mozharness: 2016-10-01 03:26:16.453475Z] Running create-virtualenv step. 20:26:16 INFO - Running pre-action listener: _resource_record_pre_action 20:26:16 INFO - Running main action method: create_virtualenv 20:26:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:26:16 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 20:26:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:26:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:26:16 INFO - Using real prefix '/usr' 20:26:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:26:17 INFO - Installing distribute.............................................................................................................................................................................................done. 20:26:19 INFO - Installing pip.................done. 20:26:19 INFO - Return code: 0 20:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:26:19 INFO - Reading from file tmpfile_stdout 20:26:19 INFO - Output received: 20:26:19 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) 20:26:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:26:19 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')]} 20:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:19 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')]} 20:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:19 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:19 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 20:26:19 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 20:26:19 INFO - Using env: {'DISPLAY': ':0', 20:26:19 INFO - 'HOME': '/home/cltbld', 20:26:19 INFO - 'LANG': 'en_US.UTF-8', 20:26:19 INFO - 'LANGUAGE': 'en_US:en', 20:26:19 INFO - 'LOGNAME': 'cltbld', 20:26:19 INFO - 'MAIL': '/var/mail/cltbld', 20:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:19 INFO - 'MOZ_NO_REMOTE': '1', 20:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:19 INFO - 'NO_EM_RESTART': '1', 20:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:19 INFO - 'PWD': '/builds/slave/test', 20:26:19 INFO - 'SHELL': '/bin/bash', 20:26:19 INFO - 'SHLVL': '1', 20:26:19 INFO - 'TERM': 'linux', 20:26:19 INFO - 'TMOUT': '86400', 20:26:19 INFO - 'USER': 'cltbld', 20:26:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:19 INFO - '_': '/tools/buildbot/bin/python'} 20:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:19 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 20:26:19 INFO - Cleaning up... 20:26:19 INFO - Return code: 0 20:26:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:26:19 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')]} 20:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:19 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')]} 20:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:19 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:19 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 20:26:19 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 20:26:19 INFO - Using env: {'DISPLAY': ':0', 20:26:19 INFO - 'HOME': '/home/cltbld', 20:26:19 INFO - 'LANG': 'en_US.UTF-8', 20:26:19 INFO - 'LANGUAGE': 'en_US:en', 20:26:19 INFO - 'LOGNAME': 'cltbld', 20:26:19 INFO - 'MAIL': '/var/mail/cltbld', 20:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:19 INFO - 'MOZ_NO_REMOTE': '1', 20:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:19 INFO - 'NO_EM_RESTART': '1', 20:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:19 INFO - 'PWD': '/builds/slave/test', 20:26:19 INFO - 'SHELL': '/bin/bash', 20:26:19 INFO - 'SHLVL': '1', 20:26:19 INFO - 'TERM': 'linux', 20:26:19 INFO - 'TMOUT': '86400', 20:26:19 INFO - 'USER': 'cltbld', 20:26:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:19 INFO - '_': '/tools/buildbot/bin/python'} 20:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:19 INFO - Downloading/unpacking psutil>=3.1.1 20:26:19 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 20:26:19 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 20:26:19 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 20:26:19 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 20:26:19 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 20:26:19 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 20:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:21 INFO - Installing collected packages: psutil 20:26:21 INFO - Running setup.py install for psutil 20:26:21 INFO - building 'psutil._psutil_linux' extension 20:26:21 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 20:26:21 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 20:26:21 INFO - building 'psutil._psutil_posix' extension 20:26:21 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 20:26:22 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 20:26:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:22 INFO - Successfully installed psutil 20:26:22 INFO - Cleaning up... 20:26:22 INFO - Return code: 0 20:26:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:26:22 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')]} 20:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:22 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')]} 20:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:22 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:22 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 20:26:22 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 20:26:22 INFO - Using env: {'DISPLAY': ':0', 20:26:22 INFO - 'HOME': '/home/cltbld', 20:26:22 INFO - 'LANG': 'en_US.UTF-8', 20:26:22 INFO - 'LANGUAGE': 'en_US:en', 20:26:22 INFO - 'LOGNAME': 'cltbld', 20:26:22 INFO - 'MAIL': '/var/mail/cltbld', 20:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:22 INFO - 'MOZ_NO_REMOTE': '1', 20:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:22 INFO - 'NO_EM_RESTART': '1', 20:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:22 INFO - 'PWD': '/builds/slave/test', 20:26:22 INFO - 'SHELL': '/bin/bash', 20:26:22 INFO - 'SHLVL': '1', 20:26:22 INFO - 'TERM': 'linux', 20:26:22 INFO - 'TMOUT': '86400', 20:26:22 INFO - 'USER': 'cltbld', 20:26:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:22 INFO - '_': '/tools/buildbot/bin/python'} 20:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:26:22 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 20:26:22 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 20:26:22 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 20:26:22 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 20:26:22 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 20:26:22 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 20:26:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:26:24 INFO - Installing collected packages: mozsystemmonitor 20:26:24 INFO - Running setup.py install for mozsystemmonitor 20:26:24 INFO - Successfully installed mozsystemmonitor 20:26:24 INFO - Cleaning up... 20:26:24 INFO - Return code: 0 20:26:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:26:24 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')]} 20:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:24 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')]} 20:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:24 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:24 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 20:26:24 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 20:26:24 INFO - Using env: {'DISPLAY': ':0', 20:26:24 INFO - 'HOME': '/home/cltbld', 20:26:24 INFO - 'LANG': 'en_US.UTF-8', 20:26:24 INFO - 'LANGUAGE': 'en_US:en', 20:26:24 INFO - 'LOGNAME': 'cltbld', 20:26:24 INFO - 'MAIL': '/var/mail/cltbld', 20:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:24 INFO - 'MOZ_NO_REMOTE': '1', 20:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:24 INFO - 'NO_EM_RESTART': '1', 20:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:24 INFO - 'PWD': '/builds/slave/test', 20:26:24 INFO - 'SHELL': '/bin/bash', 20:26:24 INFO - 'SHLVL': '1', 20:26:24 INFO - 'TERM': 'linux', 20:26:24 INFO - 'TMOUT': '86400', 20:26:24 INFO - 'USER': 'cltbld', 20:26:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:24 INFO - '_': '/tools/buildbot/bin/python'} 20:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:26:24 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 20:26:24 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 20:26:24 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 20:26:24 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 20:26:24 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 20:26:24 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 20:26:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:26:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:26:26 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 20:26:26 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 20:26:26 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 20:26:26 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 20:26:26 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 20:26:26 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 20:26:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:26:26 INFO - warning: no files found matching '*.txt' 20:26:26 INFO - no previously-included directories found matching 'build' 20:26:26 INFO - no previously-included directories found matching 'dist' 20:26:26 INFO - no previously-included directories found matching '.git*' 20:26:26 INFO - Installing collected packages: jsonschema, functools32 20:26:26 INFO - Running setup.py install for functools32 20:26:27 INFO - warning: no files found matching '*.txt' 20:26:27 INFO - no previously-included directories found matching 'build' 20:26:27 INFO - no previously-included directories found matching 'dist' 20:26:27 INFO - no previously-included directories found matching '.git*' 20:26:27 INFO - Successfully installed jsonschema functools32 20:26:27 INFO - Cleaning up... 20:26:27 INFO - Return code: 0 20:26:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:26:27 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')]} 20:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:27 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')]} 20:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:27 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:27 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 20:26:27 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 20:26:27 INFO - Using env: {'DISPLAY': ':0', 20:26:27 INFO - 'HOME': '/home/cltbld', 20:26:27 INFO - 'LANG': 'en_US.UTF-8', 20:26:27 INFO - 'LANGUAGE': 'en_US:en', 20:26:27 INFO - 'LOGNAME': 'cltbld', 20:26:27 INFO - 'MAIL': '/var/mail/cltbld', 20:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:27 INFO - 'MOZ_NO_REMOTE': '1', 20:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:27 INFO - 'NO_EM_RESTART': '1', 20:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:27 INFO - 'PWD': '/builds/slave/test', 20:26:27 INFO - 'SHELL': '/bin/bash', 20:26:27 INFO - 'SHLVL': '1', 20:26:27 INFO - 'TERM': 'linux', 20:26:27 INFO - 'TMOUT': '86400', 20:26:27 INFO - 'USER': 'cltbld', 20:26:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:27 INFO - '_': '/tools/buildbot/bin/python'} 20:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:26:27 INFO - Cleaning up... 20:26:27 INFO - Return code: 0 20:26:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:26:27 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')]} 20:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:27 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')]} 20:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:27 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:27 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 20:26:27 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 20:26:27 INFO - Using env: {'DISPLAY': ':0', 20:26:27 INFO - 'HOME': '/home/cltbld', 20:26:27 INFO - 'LANG': 'en_US.UTF-8', 20:26:27 INFO - 'LANGUAGE': 'en_US:en', 20:26:27 INFO - 'LOGNAME': 'cltbld', 20:26:27 INFO - 'MAIL': '/var/mail/cltbld', 20:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:27 INFO - 'MOZ_NO_REMOTE': '1', 20:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:27 INFO - 'NO_EM_RESTART': '1', 20:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:27 INFO - 'PWD': '/builds/slave/test', 20:26:27 INFO - 'SHELL': '/bin/bash', 20:26:27 INFO - 'SHLVL': '1', 20:26:27 INFO - 'TERM': 'linux', 20:26:27 INFO - 'TMOUT': '86400', 20:26:27 INFO - 'USER': 'cltbld', 20:26:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:27 INFO - '_': '/tools/buildbot/bin/python'} 20:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:26:27 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 20:26:27 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 20:26:27 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 20:26:27 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 20:26:27 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 20:26:27 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 20:26:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:26:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:26:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26:30 INFO - Downloading docopt-0.6.1.tar.gz 20:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:26:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:26:30 INFO - Running setup.py install for blobuploader 20:26:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:26:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:26:30 INFO - Running setup.py install for requests 20:26:30 INFO - Running setup.py install for docopt 20:26:30 INFO - Successfully installed blobuploader requests docopt 20:26:30 INFO - Cleaning up... 20:26:30 INFO - Return code: 0 20:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:30 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')]} 20:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:30 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')]} 20:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:30 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:30 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 20:26:30 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 20:26:30 INFO - Using env: {'DISPLAY': ':0', 20:26:30 INFO - 'HOME': '/home/cltbld', 20:26:30 INFO - 'LANG': 'en_US.UTF-8', 20:26:30 INFO - 'LANGUAGE': 'en_US:en', 20:26:30 INFO - 'LOGNAME': 'cltbld', 20:26:30 INFO - 'MAIL': '/var/mail/cltbld', 20:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:30 INFO - 'MOZ_NO_REMOTE': '1', 20:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:30 INFO - 'NO_EM_RESTART': '1', 20:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:30 INFO - 'PWD': '/builds/slave/test', 20:26:30 INFO - 'SHELL': '/bin/bash', 20:26:30 INFO - 'SHLVL': '1', 20:26:30 INFO - 'TERM': 'linux', 20:26:30 INFO - 'TMOUT': '86400', 20:26:30 INFO - 'USER': 'cltbld', 20:26:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:30 INFO - '_': '/tools/buildbot/bin/python'} 20:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:31 INFO - Running setup.py (path:/tmp/pip-VqQuaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:31 INFO - Running setup.py (path:/tmp/pip-QsLdX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:31 INFO - Running setup.py (path:/tmp/pip-E8YnUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:31 INFO - Running setup.py (path:/tmp/pip-FYhGv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:31 INFO - Running setup.py (path:/tmp/pip-O0tP7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:31 INFO - Running setup.py (path:/tmp/pip-AZWBeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:31 INFO - Running setup.py (path:/tmp/pip-xiscFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:31 INFO - Running setup.py (path:/tmp/pip-t3NFEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:31 INFO - Running setup.py (path:/tmp/pip-R1ID19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:31 INFO - Running setup.py (path:/tmp/pip-SjWtde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:31 INFO - Running setup.py (path:/tmp/pip-mvOk45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:31 INFO - Running setup.py (path:/tmp/pip-Wlquyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:31 INFO - Running setup.py (path:/tmp/pip-JqfkLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:32 INFO - Running setup.py (path:/tmp/pip-xGuGYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:32 INFO - Running setup.py (path:/tmp/pip-d1Tfbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:32 INFO - Running setup.py (path:/tmp/pip-gbRQbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:32 INFO - Running setup.py (path:/tmp/pip-MxXWZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:26:32 INFO - Running setup.py install for manifestparser 20:26:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:26:32 INFO - Running setup.py install for mozcrash 20:26:32 INFO - Running setup.py install for mozdebug 20:26:32 INFO - Running setup.py install for mozdevice 20:26:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:26:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:26:32 INFO - Running setup.py install for mozfile 20:26:32 INFO - Running setup.py install for mozhttpd 20:26:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:26:32 INFO - Running setup.py install for mozinfo 20:26:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for mozInstall 20:26:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for mozleak 20:26:33 INFO - Running setup.py install for mozlog 20:26:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for moznetwork 20:26:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for mozprocess 20:26:33 INFO - Running setup.py install for mozprofile 20:26:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for mozrunner 20:26:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:26:33 INFO - Running setup.py install for mozscreenshot 20:26:33 INFO - Running setup.py install for moztest 20:26:34 INFO - Running setup.py install for mozversion 20:26:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:26:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:26:34 INFO - Cleaning up... 20:26:34 INFO - Return code: 0 20:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:34 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:34 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 20:26:34 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 20:26:34 INFO - Using env: {'DISPLAY': ':0', 20:26:34 INFO - 'HOME': '/home/cltbld', 20:26:34 INFO - 'LANG': 'en_US.UTF-8', 20:26:34 INFO - 'LANGUAGE': 'en_US:en', 20:26:34 INFO - 'LOGNAME': 'cltbld', 20:26:34 INFO - 'MAIL': '/var/mail/cltbld', 20:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:34 INFO - 'MOZ_NO_REMOTE': '1', 20:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:34 INFO - 'NO_EM_RESTART': '1', 20:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:34 INFO - 'PWD': '/builds/slave/test', 20:26:34 INFO - 'SHELL': '/bin/bash', 20:26:34 INFO - 'SHLVL': '1', 20:26:34 INFO - 'TERM': 'linux', 20:26:34 INFO - 'TMOUT': '86400', 20:26:34 INFO - 'USER': 'cltbld', 20:26:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:34 INFO - '_': '/tools/buildbot/bin/python'} 20:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:34 INFO - Running setup.py (path:/tmp/pip-QAwRYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:34 INFO - Running setup.py (path:/tmp/pip-4mGgsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:34 INFO - Running setup.py (path:/tmp/pip-0nhMhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:34 INFO - Running setup.py (path:/tmp/pip-npSQwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:34 INFO - Running setup.py (path:/tmp/pip-w0W_SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:34 INFO - Running setup.py (path:/tmp/pip-1H9uno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:34 INFO - Running setup.py (path:/tmp/pip-n5touo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:34 INFO - Running setup.py (path:/tmp/pip-rl6To7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:34 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)) 20:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:34 INFO - Running setup.py (path:/tmp/pip-heD6cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:35 INFO - Running setup.py (path:/tmp/pip-236UVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:35 INFO - Running setup.py (path:/tmp/pip-zhoctP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:35 INFO - Running setup.py (path:/tmp/pip-Pox0hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:35 INFO - Running setup.py (path:/tmp/pip-7IjiI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:35 INFO - Running setup.py (path:/tmp/pip-MkGuRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:35 INFO - Running setup.py (path:/tmp/pip-NVq1MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:35 INFO - Running setup.py (path:/tmp/pip-seCIRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:35 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)) 20:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:35 INFO - Running setup.py (path:/tmp/pip-jxAkEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:35 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)) 20:26:35 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)) 20:26:35 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)) 20:26:35 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)) 20:26:35 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)) 20:26:35 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)) 20:26:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:26:35 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 20:26:35 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 20:26:35 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 20:26:35 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 20:26:35 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 20:26:35 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 20:26:37 INFO - Downloading blessings-1.6.tar.gz 20:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:26:37 INFO - Installing collected packages: blessings 20:26:37 INFO - Running setup.py install for blessings 20:26:37 INFO - Successfully installed blessings 20:26:37 INFO - Cleaning up... 20:26:37 INFO - Return code: 0 20:26:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:37 INFO - Reading from file tmpfile_stdout 20:26:37 INFO - Current package versions: 20:26:37 INFO - argparse == 1.2.1 20:26:37 INFO - blessings == 1.6 20:26:37 INFO - blobuploader == 1.2.4 20:26:37 INFO - docopt == 0.6.1 20:26:37 INFO - functools32 == 3.2.3-2 20:26:37 INFO - jsonschema == 2.5.1 20:26:37 INFO - manifestparser == 1.1 20:26:37 INFO - mozInstall == 1.12 20:26:37 INFO - mozcrash == 0.17 20:26:37 INFO - mozdebug == 0.1 20:26:37 INFO - mozdevice == 0.48 20:26:37 INFO - mozfile == 1.2 20:26:37 INFO - mozhttpd == 0.7 20:26:37 INFO - mozinfo == 0.9 20:26:37 INFO - mozleak == 0.1 20:26:37 INFO - mozlog == 3.4 20:26:37 INFO - moznetwork == 0.27 20:26:37 INFO - mozprocess == 0.23 20:26:37 INFO - mozprofile == 0.28 20:26:37 INFO - mozrunner == 6.12 20:26:37 INFO - mozscreenshot == 0.1 20:26:37 INFO - mozsystemmonitor == 0.3 20:26:37 INFO - moztest == 0.7 20:26:37 INFO - mozversion == 1.4 20:26:37 INFO - psutil == 3.1.1 20:26:37 INFO - requests == 1.2.3 20:26:37 INFO - wsgiref == 0.1.2 20:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:37 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')]} 20:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:37 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')]} 20:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:37 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:37 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 20:26:37 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 20:26:37 INFO - Using env: {'DISPLAY': ':0', 20:26:37 INFO - 'HOME': '/home/cltbld', 20:26:37 INFO - 'LANG': 'en_US.UTF-8', 20:26:37 INFO - 'LANGUAGE': 'en_US:en', 20:26:37 INFO - 'LOGNAME': 'cltbld', 20:26:37 INFO - 'MAIL': '/var/mail/cltbld', 20:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:37 INFO - 'MOZ_NO_REMOTE': '1', 20:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:37 INFO - 'NO_EM_RESTART': '1', 20:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:37 INFO - 'PWD': '/builds/slave/test', 20:26:37 INFO - 'SHELL': '/bin/bash', 20:26:37 INFO - 'SHLVL': '1', 20:26:37 INFO - 'TERM': 'linux', 20:26:37 INFO - 'TMOUT': '86400', 20:26:37 INFO - 'USER': 'cltbld', 20:26:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:37 INFO - '_': '/tools/buildbot/bin/python'} 20:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 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)) 20:26:38 INFO - Cleaning up... 20:26:38 INFO - Return code: 0 20:26:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:26:38 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')]} 20:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:38 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')]} 20:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:38 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 0x7f6ca767ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', '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 20:26:38 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 20:26:38 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 20:26:38 INFO - Using env: {'DISPLAY': ':0', 20:26:38 INFO - 'HOME': '/home/cltbld', 20:26:38 INFO - 'LANG': 'en_US.UTF-8', 20:26:38 INFO - 'LANGUAGE': 'en_US:en', 20:26:38 INFO - 'LOGNAME': 'cltbld', 20:26:38 INFO - 'MAIL': '/var/mail/cltbld', 20:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:38 INFO - 'MOZ_NO_REMOTE': '1', 20:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:38 INFO - 'NO_EM_RESTART': '1', 20:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:38 INFO - 'PWD': '/builds/slave/test', 20:26:38 INFO - 'SHELL': '/bin/bash', 20:26:38 INFO - 'SHLVL': '1', 20:26:38 INFO - 'TERM': 'linux', 20:26:38 INFO - 'TMOUT': '86400', 20:26:38 INFO - 'USER': 'cltbld', 20:26:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:38 INFO - '_': '/tools/buildbot/bin/python'} 20:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:26:38 INFO - Cleaning up... 20:26:38 INFO - Return code: 0 20:26:38 INFO - Running post-action listener: _resource_record_post_action 20:26:38 INFO - Running post-action listener: _start_resource_monitoring 20:26:38 INFO - Starting resource monitoring. 20:26:38 INFO - [mozharness: 2016-10-01 03:26:38.476507Z] Finished create-virtualenv step (success) 20:26:38 INFO - [mozharness: 2016-10-01 03:26:38.476969Z] Running install step. 20:26:38 INFO - Running pre-action listener: _resource_record_pre_action 20:26:38 INFO - Running main action method: install 20:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:38 INFO - Reading from file tmpfile_stdout 20:26:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:26:38 INFO - Reading from file tmpfile_stdout 20:26:38 INFO - Output received: 20:26:38 INFO - Usage: mozinstall [options] installer 20:26:38 INFO - Options: 20:26:38 INFO - -h, --help show this help message and exit 20:26:38 INFO - -d DEST, --destination=DEST 20:26:38 INFO - Directory to install application into. [default: 20:26:38 INFO - "/builds/slave/test"] 20:26:38 INFO - --app=APP Application being installed. [default: firefox] 20:26:38 INFO - mkdir: /builds/slave/test/build/application 20:26:38 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'] 20:26:38 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 20:26:55 INFO - Reading from file tmpfile_stdout 20:26:55 INFO - Output received: 20:26:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:26:55 INFO - Running post-action listener: _resource_record_post_action 20:26:55 INFO - [mozharness: 2016-10-01 03:26:55.790326Z] Finished install step (success) 20:26:55 INFO - [mozharness: 2016-10-01 03:26:55.790572Z] Running run-tests step. 20:26:55 INFO - Running pre-action listener: _resource_record_pre_action 20:26:55 INFO - Running main action method: run_tests 20:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:26:55 INFO - Python 2.7.3 20:26:55 INFO - Return code: 0 20:26:55 INFO - grabbing minidump binary from tooltool 20:26:55 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')]} 20:26:55 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 0xdcb930>, '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 0xdcc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:26:55 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 20:26:55 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 20:26:55 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 20:26:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:26:55 INFO - Return code: 0 20:26:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:26:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:26:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:26:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:26:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:26:55 INFO - Using env: {'DISPLAY': ':0', 20:26:55 INFO - 'HOME': '/home/cltbld', 20:26:55 INFO - 'LANG': 'en_US.UTF-8', 20:26:55 INFO - 'LANGUAGE': 'en_US:en', 20:26:55 INFO - 'LOGNAME': 'cltbld', 20:26:55 INFO - 'MAIL': '/var/mail/cltbld', 20:26:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:26:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:55 INFO - 'MOZ_NO_REMOTE': '1', 20:26:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:55 INFO - 'NO_EM_RESTART': '1', 20:26:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:55 INFO - 'PWD': '/builds/slave/test', 20:26:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:26:55 INFO - 'SHELL': '/bin/bash', 20:26:55 INFO - 'SHLVL': '1', 20:26:55 INFO - 'TERM': 'linux', 20:26:55 INFO - 'TMOUT': '86400', 20:26:55 INFO - 'USER': 'cltbld', 20:26:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225', 20:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:55 INFO - '_': '/tools/buildbot/bin/python'} 20:26:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:26:56 INFO - mozversion application_buildid: 20160930153002 20:26:56 INFO - mozversion application_changeset: ac89a649cbb96c6e50446b0df901e9d7d8963f24 20:26:56 INFO - mozversion application_display_name: Nightly 20:26:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:26:56 INFO - mozversion application_name: Firefox 20:26:56 INFO - mozversion application_remotingname: firefox 20:26:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:26:56 INFO - mozversion application_vendor: Mozilla 20:26:56 INFO - mozversion application_version: 52.0a1 20:26:56 INFO - mozversion platform_buildid: 20160930153002 20:26:56 INFO - mozversion platform_changeset: ac89a649cbb96c6e50446b0df901e9d7d8963f24 20:26:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:26:56 INFO - mozversion platform_version: 52.0a1 20:26:56 INFO - using testdate: 1475292416 20:26:56 INFO - actual date: 1475292416 20:26:56 INFO - starting webserver on 'localhost:47160' 20:26:56 INFO - SUITE-START | Running 2 tests 20:26:56 INFO - TEST-START | dromaeo_css 20:26:56 INFO - operating with platform_type : linux_ 20:26:56 INFO - Initialising browser for dromaeo_css test... 20:26:56 INFO - TEST-INFO | started process 31254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplC09il/profile http://localhost:47160/getInfo.html) 20:27:00 INFO - PROCESS | 31254 | __metrics Screen width/height:1600/1200 20:27:00 INFO - PROCESS | 31254 | colorDepth:24 20:27:00 INFO - PROCESS | 31254 | Browser inner width/height: 1024/697 20:27:00 INFO - PROCESS | 31254 | __metrics 20:27:00 INFO - PROCESS | 31254 | 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" 20:27:00 INFO - PROCESS | 31254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:27:01 INFO - PROCESS | 31254 | console.error: PushService: 20:27:01 INFO - PROCESS | 31254 | stateChangeProcessEnqueue: Error transitioning state 20:27:01 INFO - PROCESS | 31254 | UnknownError 20:27:02 INFO - TEST-INFO | 31254: exit 0 20:27:02 INFO - Browser initialized. 20:27:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:27:02 INFO - TEST-INFO | started process 31337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplC09il/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:14 INFO - PROCESS | 31337 | RSS: Main: 174161920 20:27:14 INFO - PROCESS | 31337 | 20:28:05 INFO - PROCESS | 31337 | 1475292485710 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] 20:30:15 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47160/tests/dromaeo/cssquery-ext.html) 20:30:16 INFO - PROCESS | 31337 | RSS: Main: 330825728 20:30:16 INFO - PROCESS | 31337 | 20:33:19 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-ext.html (next: http://localhost:47160/tests/dromaeo/cssquery-jquery.html) 20:33:19 INFO - PROCESS | 31337 | RSS: Main: 281321472 20:33:19 INFO - PROCESS | 31337 | 20:36:21 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47160/tests/dromaeo/cssquery-mootools.html) 20:36:22 INFO - PROCESS | 31337 | RSS: Main: 257953792 20:36:22 INFO - PROCESS | 31337 | 20:39:24 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47160/tests/dromaeo/cssquery-prototype.html) 20:39:24 INFO - PROCESS | 31337 | RSS: Main: 250642432 20:39:24 INFO - PROCESS | 31337 | 20:42:27 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47160/tests/dromaeo/cssquery-yui.html) 20:42:28 INFO - PROCESS | 31337 | RSS: Main: 222715904 20:42:28 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | Cycle 1(1): loaded http://localhost:47160/tests/dromaeo/cssquery-yui.html (next: http://localhost:47160/tests/dromaeo/cssquery-dojo.html) 20:45:31 INFO - PROCESS | 31337 | RSS: Main: 306442240 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | __start_tp_report 20:45:31 INFO - PROCESS | 31337 | _x_x_mozilla_page_load 20:45:31 INFO - PROCESS | 31337 | _x_x_mozilla_page_load_details 20:45:31 INFO - PROCESS | 31337 | |i|pagename|runs| 20:45:31 INFO - PROCESS | 31337 | |0;dojo.html;3027.5307327364258;3057.4496590613694;3058.2660161561216;3081.229692576856;3086.5524498947666;5212.2963399941;5252.501012403825;5335.986162629098;5341.572674186065;5360.08878490657;5267.65760225586;5271.288376069229;5297.576193904488;5333.2000199970025;5336.813211537587;4865.221564549673;4889.119958407486;4896.265560165968;4900.240462728283;4902.779374928119;4868.342773725555;4922.187839006559;4933.358663373757;4948.7278199699;4953.876153096166;4516.661250406216;4921.360223170983;4951.108800415924;4951.851444456672;5010.799568017275;4783.067301876135;4814.229723244264;4823.03539292143;4882.487338829407;4896.1186986342445;4672.789724462374;4775.331453596499;4827.493113223131;4830.29960655703;4861.878453038702;5306.52241298285;5315.840524784263;5322.334708161441;5322.787088516455;5369.301990741218;5724.084146536576;5727.284089488814;5732.713364331767;5794.913076303858;5795.3045634523705;5604.495595396393;5654.547636189095;5767.22142510764;5846.736896839652;5859.912101318441;5446.319210098738;5455.345358556959;5468.699221542854;5469.398366179677;5471.753771080311;5972.223610930551;5982.102684597346;5989.251343582052;5989.371116032841;5990.850228744316;5379.193121031876;5414.025475414384;5479.780808767684;5517.034518959166;5551.750171242304;5566.415526369754;5592.245046918695;5596.412376700469;5596.916046259309;5660.320761508563;5554.777808887599;5561.888762224733;5564.1931919871395;5565.193047008162;5566.860828479321;5522;5578.386377498472;5589.413111623302;5619.578531610146;5640.802571909963;4337.82648694055;4345.652347812231;4359.433273674402;4370.322599997005;4370.759608221579;3887.844486220576;3889.7860617665733;3926.2540117377607;3930.3711406174875;3955.802209889494;5365.168398898177;5377.973110134424;5390.703511306838;5394.190871369247;5440.809571664972;5535.391106978229;5642.548596112301;5645.80239691617;5727.570432217601;5761.790024094903;5351.224072509464;5366.221897824794;5386;5430.266913966643;5449.264349312872;4962.454130045692;5013.172826483662;5029.974850125726;5062.190049592047;5066.189409694505;5779.682117483579;5795.304563452329;5797.246357973437;5801.332846722681;5802.796902108406;5513.807016754395;5556.91664625039;5564.527015203753;5617.43825617435;5683.06229472149;5910;5924.7037648118285;5929.644221346733;5947.375525569752;6016.939830601638;5644.717764111861;5652.886942261214;5655.773769049192;5658.830235092953;5659.518940890071;5446.564274857923;5710.4004079572705;5710.971445142748;5752.395998420273;5770.336411312753;5369.060414427381;5555.916661250165;5598.3282006159525;5601.411851755507;5660.632058916157;5579;5583.162525621027;5597.356304025089;5602.52378547828;5605.159226115952;5493.890122197614;5529.474699903502;5545.556355491471;5552.472515111058;5625.943740562542;5503.422140675171;5559.138333558305;5643.153526970823;5687;5701.258836351248;5530.529904958124;5572.554195664256;5578.63738856973;5589.496945274945;5644.379118297066 20:45:31 INFO - PROCESS | 31337 | |1;ext.html;546.7650526796243;583.9211706419634;600.2676734384055;605.9244840408275;608.5831205624146;31522.211944701394;32355.852388046285;41254.7937260314;41709.16581668365;41715.58284417155;39097.804510977476;42767;42854.78572607133;42882.142357152836;42999.570004299945;7911.169327220645;8769.912300876973;8895.555222238894;8910.242629376511;8917.777055573597;7897.644605992716;10510.842337364908;10844.457777111153;10850.782984340309;11227.382493962828;11016.394098324588;11064.668059958174;11074.557017719282;11083.168762342857;11085.057770089552;10850.891491085067;10928.453577321103;10936.343819370863;10955.616553420672;10964.013238808466;10629.149668026617;10680.25238233324;10696.893031069667;10697.411642359668;10702;42877.78561107206;43038.35442468365;43130.56869431297;43290.350644740356;43292.78353608243;3653.013686304683;3711.480392745018;3796.373598356268;3957.228340473609;4024.255512730125;30942.381152377053;32138.678613213804;32403;32445.83777081123;32831.6716832831;4178;4311.611954924072;4372.934405983913;4386.517483076891;4499.61753250974;311851;312261;312791;313297;314565;58585.41414585885;59021.40978590245;59052;59069.40930590725;59097;60586.39413605807;61009.389906101256;61156.69421652863;61160.08259876105;61254.693726531084;15936.36254549805;16052.438164664181;16070.43753468623;16086.115263660377;16094.436694715629;11075.50160242791;11099.5560177592;12796.61610151697;13346.46614135443;13415.262160581067;14642.707145857235;14721.705565888622;14869.925650371895;14962.40150393972;15147.469838555819;6053.576249662481;6267.592606480564;6313.179286692701;6347.936520634735;6494.350564943468;911.1981456318398;978.2076518020426;1000.3847633705219;1023.6673081248624;1043.9060484556426;30714.69285307163;30804.229894252374;31129;31237.843810781254;31630.525542116888;1091.110744743032;1093.5680406239492;1105.8507101541188;1109.5450865145413;1120.8991190792867;15993.680126397407;16516.587085322964;16557;16611.41860034893;16904.323827047025;462415;462593;464581;465050;465296;55063.44936550663;55518.44481555214;55649;55654;55785.72107139519;1202.6933132051272;1247.2703468470866;1310.927898965528;1330.4478641363726;1348.0967751606447;28604.570931435628;32681.34637307193;32964.835175823966;33122.17194570059;33250.833745831114;46315.60001799824;46842;46885.29672054854;46887.765561171975;46929;377820;380606;381148;381448;381667;38946.6105338943;39544.2091158181;40335;40430.595694042684;40431;44305.778471107435;44964.325535116346;45597;45774.54225457703;46191.30713039375;38422.615773841906;38907;39151.34427147335;40202.798986004884;40675;38073.23853522969;38435;38763.2247355057;39659.2068158641;40016.79991600024;33207.50188747219;33836.66163338335;34204.14489637779;34639.826800866846;34785.30429391449;33190.502142468365;35373.469397958535;36034.819825900704;36614.63385366219;36728.63271367252;27516.312092197855;27709.445811083264;28145.577816332363;28263;28279 20:45:31 INFO - PROCESS | 31337 | |2;jquery.html;359.89023347878884;373.31869338457324;391.3288709862585;393.8641168796765;409.6067774936061;14204.36080376383;18158.909205453987;18364.99999999998;19243.230270789187;20351;17289.13554322282;17430.38993635223;17449;17503.649927001483;18366.98981556014;5508.889822203543;5792.044312688401;5805.477507024367;5811.738471768759;5835.270591176103;3993.560708322082;4761.642876784238;5680.261565996415;5777.364489906107;5779.046457334534;6242.531810114237;6354.491640668759;6355.650439225864;6361.886669832761;6363.872722545546;6138.202033735631;6357.93642063578;6361.459275961549;6429.54993150475;6429.54993150475;5637.069883469264;5641.323041235037;5645.802396916089;5648.124540696199;5649.887002259973;22762.585612158142;22844.31467055991;22897.656535151986;22903.77096229033;22910.77089229103;2395.6646069550275;2625.2124362691115;2896.000879696501;3085;3110.144710204689;13950.651233719136;14252.786208206782;14282.214478203694;14383.78424323636;14634.487792927303;1879.6240751849684;1925.1721759643349;1971.3001884331143;1974.2892558678864;1979.6733538966052;50226.246606300934;80475;82341.58829205876;82921;85623.99999999937;9145.131212534798;9536.475493847765;10346.689599312032;10736.248462607542;10749.40878251688;14798;14847.331870065873;14858.03422777516;14861.479848205261;14867.776983345258;7988.334745512259;8138.470999385021;8154.796130096795;8366.832663346699;8435.70475033383;7625.923740762521;7814.648340824677;7888.211178882066;7960.56216908064;8284.461510001951;6250.468710159596;6370.554061215763;6378.840528986812;6378.872422551616;6449.355064493607;1844.6480737060356;1887.8867267963692;1904.124102912648;1951.3170390363543;1953.5116220944765;863.9006514250816;956.1490273656451;958.242988039455;1041.146260066738;1051.3271506236015;18071.27714891416;19461.12424940881;19760.308389206595;20865.478363041046;21037.474063148544;967.8935317115112;971.2618410008445;975.3855071305032;1002.1832206751474;1065.0148612533376;10667.466626668636;10889.746427752243;10965.50655220517;10992.065674417765;11091.33451992883;393633;429437;456722;461170;463850;91180.54409727908;93695;93769;94469.5276523613;94758;1047.7537778622018;1074.0655629602295;1080.0765345629375;1097.7804439112049;1100.2793170473353;16553.751693724844;16704.582385440463;17566.648667026333;17579.208935598184;17961.550961226072;40063.91589385155;40868.59131408648;42171.36742948797;42401.78799105985;43789.78105109454;51270.48729512806;53130;54140.72929635327;54508.72745636405;57383.42616573781;8383.748487545383;8418.5790710463;8572.657093716181;8696.21734043939;8773.912260877565;11322.773544529227;12368.876311236772;12504.687382815502;12633.93683031579;13256.337183140997;11023.72440688957;11066.667999960015;11107.222494425312;11209.215354925076;11274.926332841429;10638.095761860328;10768.784624307627;10823.971722686332;11149.108071354434;11407.771844563229;11205.215634905479;11304.83042754343;11583.420828958688;11606.825897611374;11833.46749396262;8317.833643326978;8343.165683431609;8395.916040839513;8457.915420845959;8598.441101328644;8805.735827925173;10841.67474975752;10844.566217351534;11034.172437067413;11151.330920144817 20:45:31 INFO - PROCESS | 31337 | |3;mootools.html;1341.2623057318472;1461.8245810502738;1486.5688950204437;1611.919404029799;1775.6093659394937;7901.407394445418;8726.171013753692;9104.271658267347;9113.817723645523;9376.484293363863;9151.67969121081;9213.493257870814;9222.861657075133;9231.723048308544;9245.075492450751;2294.999999999996;2315.340128063502;2317.084751523147;2317.5249073939885;2320.825938054644;2248.5278091600785;2266.478709896725;2318.8376813623054;2319.895604697784;2329.3477826208687;2276.499170182557;2288.931332060041;2302.781235782598;2318.802901753353;2320.907163713458;2215.878126703031;2224.232639739287;2228.687983682286;2234.575430668168;2235.005422586941;2213.4798322394226;2238.1271304191378;2238.708967834187;2240.462289050616;2264.750877403484;9065;9148.130927561871;9220.815583688289;9239;9240.260779137652;5299.284596579451;5458.099413596752;5464.617476776627;5466.808661696821;5474.09677403228;3446.293509830479;3482.0946553895915;3508.7894726316504;3512.0868574170645;3554.377983852841;1102.5755084292525;1112.2047735868812;1114.6433141394675;1122.6407549584137;1146.8910453506903;12883.549075782397;12977;13054.608361749068;13068.889144422736;13088.738225235442;4399.340098985178;4539.205639013159;4646.767661616906;4702.177119004161;4732.929006064912;10084.798304033879;10100.797984040424;10102;10105.39367637944;10110.69667909964;5389.02997460453;5395.460453954652;5400.648957817808;5402.837914862561;5404.945950540444;4253.340732186516;4401.713888597231;4887.584555312838;5003.224500202475;5057.317262169634;3793.563740169916;3825.885223443301;3846.8461261549223;3867.613238676166;3944.881653550398;1166.5916929074756;1191.737817680109;1215.7082300247878;1220.2312543097792;1226.2826246645634;901.4726385064811;911.7401540560908;920.963161473547;949.6723630347657;968.4141094637642;5625.296837895263;5796.594238403356;5819.73811178498;5883.764649414061;6096.359882212392;447.5032713687804;457.8603525924625;460.3715927758585;463.726401423162;464.5493870945178;3730.850765969331;3793.336166170909;3870.806459677005;3871.632194941476;3987.302222111119;11371.431428428545;11701.765964680659;11776.822317768154;11786.116041296937;11787.35169565665;11484.368359740294;11649.53401863933;11709.414529273503;11858.347790871585;11881.049516038696;8585.441946273471;8590.59463350263;8675.609597568124;8689.217970382695;8729.781755456037;5734.34055083654;5795.710214489174;5803.332616749128;5806.042003069615;5903.822885313448;10510.421926794099;10645.680629581126;10760;10805.135589153006;10931.180161488079;10873.78252434931;10993.61522346714;11007.669769906915;11132.276402033842;11151.944240278746;7523.172451030492;7581.469297149147;7639.159692433939;7781.883271751041;7796.298333150044;8995.77510562215;9076.818463630558;9097.363184577016;9121.179093881583;9134.406263592846;7773.1060927994;7779.649915753692;7962.283394494523;8029.598520073856;8136.959315203386;7641.121271053677;7785.727499537489;7817.1791961845465;7832.80417989532;7853.214678532329;7014.614196219257;7109.537880037781;7109.8578028438105;7118.822029449305;7124.21633620291;4903.803847846189;4998.225275082368;5056.82301119459;5127.512886275797;5296.126139186991;4936.234883593049;5080.288759573737;5099.745012749422;5141.352203615066;5226.085435048927 20:45:31 INFO - PROCESS | 31337 | |4;prototype.html;330.919547676835;342.878278211235;347.44062060083263;348.4651060621946;350.0042379430519;5111.846644600659;5286.303984967665;5327.866803329914;5379.112446446336;5391.145331088271;5076.263941728447;5197;5219.295395121658;5220.441983428122;5242.18746094356;4172.497900755726;4186.79066046698;4193.475815523059;4195.874123776284;4208.684348673846;3994.62051105146;4079.898002549945;4206.978965105171;4211.599898009684;4218.767967761772;4112.05422752767;4115.773632450229;4120.896977575555;4125.484314460692;4126.484189476316;4105.835766569334;4112.568180341066;4117.814698338552;4121.80467664377;4138.193052354792;3631.800250986195;3660.359437098497;3662.285854258421;3666.2667466506537;3668.394714872043;5042.445331013586;5097.388313402378;5107.182850743863;5138.203578445309;5150.407703114152;4699.271612900006;4704.741239231841;4706.74112923789;4710.646701497367;4717.363155973934;5472.701465384548;5479.479449452296;5482.342118945752;5491.807786727445;5498.477644623755;3818.8472461101524;3981.228353382746;4012.7191096623246;4013.5986401359924;4023.436718859362;5675.318961724578;5694.288213973254;5719.399463056402;5737.82786516401;5785.768569257225;4096.139810639799;4104.15864747726;4107.589241075869;4111.8972025698995;4122.2786012447705;3910.9804450977563;4084.346504559256;4087.3255912774653;4112.670986321087;4131.153113611763;4657.394538709946;4667.85278771762;4691.906161876744;4698.553637404441;4698.8355407560575;5514.641548299348;5520.889582208413;5541.722913854291;5546.168074788814;5560.638558493685;1340.3968214303602;1351.5607427586074;1413.7064585903988;1415.8390120101417;1418.3404716806529;895.4582477601087;898;917.3899356927702;929.1730359979623;929.7396728915915;4740.132220006915;4747.7626118693925;4759.881002974953;4766.212670248657;4789.9042019160115;4860.270959356054;4879.243717223836;5027.271045698353;5033.496650334937;5040.521150490697;4377.627901628333;4631.421072365954;4647.837325693585;4657.578059409088;4681.250999840077;2639.5512762830367;2651.8387514175884;2651.8541480218387;2653.8009649276382;2660.1246121484305;5072.949270507248;5094;5102.719350435687;5111.415461207038;5134.666246693953;4734.928976065362;4988.925166122511;4991.401031876126;5005.974970125126;5101.668391554537;5160.664556803796;5163.580015495693;5182.922256166161;5205.869853253624;5212.322398088224;4966.882451448395;4986.32684587576;4997.975010125072;5034.219695947134;5041.344625198701;4715.198416269311;4795.664303498722;4898.191798353232;4934.481879402611;4956.82651107224;5092.541671249605;5093.7707803148205;5116.411612664442;5125.641205115606;5136.332276803992;3680.392735198662;3680.6687398134295;3697.6487233712755;3704.5739739929177;3720.8697695580527;4718.504557021463;4862.756862156807;4941.901161976813;4958.2810492477665;4975.676581022367;4754.95682763025;4803.255495398219;4810.975945120252;4900.0444913243;4901.240307752304;4783.832565860317;4788.066327066189;4836.322914791862;4854.2233242681;4881.219004959189;4608.423947006624;4764.618830493621;4809.326694262876;4838.346823178826;4863.805447782049;4889.801998510387;4908.361912951294;4908.8772780680765;4921.63087768426;4923.606111510999;4737.644676649334;4770.2129148691465;4774.283857421415;4791.442781096088;4831.299461578122 20:45:31 INFO - PROCESS | 31337 | |5;yui.html;702.701629711972;706.5372181221301;748.651876877252;785.8271180340325;815.2214635023553;14067.718645627094;14538.127712337267;14551.199684017374;14555;14560.271986400678;13675.726485470284;15067.246637668128;15107.320170592322;15149.166795826226;15179.316930738116;652.044754434753;780.8555417247799;780.9921900780977;787.1813314153273;791.2720297326445;672.576276945526;786.4376970466116;813.3330668851514;815.7144999250245;820.3888103363003;847.6058632735777;849.8597731374347;850.0139837788167;850.1243718969471;850.5577099908076;684.6029303004245;842.6671464771442;843.5613480989881;843.616154649636;844.3751623798406;510.0971280832942;602.6956387024568;613.2365205319361;617.4196255519797;618.2766163588612;14611.415543378253;14679.559613211513;14697.485588004476;14700.044497107654;14729.852701473063;13533.323333833268;13925.30373481332;14133.363998620087;14226.92886535571;14256.92871535646;11605.94197029018;11726.237794543327;11734.11994100446;11770.823437648442;11901.583444579484;4331.306990881475;4340.305551111807;4425.955740442619;4435.356873253392;4460.33095035744;64215;66975;80737;81076.18923810746;81783;11077.955801379303;11328.32030078198;11445.54217831294;11498.655040348804;11683.883161168449;20999.580008399746;21025;21106.15575376968;21129.89435052815;21136.894315528323;8461.40770146084;8571.757095221157;8591.785205369915;8849.115088491099;9052.094790520896;4695.3426520287185;4879.316895634614;4928.408590969107;4939;5083.940449794155;3509.982450087733;3599.5140656011627;3617.2403795202777;3621.9818900905325;3633.109888077385;647.9578827376206;651.0852252585125;651.1567520061437;666.4634968850122;668.8963210702349;631.9210098737658;646.6863571167979;677.383580941341;682.3926705232348;735.7130719019586;9088.863667045;9853.211743060538;9901.207903367713;9952.25358098131;10007.399556026516;642.945349645276;678.9815277084374;695.6278391060758;712.6150783777059;735.3565630073685;4711.175544279738;4939.407271127488;4953.1332016896895;4970.875728106754;4990.775415106329;117240.96554206774;122067.38966305289;122847;125577;127103.2055512229;83531.5823420879;105414;105716.47141764242;108994.45502772435;109846;64555.677221613594;93498;96279;97758.5112074435;98002;8901.421407608485;9047.954760226157;9087.727368178965;9314.44113353201;9358.953205233931;43111.35332970071;46557.76721116373;54830.17754733762;54849;55534.44465555293;46156.53843461657;62903;68209.31790682228;73318.26681733114;73558.63220684076;11129.777404451703;11205.943970280096;11331.830022549833;11596.420178990847;11688.649340519798;13260.138091024053;13406;13714.51999180024;14910.62144095073;15170.317335719697;13891.861081389057;13938.163710177421;13978.650533736738;14367.13797172173;14835.10989340643;12963.546275880299;13374.665633359244;13382.665433364244;13767.242801646005;14298.714025719635;13753.312334383441;14447.277636118362;14682.853171468576;14686.265686715835;15013.249337532861;11516.53933842637;11618.477168527606;11704.590339338083;11836.289822610672;11891;10301.9484902575;11609.771624094677;11966.46150923193;12039.699007524532;12240 20:45:31 INFO - PROCESS | 31337 | __end_tp_report 20:45:31 INFO - PROCESS | 31337 | __start_cc_report 20:45:31 INFO - PROCESS | 31337 | _x_x_mozilla_cycle_collect,1226 20:45:31 INFO - PROCESS | 31337 | __end_cc_report 20:45:31 INFO - PROCESS | 31337 | __startTimestamp1475293531441__endTimestamp 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | ------- Summary: start ------- 20:45:31 INFO - PROCESS | 31337 | Number of tests: 6 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#0] dojo.html Cycles:165 Average:5296.97 Median:5513.81 stddev:596.94 (10.8%) stddev-sans-first:571.61 20:45:31 INFO - PROCESS | 31337 | Values: 3027.5 3057.4 3058.3 3081.2 3086.6 5212.3 5252.5 5336.0 5341.6 5360.1 5267.7 5271.3 5297.6 5333.2 5336.8 4865.2 4889.1 4896.3 4900.2 4902.8 4868.3 4922.2 4933.4 4948.7 4953.9 4516.7 4921.4 4951.1 4951.9 5010.8 4783.1 4814.2 4823.0 4882.5 4896.1 4672.8 4775.3 4827.5 4830.3 4861.9 5306.5 5315.8 5322.3 5322.8 5369.3 5724.1 5727.3 5732.7 5794.9 5795.3 5604.5 5654.5 5767.2 5846.7 5859.9 5446.3 5455.3 5468.7 5469.4 5471.8 5972.2 5982.1 5989.3 5989.4 5990.9 5379.2 5414.0 5479.8 5517.0 5551.8 5566.4 5592.2 5596.4 5596.9 5660.3 5554.8 5561.9 5564.2 5565.2 5566.9 5522.0 5578.4 5589.4 5619.6 5640.8 4337.8 4345.7 4359.4 4370.3 4370.8 3887.8 3889.8 3926.3 3930.4 3955.8 5365.2 5378.0 5390.7 5394.2 5440.8 5535.4 5642.5 5645.8 5727.6 5761.8 5351.2 5366.2 5386.0 5430.3 5449.3 4962.5 5013.2 5030.0 5062.2 5066.2 5779.7 5795.3 5797.2 5801.3 5802.8 5513.8 5556.9 5564.5 5617.4 5683.1 5910.0 5924.7 5929.6 5947.4 6016.9 5644.7 5652.9 5655.8 5658.8 5659.5 5446.6 5710.4 5711.0 5752.4 5770.3 5369.1 5555.9 5598.3 5601.4 5660.6 5579.0 5583.2 5597.4 5602.5 5605.2 5493.9 5529.5 5545.6 5552.5 5625.9 5503.4 5559.1 5643.2 5687.0 5701.3 5530.5 5572.6 5578.6 5589.5 5644.4 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#1] ext.html Cycles:180 Average:55262.16 Median:190765.74 stddev:103048.33 (54.0%) stddev-sans-first:103255.52 20:45:31 INFO - PROCESS | 31337 | Values: 546.8 583.9 600.3 605.9 608.6 31522.2 32355.9 41254.8 41709.2 41715.6 39097.8 42767.0 42854.8 42882.1 42999.6 7911.2 8769.9 8895.6 8910.2 8917.8 7897.6 10510.8 10844.5 10850.8 11227.4 11016.4 11064.7 11074.6 11083.2 11085.1 10850.9 10928.5 10936.3 10955.6 10964.0 10629.1 10680.3 10696.9 10697.4 10702.0 42877.8 43038.4 43130.6 43290.4 43292.8 3653.0 3711.5 3796.4 3957.2 4024.3 30942.4 32138.7 32403.0 32445.8 32831.7 4178.0 4311.6 4372.9 4386.5 4499.6 311851.0 312261.0 312791.0 313297.0 314565.0 58585.4 59021.4 59052.0 59069.4 59097.0 60586.4 61009.4 61156.7 61160.1 61254.7 15936.4 16052.4 16070.4 16086.1 16094.4 11075.5 11099.6 12796.6 13346.5 13415.3 14642.7 14721.7 14869.9 14962.4 15147.5 6053.6 6267.6 6313.2 6347.9 6494.4 911.2 978.2 1000.4 1023.7 1043.9 30714.7 30804.2 31129.0 31237.8 31630.5 1091.1 1093.6 1105.9 1109.5 1120.9 15993.7 16516.6 16557.0 16611.4 16904.3 462415.0 462593.0 464581.0 465050.0 465296.0 55063.4 55518.4 55649.0 55654.0 55785.7 1202.7 1247.3 1310.9 1330.4 1348.1 28604.6 32681.3 32964.8 33122.2 33250.8 46315.6 46842.0 46885.3 46887.8 46929.0 377820.0 380606.0 381148.0 381448.0 381667.0 38946.6 39544.2 40335.0 40430.6 40431.0 44305.8 44964.3 45597.0 45774.5 46191.3 38422.6 38907.0 39151.3 40202.8 40675.0 38073.2 38435.0 38763.2 39659.2 40016.8 33207.5 33836.7 34204.1 34639.8 34785.3 33190.5 35373.5 36034.8 36614.6 36728.6 27516.3 27709.4 28145.6 28263.0 28279.0 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#2] jquery.html Cycles:180 Average:27445.77 Median:1735.02 stddev:73067.76 (4211.4%) stddev-sans-first:73244.43 20:45:31 INFO - PROCESS | 31337 | Values: 359.9 373.3 391.3 393.9 409.6 14204.4 18158.9 18365.0 19243.2 20351.0 17289.1 17430.4 17449.0 17503.6 18367.0 5508.9 5792.0 5805.5 5811.7 5835.3 3993.6 4761.6 5680.3 5777.4 5779.0 6242.5 6354.5 6355.7 6361.9 6363.9 6138.2 6357.9 6361.5 6429.5 6429.5 5637.1 5641.3 5645.8 5648.1 5649.9 22762.6 22844.3 22897.7 22903.8 22910.8 2395.7 2625.2 2896.0 3085.0 3110.1 13950.7 14252.8 14282.2 14383.8 14634.5 1879.6 1925.2 1971.3 1974.3 1979.7 50226.2 80475.0 82341.6 82921.0 85624.0 9145.1 9536.5 10346.7 10736.2 10749.4 14798.0 14847.3 14858.0 14861.5 14867.8 7988.3 8138.5 8154.8 8366.8 8435.7 7625.9 7814.6 7888.2 7960.6 8284.5 6250.5 6370.6 6378.8 6378.9 6449.4 1844.6 1887.9 1904.1 1951.3 1953.5 863.9 956.1 958.2 1041.1 1051.3 18071.3 19461.1 19760.3 20865.5 21037.5 967.9 971.3 975.4 1002.2 1065.0 10667.5 10889.7 10965.5 10992.1 11091.3 393633.0 429437.0 456722.0 461170.0 463850.0 91180.5 93695.0 93769.0 94469.5 94758.0 1047.8 1074.1 1080.1 1097.8 1100.3 16553.8 16704.6 17566.6 17579.2 17961.6 40063.9 40868.6 42171.4 42401.8 43789.8 51270.5 53130.0 54140.7 54508.7 57383.4 8383.7 8418.6 8572.7 8696.2 8773.9 11322.8 12368.9 12504.7 12633.9 13256.3 11023.7 11066.7 11107.2 11209.2 11274.9 10638.1 10768.8 10824.0 11149.1 11407.8 11205.2 11304.8 11583.4 11606.8 11833.5 8317.8 8343.2 8395.9 8457.9 8598.4 8805.7 10841.7 10844.6 11034.2 11151.3 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#3] mootools.html Cycles:180 Average:5932.12 Median:459.12 stddev:3542.06 (771.5%) stddev-sans-first:3535.19 20:45:31 INFO - PROCESS | 31337 | Values: 1341.3 1461.8 1486.6 1611.9 1775.6 7901.4 8726.2 9104.3 9113.8 9376.5 9151.7 9213.5 9222.9 9231.7 9245.1 2295.0 2315.3 2317.1 2317.5 2320.8 2248.5 2266.5 2318.8 2319.9 2329.3 2276.5 2288.9 2302.8 2318.8 2320.9 2215.9 2224.2 2228.7 2234.6 2235.0 2213.5 2238.1 2238.7 2240.5 2264.8 9065.0 9148.1 9220.8 9239.0 9240.3 5299.3 5458.1 5464.6 5466.8 5474.1 3446.3 3482.1 3508.8 3512.1 3554.4 1102.6 1112.2 1114.6 1122.6 1146.9 12883.5 12977.0 13054.6 13068.9 13088.7 4399.3 4539.2 4646.8 4702.2 4732.9 10084.8 10100.8 10102.0 10105.4 10110.7 5389.0 5395.5 5400.6 5402.8 5404.9 4253.3 4401.7 4887.6 5003.2 5057.3 3793.6 3825.9 3846.8 3867.6 3944.9 1166.6 1191.7 1215.7 1220.2 1226.3 901.5 911.7 921.0 949.7 968.4 5625.3 5796.6 5819.7 5883.8 6096.4 447.5 457.9 460.4 463.7 464.5 3730.9 3793.3 3870.8 3871.6 3987.3 11371.4 11701.8 11776.8 11786.1 11787.4 11484.4 11649.5 11709.4 11858.3 11881.0 8585.4 8590.6 8675.6 8689.2 8729.8 5734.3 5795.7 5803.3 5806.0 5903.8 10510.4 10645.7 10760.0 10805.1 10931.2 10873.8 10993.6 11007.7 11132.3 11151.9 7523.2 7581.5 7639.2 7781.9 7796.3 8995.8 9076.8 9097.4 9121.2 9134.4 7773.1 7779.6 7962.3 8029.6 8137.0 7641.1 7785.7 7817.2 7832.8 7853.2 7014.6 7109.5 7109.9 7118.8 7124.2 4903.8 4998.2 5056.8 5127.5 5296.1 4936.2 5080.3 5099.7 5141.4 5226.1 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#4] prototype.html Cycles:180 Average:4352.31 Median:4790.67 stddev:1216.18 (25.4%) stddev-sans-first:1181.54 20:45:31 INFO - PROCESS | 31337 | Values: 330.9 342.9 347.4 348.5 350.0 5111.8 5286.3 5327.9 5379.1 5391.1 5076.3 5197.0 5219.3 5220.4 5242.2 4172.5 4186.8 4193.5 4195.9 4208.7 3994.6 4079.9 4207.0 4211.6 4218.8 4112.1 4115.8 4120.9 4125.5 4126.5 4105.8 4112.6 4117.8 4121.8 4138.2 3631.8 3660.4 3662.3 3666.3 3668.4 5042.4 5097.4 5107.2 5138.2 5150.4 4699.3 4704.7 4706.7 4710.6 4717.4 5472.7 5479.5 5482.3 5491.8 5498.5 3818.8 3981.2 4012.7 4013.6 4023.4 5675.3 5694.3 5719.4 5737.8 5785.8 4096.1 4104.2 4107.6 4111.9 4122.3 3911.0 4084.3 4087.3 4112.7 4131.2 4657.4 4667.9 4691.9 4698.6 4698.8 5514.6 5520.9 5541.7 5546.2 5560.6 1340.4 1351.6 1413.7 1415.8 1418.3 895.5 898.0 917.4 929.2 929.7 4740.1 4747.8 4759.9 4766.2 4789.9 4860.3 4879.2 5027.3 5033.5 5040.5 4377.6 4631.4 4647.8 4657.6 4681.3 2639.6 2651.8 2651.9 2653.8 2660.1 5072.9 5094.0 5102.7 5111.4 5134.7 4734.9 4988.9 4991.4 5006.0 5101.7 5160.7 5163.6 5182.9 5205.9 5212.3 4966.9 4986.3 4998.0 5034.2 5041.3 4715.2 4795.7 4898.2 4934.5 4956.8 5092.5 5093.8 5116.4 5125.6 5136.3 3680.4 3680.7 3697.6 3704.6 3720.9 4718.5 4862.8 4941.9 4958.3 4975.7 4755.0 4803.3 4811.0 4900.0 4901.2 4783.8 4788.1 4836.3 4854.2 4881.2 4608.4 4764.6 4809.3 4838.3 4863.8 4889.8 4908.4 4908.9 4921.6 4923.6 4737.6 4770.2 4774.3 4791.4 4831.3 20:45:31 INFO - PROCESS | 31337 | 20:45:31 INFO - PROCESS | 31337 | [#5] yui.html Cycles:180 Average:20882.45 Median:25308.43 stddev:30837.98 (121.8%) stddev-sans-first:30887.26 20:45:31 INFO - PROCESS | 31337 | Values: 702.7 706.5 748.7 785.8 815.2 14067.7 14538.1 14551.2 14555.0 14560.3 13675.7 15067.2 15107.3 15149.2 15179.3 652.0 780.9 781.0 787.2 791.3 672.6 786.4 813.3 815.7 820.4 847.6 849.9 850.0 850.1 850.6 684.6 842.7 843.6 843.6 844.4 510.1 602.7 613.2 617.4 618.3 14611.4 14679.6 14697.5 14700.0 14729.9 13533.3 13925.3 14133.4 14226.9 14256.9 11605.9 11726.2 11734.1 11770.8 11901.6 4331.3 4340.3 4426.0 4435.4 4460.3 64215.0 66975.0 80737.0 81076.2 81783.0 11078.0 11328.3 11445.5 11498.7 11683.9 20999.6 21025.0 21106.2 21129.9 21136.9 8461.4 8571.8 8591.8 8849.1 9052.1 4695.3 4879.3 4928.4 4939.0 5083.9 3510.0 3599.5 3617.2 3622.0 3633.1 648.0 651.1 651.2 666.5 668.9 631.9 646.7 677.4 682.4 735.7 9088.9 9853.2 9901.2 9952.3 10007.4 642.9 679.0 695.6 712.6 735.4 4711.2 4939.4 4953.1 4970.9 4990.8 117241.0 122067.4 122847.0 125577.0 127103.2 83531.6 105414.0 105716.5 108994.5 109846.0 64555.7 93498.0 96279.0 97758.5 98002.0 8901.4 9048.0 9087.7 9314.4 9359.0 43111.4 46557.8 54830.2 54849.0 55534.4 46156.5 62903.0 68209.3 73318.3 73558.6 11129.8 11205.9 11331.8 11596.4 11688.6 13260.1 13406.0 13714.5 14910.6 15170.3 13891.9 13938.2 13978.7 14367.1 14835.1 12963.5 13374.7 13382.7 13767.2 14298.7 13753.3 14447.3 14682.9 14686.3 15013.2 11516.5 11618.5 11704.6 11836.3 11891.0 10301.9 11609.8 11966.5 12039.7 12240.0 20:45:31 INFO - PROCESS | 31337 | -------- Summary: end -------- 20:45:31 INFO - PROCESS | 31337 | 20:45:32 INFO - TEST-INFO | 31337: exit 0 20:45:32 INFO - TEST-OK | dromaeo_css | took 1116334ms 20:45:32 INFO - TEST-START | kraken 20:45:32 INFO - operating with platform_type : linux_ 20:45:32 INFO - Initialising browser for kraken test... 20:45:32 INFO - TEST-INFO | started process 31648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOrp57u/profile http://localhost:47160/getInfo.html) 20:45:36 INFO - PROCESS | 31648 | __metrics Screen width/height:1600/1200 20:45:36 INFO - PROCESS | 31648 | colorDepth:24 20:45:36 INFO - PROCESS | 31648 | Browser inner width/height: 1024/697 20:45:36 INFO - PROCESS | 31648 | __metrics 20:45:37 INFO - PROCESS | 31648 | 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" 20:45:37 INFO - PROCESS | 31648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:45:37 INFO - PROCESS | 31648 | console.error: PushService: 20:45:37 INFO - PROCESS | 31648 | stateChangeProcessEnqueue: Error transitioning state 20:45:37 INFO - PROCESS | 31648 | UnknownError 20:45:38 INFO - TEST-INFO | 31648: exit 0 20:45:38 INFO - Browser initialized. 20:45:38 INFO - Running cycle 1/1 for kraken test... 20:45:38 INFO - TEST-INFO | started process 31729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOrp57u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:45:50 INFO - PROCESS | 31729 | RSS: Main: 173584384 20:45:50 INFO - PROCESS | 31729 | 20:45:53 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47160/tests/kraken/driver.html?testName=audio-beat-detection) 20:45:54 INFO - PROCESS | 31729 | RSS: Main: 240898048 20:45:54 INFO - PROCESS | 31729 | 20:45:56 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47160/tests/kraken/driver.html?testName=audio-dft) 20:45:57 INFO - PROCESS | 31729 | RSS: Main: 217669632 20:45:57 INFO - PROCESS | 31729 | 20:46:00 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47160/tests/kraken/driver.html?testName=audio-fft) 20:46:01 INFO - PROCESS | 31729 | RSS: Main: 298844160 20:46:01 INFO - PROCESS | 31729 | 20:46:03 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47160/tests/kraken/driver.html?testName=audio-oscillator) 20:46:03 INFO - PROCESS | 31729 | RSS: Main: 208896000 20:46:03 INFO - PROCESS | 31729 | 20:46:06 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:46:06 INFO - PROCESS | 31729 | RSS: Main: 212426752 20:46:06 INFO - PROCESS | 31729 | 20:46:09 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47160/tests/kraken/driver.html?testName=imaging-darkroom) 20:46:10 INFO - PROCESS | 31729 | RSS: Main: 249335808 20:46:10 INFO - PROCESS | 31729 | 20:46:13 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47160/tests/kraken/driver.html?testName=imaging-desaturate) 20:46:14 INFO - PROCESS | 31729 | RSS: Main: 248238080 20:46:14 INFO - PROCESS | 31729 | 20:46:17 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47160/tests/kraken/driver.html?testName=json-parse-financial) 20:46:17 INFO - PROCESS | 31729 | RSS: Main: 248500224 20:46:17 INFO - PROCESS | 31729 | 20:46:19 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:46:19 INFO - PROCESS | 31729 | RSS: Main: 210604032 20:46:19 INFO - PROCESS | 31729 | 20:46:21 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:46:22 INFO - PROCESS | 31729 | RSS: Main: 216842240 20:46:22 INFO - PROCESS | 31729 | 20:46:24 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:46:24 INFO - PROCESS | 31729 | RSS: Main: 222568448 20:46:24 INFO - PROCESS | 31729 | 20:46:27 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:46:28 INFO - PROCESS | 31729 | RSS: Main: 224026624 20:46:28 INFO - PROCESS | 31729 | 20:46:30 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:46:31 INFO - PROCESS | 31729 | RSS: Main: 222146560 20:46:31 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | Cycle 1(1): loaded http://localhost:47160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47160/tests/kraken/driver.html?testName=ai-astar) 20:46:33 INFO - PROCESS | 31729 | RSS: Main: 273334272 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | __start_tp_report 20:46:33 INFO - PROCESS | 31729 | _x_x_mozilla_page_load 20:46:33 INFO - PROCESS | 31729 | _x_x_mozilla_page_load_details 20:46:33 INFO - PROCESS | 31729 | |i|pagename|runs| 20:46:33 INFO - PROCESS | 31729 | |0;ai-astar;108;111;113;110;110;110;111;111;111;112 20:46:33 INFO - PROCESS | 31729 | |1;audio-beat-detection;147;122;121;179;125;125;122;127;160;124 20:46:33 INFO - PROCESS | 31729 | |2;audio-dft;161;162;161;160;163;161;161;161;161;161 20:46:33 INFO - PROCESS | 31729 | |3;audio-fft;74;76;76;113;77;76;76;77;120;75 20:46:33 INFO - PROCESS | 31729 | |4;audio-oscillator;83;82;108;83;83;84;105;83;82;110 20:46:33 INFO - PROCESS | 31729 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 20:46:33 INFO - PROCESS | 31729 | |6;imaging-darkroom;149;149;148;150;149;149;148;150;149;146 20:46:33 INFO - PROCESS | 31729 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 20:46:33 INFO - PROCESS | 31729 | |8;json-parse-financial;54;53;52;53;54;53;55;53;53;53 20:46:33 INFO - PROCESS | 31729 | |9;json-stringify-tinderbox;61;60;60;61;61;61;61;60;60;61 20:46:33 INFO - PROCESS | 31729 | |10;stanford-crypto-aes;86;80;78;79;88;80;81;79;79;79 20:46:33 INFO - PROCESS | 31729 | |11;stanford-crypto-ccm;130;127;131;142;146;133;128;132;159;139 20:46:33 INFO - PROCESS | 31729 | |12;stanford-crypto-pbkdf2;175;169;170;171;170;168;169;169;173;169 20:46:33 INFO - PROCESS | 31729 | |13;stanford-crypto-sha256-iterative;67;66;69;67;67;67;67;66;66;66 20:46:33 INFO - PROCESS | 31729 | __end_tp_report 20:46:33 INFO - PROCESS | 31729 | __start_cc_report 20:46:33 INFO - PROCESS | 31729 | _x_x_mozilla_cycle_collect,1600 20:46:33 INFO - PROCESS | 31729 | __end_cc_report 20:46:33 INFO - PROCESS | 31729 | __startTimestamp1475293593482__endTimestamp 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | ------- Summary: start ------- 20:46:33 INFO - PROCESS | 31729 | Number of tests: 14 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.00 20:46:33 INFO - PROCESS | 31729 | Values: 108.0 111.0 113.0 110.0 110.0 110.0 111.0 111.0 111.0 112.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:126.00 stddev:20.07 (15.9%) stddev-sans-first:20.82 20:46:33 INFO - PROCESS | 31729 | Values: 147.0 122.0 121.0 179.0 125.0 125.0 122.0 127.0 160.0 124.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 20:46:33 INFO - PROCESS | 31729 | Values: 161.0 162.0 161.0 160.0 163.0 161.0 161.0 161.0 161.0 161.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:17.23 (22.7%) stddev-sans-first:17.89 20:46:33 INFO - PROCESS | 31729 | Values: 74.0 76.0 76.0 113.0 77.0 76.0 76.0 77.0 120.0 75.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.00 stddev:12.06 (14.5%) stddev-sans-first:12.49 20:46:33 INFO - PROCESS | 31729 | Values: 83.0 82.0 108.0 83.0 83.0 84.0 105.0 83.0 82.0 110.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:46:33 INFO - PROCESS | 31729 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 20:46:33 INFO - PROCESS | 31729 | Values: 149.0 149.0 148.0 150.0 149.0 149.0 148.0 150.0 149.0 146.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 20:46:33 INFO - PROCESS | 31729 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 20:46:33 INFO - PROCESS | 31729 | Values: 54.0 53.0 52.0 53.0 54.0 53.0 55.0 53.0 53.0 53.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:46:33 INFO - PROCESS | 31729 | Values: 61.0 60.0 60.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.35 (4.2%) stddev-sans-first:3.00 20:46:33 INFO - PROCESS | 31729 | Values: 86.0 80.0 78.0 79.0 88.0 80.0 81.0 79.0 79.0 79.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:136.00 stddev:10.00 (7.4%) stddev-sans-first:10.31 20:46:33 INFO - PROCESS | 31729 | Values: 130.0 127.0 131.0 142.0 146.0 133.0 128.0 132.0 159.0 139.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.00 stddev:2.16 (1.3%) stddev-sans-first:1.48 20:46:33 INFO - PROCESS | 31729 | Values: 175.0 169.0 170.0 171.0 170.0 168.0 169.0 169.0 173.0 169.0 20:46:33 INFO - PROCESS | 31729 | 20:46:33 INFO - PROCESS | 31729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 20:46:33 INFO - PROCESS | 31729 | Values: 67.0 66.0 69.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 20:46:33 INFO - PROCESS | 31729 | -------- Summary: end -------- 20:46:33 INFO - PROCESS | 31729 | 20:46:34 INFO - TEST-INFO | 31729: exit 0 20:46:34 INFO - TEST-OK | kraken | took 62322ms 20:46:34 INFO - SUITE-END | took 1178s 20:46:35 INFO - Completed test suite (00:19:39) 20:46:35 INFO - javascript benchmark 20:46:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.5307327364258, 3057.4496590613694, 3058.2660161561216, 3081.229692576856, 3086.5524498947666, 5212.2963399941, 5252.501012403825, 5335.986162629098, 5341.572674186065, 5360.08878490657, 5267.65760225586, 5271.288376069229, 5297.576193904488, 5333.2000199970025, 5336.813211537587, 4865.221564549673, 4889.119958407486, 4896.265560165968, 4900.240462728283, 4902.779374928119, 4868.342773725555, 4922.187839006559, 4933.358663373757, 4948.7278199699, 4953.876153096166, 4516.661250406216, 4921.360223170983, 4951.108800415924, 4951.851444456672, 5010.799568017275, 4783.067301876135, 4814.229723244264, 4823.03539292143, 4882.487338829407, 4896.1186986342445, 4672.789724462374, 4775.331453596499, 4827.493113223131, 4830.29960655703, 4861.878453038702, 5306.52241298285, 5315.840524784263, 5322.334708161441, 5322.787088516455, 5369.301990741218, 5724.084146536576, 5727.284089488814, 5732.713364331767, 5794.913076303858, 5795.3045634523705, 5604.495595396393, 5654.547636189095, 5767.22142510764, 5846.736896839652, 5859.912101318441, 5446.319210098738, 5455.345358556959, 5468.699221542854, 5469.398366179677, 5471.753771080311, 5972.223610930551, 5982.102684597346, 5989.251343582052, 5989.371116032841, 5990.850228744316, 5379.193121031876, 5414.025475414384, 5479.780808767684, 5517.034518959166, 5551.750171242304, 5566.415526369754, 5592.245046918695, 5596.412376700469, 5596.916046259309, 5660.320761508563, 5554.777808887599, 5561.888762224733, 5564.1931919871395, 5565.193047008162, 5566.860828479321, 5522.0, 5578.386377498472, 5589.413111623302, 5619.578531610146, 5640.802571909963, 4337.82648694055, 4345.652347812231, 4359.433273674402, 4370.322599997005, 4370.759608221579, 3887.844486220576, 3889.7860617665733, 3926.2540117377607, 3930.3711406174875, 3955.802209889494, 5365.168398898177, 5377.973110134424, 5390.703511306838, 5394.190871369247, 5440.809571664972, 5535.391106978229, 5642.548596112301, 5645.80239691617, 5727.570432217601, 5761.790024094903, 5351.224072509464, 5366.221897824794, 5386.0, 5430.266913966643, 5449.264349312872, 4962.454130045692, 5013.172826483662, 5029.974850125726, 5062.190049592047, 5066.189409694505, 5779.682117483579, 5795.304563452329, 5797.246357973437, 5801.332846722681, 5802.796902108406, 5513.807016754395, 5556.91664625039, 5564.527015203753, 5617.43825617435, 5683.06229472149, 5910.0, 5924.7037648118285, 5929.644221346733, 5947.375525569752, 6016.939830601638, 5644.717764111861, 5652.886942261214, 5655.773769049192, 5658.830235092953, 5659.518940890071, 5446.564274857923, 5710.4004079572705, 5710.971445142748, 5752.395998420273, 5770.336411312753, 5369.060414427381, 5555.916661250165, 5598.3282006159525, 5601.411851755507, 5660.632058916157, 5579.0, 5583.162525621027, 5597.356304025089, 5602.52378547828, 5605.159226115952, 5493.890122197614, 5529.474699903502, 5545.556355491471, 5552.472515111058, 5625.943740562542, 5503.422140675171, 5559.138333558305, 5643.153526970823, 5687.0, 5701.258836351248, 5530.529904958124, 5572.554195664256, 5578.63738856973, 5589.496945274945, 5644.379118297066], "value": 5256.805770930748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7650526796243, 583.9211706419634, 600.2676734384055, 605.9244840408275, 608.5831205624146, 31522.211944701394, 32355.852388046285, 41254.7937260314, 41709.16581668365, 41715.58284417155, 39097.804510977476, 42767.0, 42854.78572607133, 42882.142357152836, 42999.570004299945, 7911.169327220645, 8769.912300876973, 8895.555222238894, 8910.242629376511, 8917.777055573597, 7897.644605992716, 10510.842337364908, 10844.457777111153, 10850.782984340309, 11227.382493962828, 11016.394098324588, 11064.668059958174, 11074.557017719282, 11083.168762342857, 11085.057770089552, 10850.891491085067, 10928.453577321103, 10936.343819370863, 10955.616553420672, 10964.013238808466, 10629.149668026617, 10680.25238233324, 10696.893031069667, 10697.411642359668, 10702.0, 42877.78561107206, 43038.35442468365, 43130.56869431297, 43290.350644740356, 43292.78353608243, 3653.013686304683, 3711.480392745018, 3796.373598356268, 3957.228340473609, 4024.255512730125, 30942.381152377053, 32138.678613213804, 32403.0, 32445.83777081123, 32831.6716832831, 4178.0, 4311.611954924072, 4372.934405983913, 4386.517483076891, 4499.61753250974, 311851.0, 312261.0, 312791.0, 313297.0, 314565.0, 58585.41414585885, 59021.40978590245, 59052.0, 59069.40930590725, 59097.0, 60586.39413605807, 61009.389906101256, 61156.69421652863, 61160.08259876105, 61254.693726531084, 15936.36254549805, 16052.438164664181, 16070.43753468623, 16086.115263660377, 16094.436694715629, 11075.50160242791, 11099.5560177592, 12796.61610151697, 13346.46614135443, 13415.262160581067, 14642.707145857235, 14721.705565888622, 14869.925650371895, 14962.40150393972, 15147.469838555819, 6053.576249662481, 6267.592606480564, 6313.179286692701, 6347.936520634735, 6494.350564943468, 911.1981456318398, 978.2076518020426, 1000.3847633705219, 1023.6673081248624, 1043.9060484556426, 30714.69285307163, 30804.229894252374, 31129.0, 31237.843810781254, 31630.525542116888, 1091.110744743032, 1093.5680406239492, 1105.8507101541188, 1109.5450865145413, 1120.8991190792867, 15993.680126397407, 16516.587085322964, 16557.0, 16611.41860034893, 16904.323827047025, 462415.0, 462593.0, 464581.0, 465050.0, 465296.0, 55063.44936550663, 55518.44481555214, 55649.0, 55654.0, 55785.72107139519, 1202.6933132051272, 1247.2703468470866, 1310.927898965528, 1330.4478641363726, 1348.0967751606447, 28604.570931435628, 32681.34637307193, 32964.835175823966, 33122.17194570059, 33250.833745831114, 46315.60001799824, 46842.0, 46885.29672054854, 46887.765561171975, 46929.0, 377820.0, 380606.0, 381148.0, 381448.0, 381667.0, 38946.6105338943, 39544.2091158181, 40335.0, 40430.595694042684, 40431.0, 44305.778471107435, 44964.325535116346, 45597.0, 45774.54225457703, 46191.30713039375, 38422.615773841906, 38907.0, 39151.34427147335, 40202.798986004884, 40675.0, 38073.23853522969, 38435.0, 38763.2247355057, 39659.2068158641, 40016.79991600024, 33207.50188747219, 33836.66163338335, 34204.14489637779, 34639.826800866846, 34785.30429391449, 33190.502142468365, 35373.469397958535, 36034.819825900704, 36614.63385366219, 36728.63271367252, 27516.312092197855, 27709.445811083264, 28145.577816332363, 28263.0, 28279.0], "value": 19853.861336923692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.89023347878884, 373.31869338457324, 391.3288709862585, 393.8641168796765, 409.6067774936061, 14204.36080376383, 18158.909205453987, 18364.99999999998, 19243.230270789187, 20351.0, 17289.13554322282, 17430.38993635223, 17449.0, 17503.649927001483, 18366.98981556014, 5508.889822203543, 5792.044312688401, 5805.477507024367, 5811.738471768759, 5835.270591176103, 3993.560708322082, 4761.642876784238, 5680.261565996415, 5777.364489906107, 5779.046457334534, 6242.531810114237, 6354.491640668759, 6355.650439225864, 6361.886669832761, 6363.872722545546, 6138.202033735631, 6357.93642063578, 6361.459275961549, 6429.54993150475, 6429.54993150475, 5637.069883469264, 5641.323041235037, 5645.802396916089, 5648.124540696199, 5649.887002259973, 22762.585612158142, 22844.31467055991, 22897.656535151986, 22903.77096229033, 22910.77089229103, 2395.6646069550275, 2625.2124362691115, 2896.000879696501, 3085.0, 3110.144710204689, 13950.651233719136, 14252.786208206782, 14282.214478203694, 14383.78424323636, 14634.487792927303, 1879.6240751849684, 1925.1721759643349, 1971.3001884331143, 1974.2892558678864, 1979.6733538966052, 50226.246606300934, 80475.0, 82341.58829205876, 82921.0, 85623.99999999937, 9145.131212534798, 9536.475493847765, 10346.689599312032, 10736.248462607542, 10749.40878251688, 14798.0, 14847.331870065873, 14858.03422777516, 14861.479848205261, 14867.776983345258, 7988.334745512259, 8138.470999385021, 8154.796130096795, 8366.832663346699, 8435.70475033383, 7625.923740762521, 7814.648340824677, 7888.211178882066, 7960.56216908064, 8284.461510001951, 6250.468710159596, 6370.554061215763, 6378.840528986812, 6378.872422551616, 6449.355064493607, 1844.6480737060356, 1887.8867267963692, 1904.124102912648, 1951.3170390363543, 1953.5116220944765, 863.9006514250816, 956.1490273656451, 958.242988039455, 1041.146260066738, 1051.3271506236015, 18071.27714891416, 19461.12424940881, 19760.308389206595, 20865.478363041046, 21037.474063148544, 967.8935317115112, 971.2618410008445, 975.3855071305032, 1002.1832206751474, 1065.0148612533376, 10667.466626668636, 10889.746427752243, 10965.50655220517, 10992.065674417765, 11091.33451992883, 393633.0, 429437.0, 456722.0, 461170.0, 463850.0, 91180.54409727908, 93695.0, 93769.0, 94469.5276523613, 94758.0, 1047.7537778622018, 1074.0655629602295, 1080.0765345629375, 1097.7804439112049, 1100.2793170473353, 16553.751693724844, 16704.582385440463, 17566.648667026333, 17579.208935598184, 17961.550961226072, 40063.91589385155, 40868.59131408648, 42171.36742948797, 42401.78799105985, 43789.78105109454, 51270.48729512806, 53130.0, 54140.72929635327, 54508.72745636405, 57383.42616573781, 8383.748487545383, 8418.5790710463, 8572.657093716181, 8696.21734043939, 8773.912260877565, 11322.773544529227, 12368.876311236772, 12504.687382815502, 12633.93683031579, 13256.337183140997, 11023.72440688957, 11066.667999960015, 11107.222494425312, 11209.215354925076, 11274.926332841429, 10638.095761860328, 10768.784624307627, 10823.971722686332, 11149.108071354434, 11407.771844563229, 11205.215634905479, 11304.83042754343, 11583.420828958688, 11606.825897611374, 11833.46749396262, 8317.833643326978, 8343.165683431609, 8395.916040839513, 8457.915420845959, 8598.441101328644, 8805.735827925173, 10841.67474975752, 10844.566217351534, 11034.172437067413, 11151.330920144817], "value": 9272.789990657955, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2623057318472, 1461.8245810502738, 1486.5688950204437, 1611.919404029799, 1775.6093659394937, 7901.407394445418, 8726.171013753692, 9104.271658267347, 9113.817723645523, 9376.484293363863, 9151.67969121081, 9213.493257870814, 9222.861657075133, 9231.723048308544, 9245.075492450751, 2294.999999999996, 2315.340128063502, 2317.084751523147, 2317.5249073939885, 2320.825938054644, 2248.5278091600785, 2266.478709896725, 2318.8376813623054, 2319.895604697784, 2329.3477826208687, 2276.499170182557, 2288.931332060041, 2302.781235782598, 2318.802901753353, 2320.907163713458, 2215.878126703031, 2224.232639739287, 2228.687983682286, 2234.575430668168, 2235.005422586941, 2213.4798322394226, 2238.1271304191378, 2238.708967834187, 2240.462289050616, 2264.750877403484, 9065.0, 9148.130927561871, 9220.815583688289, 9239.0, 9240.260779137652, 5299.284596579451, 5458.099413596752, 5464.617476776627, 5466.808661696821, 5474.09677403228, 3446.293509830479, 3482.0946553895915, 3508.7894726316504, 3512.0868574170645, 3554.377983852841, 1102.5755084292525, 1112.2047735868812, 1114.6433141394675, 1122.6407549584137, 1146.8910453506903, 12883.549075782397, 12977.0, 13054.608361749068, 13068.889144422736, 13088.738225235442, 4399.340098985178, 4539.205639013159, 4646.767661616906, 4702.177119004161, 4732.929006064912, 10084.798304033879, 10100.797984040424, 10102.0, 10105.39367637944, 10110.69667909964, 5389.02997460453, 5395.460453954652, 5400.648957817808, 5402.837914862561, 5404.945950540444, 4253.340732186516, 4401.713888597231, 4887.584555312838, 5003.224500202475, 5057.317262169634, 3793.563740169916, 3825.885223443301, 3846.8461261549223, 3867.613238676166, 3944.881653550398, 1166.5916929074756, 1191.737817680109, 1215.7082300247878, 1220.2312543097792, 1226.2826246645634, 901.4726385064811, 911.7401540560908, 920.963161473547, 949.6723630347657, 968.4141094637642, 5625.296837895263, 5796.594238403356, 5819.73811178498, 5883.764649414061, 6096.359882212392, 447.5032713687804, 457.8603525924625, 460.3715927758585, 463.726401423162, 464.5493870945178, 3730.850765969331, 3793.336166170909, 3870.806459677005, 3871.632194941476, 3987.302222111119, 11371.431428428545, 11701.765964680659, 11776.822317768154, 11786.116041296937, 11787.35169565665, 11484.368359740294, 11649.53401863933, 11709.414529273503, 11858.347790871585, 11881.049516038696, 8585.441946273471, 8590.59463350263, 8675.609597568124, 8689.217970382695, 8729.781755456037, 5734.34055083654, 5795.710214489174, 5803.332616749128, 5806.042003069615, 5903.822885313448, 10510.421926794099, 10645.680629581126, 10760.0, 10805.135589153006, 10931.180161488079, 10873.78252434931, 10993.61522346714, 11007.669769906915, 11132.276402033842, 11151.944240278746, 7523.172451030492, 7581.469297149147, 7639.159692433939, 7781.883271751041, 7796.298333150044, 8995.77510562215, 9076.818463630558, 9097.363184577016, 9121.179093881583, 9134.406263592846, 7773.1060927994, 7779.649915753692, 7962.283394494523, 8029.598520073856, 8136.959315203386, 7641.121271053677, 7785.727499537489, 7817.1791961845465, 7832.80417989532, 7853.214678532329, 7014.614196219257, 7109.537880037781, 7109.8578028438105, 7118.822029449305, 7124.21633620291, 4903.803847846189, 4998.225275082368, 5056.82301119459, 5127.512886275797, 5296.126139186991, 4936.234883593049, 5080.288759573737, 5099.745012749422, 5141.352203615066, 5226.085435048927], "value": 4588.9476828117295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.919547676835, 342.878278211235, 347.44062060083263, 348.4651060621946, 350.0042379430519, 5111.846644600659, 5286.303984967665, 5327.866803329914, 5379.112446446336, 5391.145331088271, 5076.263941728447, 5197.0, 5219.295395121658, 5220.441983428122, 5242.18746094356, 4172.497900755726, 4186.79066046698, 4193.475815523059, 4195.874123776284, 4208.684348673846, 3994.62051105146, 4079.898002549945, 4206.978965105171, 4211.599898009684, 4218.767967761772, 4112.05422752767, 4115.773632450229, 4120.896977575555, 4125.484314460692, 4126.484189476316, 4105.835766569334, 4112.568180341066, 4117.814698338552, 4121.80467664377, 4138.193052354792, 3631.800250986195, 3660.359437098497, 3662.285854258421, 3666.2667466506537, 3668.394714872043, 5042.445331013586, 5097.388313402378, 5107.182850743863, 5138.203578445309, 5150.407703114152, 4699.271612900006, 4704.741239231841, 4706.74112923789, 4710.646701497367, 4717.363155973934, 5472.701465384548, 5479.479449452296, 5482.342118945752, 5491.807786727445, 5498.477644623755, 3818.8472461101524, 3981.228353382746, 4012.7191096623246, 4013.5986401359924, 4023.436718859362, 5675.318961724578, 5694.288213973254, 5719.399463056402, 5737.82786516401, 5785.768569257225, 4096.139810639799, 4104.15864747726, 4107.589241075869, 4111.8972025698995, 4122.2786012447705, 3910.9804450977563, 4084.346504559256, 4087.3255912774653, 4112.670986321087, 4131.153113611763, 4657.394538709946, 4667.85278771762, 4691.906161876744, 4698.553637404441, 4698.8355407560575, 5514.641548299348, 5520.889582208413, 5541.722913854291, 5546.168074788814, 5560.638558493685, 1340.3968214303602, 1351.5607427586074, 1413.7064585903988, 1415.8390120101417, 1418.3404716806529, 895.4582477601087, 898.0, 917.3899356927702, 929.1730359979623, 929.7396728915915, 4740.132220006915, 4747.7626118693925, 4759.881002974953, 4766.212670248657, 4789.9042019160115, 4860.270959356054, 4879.243717223836, 5027.271045698353, 5033.496650334937, 5040.521150490697, 4377.627901628333, 4631.421072365954, 4647.837325693585, 4657.578059409088, 4681.250999840077, 2639.5512762830367, 2651.8387514175884, 2651.8541480218387, 2653.8009649276382, 2660.1246121484305, 5072.949270507248, 5094.0, 5102.719350435687, 5111.415461207038, 5134.666246693953, 4734.928976065362, 4988.925166122511, 4991.401031876126, 5005.974970125126, 5101.668391554537, 5160.664556803796, 5163.580015495693, 5182.922256166161, 5205.869853253624, 5212.322398088224, 4966.882451448395, 4986.32684587576, 4997.975010125072, 5034.219695947134, 5041.344625198701, 4715.198416269311, 4795.664303498722, 4898.191798353232, 4934.481879402611, 4956.82651107224, 5092.541671249605, 5093.7707803148205, 5116.411612664442, 5125.641205115606, 5136.332276803992, 3680.392735198662, 3680.6687398134295, 3697.6487233712755, 3704.5739739929177, 3720.8697695580527, 4718.504557021463, 4862.756862156807, 4941.901161976813, 4958.2810492477665, 4975.676581022367, 4754.95682763025, 4803.255495398219, 4810.975945120252, 4900.0444913243, 4901.240307752304, 4783.832565860317, 4788.066327066189, 4836.322914791862, 4854.2233242681, 4881.219004959189, 4608.423947006624, 4764.618830493621, 4809.326694262876, 4838.346823178826, 4863.805447782049, 4889.801998510387, 4908.361912951294, 4908.8772780680765, 4921.63087768426, 4923.606111510999, 4737.644676649334, 4770.2129148691465, 4774.283857421415, 4791.442781096088, 4831.299461578122], "value": 3974.612056212224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.701629711972, 706.5372181221301, 748.651876877252, 785.8271180340325, 815.2214635023553, 14067.718645627094, 14538.127712337267, 14551.199684017374, 14555.0, 14560.271986400678, 13675.726485470284, 15067.246637668128, 15107.320170592322, 15149.166795826226, 15179.316930738116, 652.044754434753, 780.8555417247799, 780.9921900780977, 787.1813314153273, 791.2720297326445, 672.576276945526, 786.4376970466116, 813.3330668851514, 815.7144999250245, 820.3888103363003, 847.6058632735777, 849.8597731374347, 850.0139837788167, 850.1243718969471, 850.5577099908076, 684.6029303004245, 842.6671464771442, 843.5613480989881, 843.616154649636, 844.3751623798406, 510.0971280832942, 602.6956387024568, 613.2365205319361, 617.4196255519797, 618.2766163588612, 14611.415543378253, 14679.559613211513, 14697.485588004476, 14700.044497107654, 14729.852701473063, 13533.323333833268, 13925.30373481332, 14133.363998620087, 14226.92886535571, 14256.92871535646, 11605.94197029018, 11726.237794543327, 11734.11994100446, 11770.823437648442, 11901.583444579484, 4331.306990881475, 4340.305551111807, 4425.955740442619, 4435.356873253392, 4460.33095035744, 64215.0, 66975.0, 80737.0, 81076.18923810746, 81783.0, 11077.955801379303, 11328.32030078198, 11445.54217831294, 11498.655040348804, 11683.883161168449, 20999.580008399746, 21025.0, 21106.15575376968, 21129.89435052815, 21136.894315528323, 8461.40770146084, 8571.757095221157, 8591.785205369915, 8849.115088491099, 9052.094790520896, 4695.3426520287185, 4879.316895634614, 4928.408590969107, 4939.0, 5083.940449794155, 3509.982450087733, 3599.5140656011627, 3617.2403795202777, 3621.9818900905325, 3633.109888077385, 647.9578827376206, 651.0852252585125, 651.1567520061437, 666.4634968850122, 668.8963210702349, 631.9210098737658, 646.6863571167979, 677.383580941341, 682.3926705232348, 735.7130719019586, 9088.863667045, 9853.211743060538, 9901.207903367713, 9952.25358098131, 10007.399556026516, 642.945349645276, 678.9815277084374, 695.6278391060758, 712.6150783777059, 735.3565630073685, 4711.175544279738, 4939.407271127488, 4953.1332016896895, 4970.875728106754, 4990.775415106329, 117240.96554206774, 122067.38966305289, 122847.0, 125577.0, 127103.2055512229, 83531.5823420879, 105414.0, 105716.47141764242, 108994.45502772435, 109846.0, 64555.677221613594, 93498.0, 96279.0, 97758.5112074435, 98002.0, 8901.421407608485, 9047.954760226157, 9087.727368178965, 9314.44113353201, 9358.953205233931, 43111.35332970071, 46557.76721116373, 54830.17754733762, 54849.0, 55534.44465555293, 46156.53843461657, 62903.0, 68209.31790682228, 73318.26681733114, 73558.63220684076, 11129.777404451703, 11205.943970280096, 11331.830022549833, 11596.420178990847, 11688.649340519798, 13260.138091024053, 13406.0, 13714.51999180024, 14910.62144095073, 15170.317335719697, 13891.861081389057, 13938.163710177421, 13978.650533736738, 14367.13797172173, 14835.10989340643, 12963.546275880299, 13374.665633359244, 13382.665433364244, 13767.242801646005, 14298.714025719635, 13753.312334383441, 14447.277636118362, 14682.853171468576, 14686.265686715835, 15013.249337532861, 11516.53933842637, 11618.477168527606, 11704.590339338083, 11836.289822610672, 11891.0, 10301.9484902575, 11609.771624094677, 11966.46150923193, 12039.699007524532, 12240.0], "value": 7525.561317991509, "unit": "score"}], "name": "dromaeo_css", "value": 7143.242135458319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 113.0, 110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 121.0, 179.0, 125.0, 125.0, 122.0, 127.0, 160.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 163.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 113.0, 77.0, 76.0, 76.0, 77.0, 120.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 83.0, 83.0, 84.0, 105.0, 83.0, 82.0, 110.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 150.0, 149.0, 149.0, 148.0, 150.0, 149.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 78.0, 79.0, 88.0, 80.0, 81.0, 79.0, 79.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 131.0, 142.0, 146.0, 133.0, 128.0, 132.0, 159.0, 139.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 170.0, 171.0, 170.0, 168.0, 169.0, 169.0, 173.0, 169.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1510.6, "alertThreshold": 2.0}]} 20:46:35 INFO - Return code: 0 20:46:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:46:35 INFO - # TBPL SUCCESS # 20:46:35 INFO - Running post-action listener: _resource_record_post_action 20:46:35 INFO - [mozharness: 2016-10-01 03:46:35.299544Z] Finished run-tests step (success) 20:46:35 INFO - Running post-run listener: _resource_record_post_run 20:46:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 408829952; Read time: 0; Write time: 249828 20:46:35 INFO - TinderboxPrint: CPU usage
13.2% 20:46:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:46:35 INFO - TinderboxPrint: I/O write bytes / time
408,829,952 / 249,828 20:46:35 INFO - TinderboxPrint: CPU idle
8,283.4 (86.8%) 20:46:35 INFO - TinderboxPrint: CPU user
1,207.9 (12.7%) 20:46:35 INFO - TinderboxPrint: Swap in / out
0 / 0 20:46:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116948992; Read time: 0; Write time: 59380 20:46:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288059392; Read time: 0; Write time: 190380 20:46:35 INFO - Running post-run listener: _upload_blobber_files 20:46:35 INFO - Blob upload gear active. 20:46:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:46:35 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 20:46:35 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:46:35 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:46:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:37 INFO - (blobuploader) - INFO - Done attempting. 20:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:46:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:37 INFO - (blobuploader) - INFO - Done attempting. 20:46:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:46:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:46:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:42 INFO - (blobuploader) - INFO - Done attempting. 20:46:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:46:42 INFO - Return code: 0 20:46:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:46:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:46:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3063ba1cf01d4e017c48073bab9f2aced903e77384fb0938defd95f5b9029d6f845e758223f3baa14fd7a6e18fcf8606f0a5707b1a46e603082e545ff9e74c0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28e8c7a9ed44d3d4cc4ba9aa0f0b801c39964c2b8149c94500a50d435193a46f5331fa32e8869c4b7c4d8b7c125e0679e9bcbeeeb2b0b305afe6386b6e99f284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be870e39b80c359c51b1d6e01eae9c2b3515a1da161c29c50f6563861a03c2ee3c216f6e56988fb8420bc4e21bdaf6c272e494d3b911d31261d40f63ac94868c"} 20:46:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:46:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:46:42 INFO - Contents: 20:46:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3063ba1cf01d4e017c48073bab9f2aced903e77384fb0938defd95f5b9029d6f845e758223f3baa14fd7a6e18fcf8606f0a5707b1a46e603082e545ff9e74c0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28e8c7a9ed44d3d4cc4ba9aa0f0b801c39964c2b8149c94500a50d435193a46f5331fa32e8869c4b7c4d8b7c125e0679e9bcbeeeb2b0b305afe6386b6e99f284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be870e39b80c359c51b1d6e01eae9c2b3515a1da161c29c50f6563861a03c2ee3c216f6e56988fb8420bc4e21bdaf6c272e494d3b911d31261d40f63ac94868c"} 20:46:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:46:42 INFO - Copying logs to upload dir... 20:46:42 INFO - mkdir: /builds/slave/test/build/upload/logs 20:46:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.813128 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 20:46:41.494199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 20:46:41.497626) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 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/sha512/3063ba1cf01d4e017c48073bab9f2aced903e77384fb0938defd95f5b9029d6f845e758223f3baa14fd7a6e18fcf8606f0a5707b1a46e603082e545ff9e74c0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28e8c7a9ed44d3d4cc4ba9aa0f0b801c39964c2b8149c94500a50d435193a46f5331fa32e8869c4b7c4d8b7c125e0679e9bcbeeeb2b0b305afe6386b6e99f284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be870e39b80c359c51b1d6e01eae9c2b3515a1da161c29c50f6563861a03c2ee3c216f6e56988fb8420bc4e21bdaf6c272e494d3b911d31261d40f63ac94868c"} build_url:https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/Jl2nkC9PRFy8zU1S519dbA/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/sha512/3063ba1cf01d4e017c48073bab9f2aced903e77384fb0938defd95f5b9029d6f845e758223f3baa14fd7a6e18fcf8606f0a5707b1a46e603082e545ff9e74c0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/28e8c7a9ed44d3d4cc4ba9aa0f0b801c39964c2b8149c94500a50d435193a46f5331fa32e8869c4b7c4d8b7c125e0679e9bcbeeeb2b0b305afe6386b6e99f284", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/be870e39b80c359c51b1d6e01eae9c2b3515a1da161c29c50f6563861a03c2ee3c216f6e56988fb8420bc4e21bdaf6c272e494d3b911d31261d40f63ac94868c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 20:46:41.527675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:46:41.528017) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475290742.770673-1838697225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 20:46:41.610718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 20:46:41.611489) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 20:46:41.612104) ========= ========= Total master_lag: 0.22 =========