builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1475828741.25 results: success (0) buildid: 20161006223005 builduid: d9a9850b6d184328be6c35b3a803829f revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.254878) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.255631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.255935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.322096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.322396) ========= 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=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 01:25:41-- 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% 42.7M=0s 2016-10-07 01:25:42 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.572372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.572927) ========= 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=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.624415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:41.624766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --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=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 01:25:42,245 truncating revision to first 12 chars 2016-10-07 01:25:42,245 Setting DEBUG logging. 2016-10-07 01:25:42,245 attempt 1/10 2016-10-07 01:25:42,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b9944879c9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 01:25:42,563 unpacking tar archive at: mozilla-central-4b9944879c9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644622 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:42.297285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:42.297686) ========= script_repo_revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:42.298219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:42.298578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 01:25:42.314625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-07 01:25:42.315027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:43 INFO - MultiFileLogger online at 20161007 01:25:43 in /builds/slave/test 01:25:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:25:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:43 INFO - {'append_to_log': False, 01:25:43 INFO - 'base_work_dir': '/builds/slave/test', 01:25:43 INFO - 'blob_upload_branch': 'Firefox', 01:25:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:43 INFO - 'branch': 'Firefox', 01:25:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:43 INFO - 'config_files': ('talos/linux_config.py',), 01:25:43 INFO - 'default_actions': ('clobber', 01:25:43 INFO - 'read-buildbot-config', 01:25:43 INFO - 'download-and-extract', 01:25:43 INFO - 'populate-webroot', 01:25:43 INFO - 'create-virtualenv', 01:25:43 INFO - 'install', 01:25:43 INFO - 'run-tests'), 01:25:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:43 INFO - 'download_minidump_stackwalk': True, 01:25:43 INFO - 'download_symbols': 'ondemand', 01:25:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:43 INFO - 'installer_path': 'installer.exe', 01:25:43 INFO - 'log_level': 'info', 01:25:43 INFO - 'log_name': 'talos', 01:25:43 INFO - 'log_to_console': True, 01:25:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:43 INFO - 'opt_config_files': (), 01:25:43 INFO - 'pip_index': False, 01:25:43 INFO - 'sps_profile': False, 01:25:43 INFO - 'sps_profile_interval': 0, 01:25:43 INFO - 'suite': 'dromaeojs-e10s', 01:25:43 INFO - 'system_bits': '32', 01:25:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:43 INFO - 'title': 'talos-linux64-ix-065', 01:25:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:43 INFO - 'use_talos_json': True, 01:25:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:43 INFO - 'work_dir': 'build'} 01:25:43 INFO - [mozharness: 2016-10-07 08:25:43.041030Z] Running clobber step. 01:25:43 INFO - Running pre-action listener: _resource_record_pre_action 01:25:43 INFO - Running main action method: clobber 01:25:43 INFO - rmtree: /builds/slave/test/build 01:25:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:44 INFO - Running post-action listener: _resource_record_post_action 01:25:44 INFO - [mozharness: 2016-10-07 08:25:44.027048Z] Finished clobber step (success) 01:25:44 INFO - [mozharness: 2016-10-07 08:25:44.027147Z] Running read-buildbot-config step. 01:25:44 INFO - Running pre-action listener: _resource_record_pre_action 01:25:44 INFO - Running main action method: read_buildbot_config 01:25:44 INFO - Using buildbot properties: 01:25:44 INFO - { 01:25:44 INFO - "project": "", 01:25:44 INFO - "product": "firefox", 01:25:44 INFO - "script_repo_revision": "production", 01:25:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:25:44 INFO - "repository": "", 01:25:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:25:44 INFO - "buildid": "20161006223005", 01:25:44 INFO - "pgo_build": "True", 01:25:44 INFO - "basedir": "/builds/slave/test", 01:25:44 INFO - "buildnumber": 388, 01:25:44 INFO - "slavename": "talos-linux64-ix-065", 01:25:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:25:44 INFO - "platform": "ubuntu64_hw", 01:25:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:25:44 INFO - "branch": "mozilla-central", 01:25:44 INFO - "repo_path": "mozilla-central", 01:25:44 INFO - "revision": "4b9944879c9a60a9aba4a744a7401bc38e0f39c4", 01:25:44 INFO - "stage_platform": "linux64-pgo", 01:25:44 INFO - "builduid": "d9a9850b6d184328be6c35b3a803829f", 01:25:44 INFO - "slavebuilddir": "test" 01:25:44 INFO - } 01:25:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:25:44 INFO - Running post-action listener: _resource_record_post_action 01:25:44 INFO - [mozharness: 2016-10-07 08:25:44.029605Z] Finished read-buildbot-config step (success) 01:25:44 INFO - [mozharness: 2016-10-07 08:25:44.029693Z] Running download-and-extract step. 01:25:44 INFO - Running pre-action listener: _resource_record_pre_action 01:25:44 INFO - Running main action method: download_and_extract 01:25:44 INFO - mkdir: /builds/slave/test/build/tests 01:25:44 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')]} 01:25:44 INFO - trying https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:44 INFO - Downloaded 1361 bytes. 01:25:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:25:44 INFO - Using the following test package requirements: 01:25:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'jsshell-linux-x86_64.zip'], 01:25:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:45 INFO - Http code: 200 01:25:45 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 01:25:45 INFO - x-amz-cf-id: e7U2ZbYnAfpF4AhWnvItFYuKHyi7aK_WoXeykKg6SMDAHags9rgaJQ== 01:25:45 INFO - x-amz-version-id: ENqAKZdcwkNp_PoIQSnv3.fyMJqaW9Lf 01:25:45 INFO - Expected file size: 22021944 01:25:45 INFO - Obtained file size: 22021944 01:25:49 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 01:25:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:25:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:25:50 INFO - Http code: 200 01:25:50 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 01:25:50 INFO - x-amz-cf-id: QvYNeGDw2whdH3A7F7nKyiS-LT9uruj7YAQP9lovjN-c9TfLL-FLZQ== 01:25:50 INFO - x-amz-version-id: ENqAKZdcwkNp_PoIQSnv3.fyMJqaW9Lf 01:25:50 INFO - Expected file size: 22021944 01:25:50 INFO - Obtained file size: 22021944 01:25:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:25:55 INFO - Http code: 200 01:25:55 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 01:25:55 INFO - x-amz-cf-id: lv7hi5FAltwgeQL7VUYaSBMPErxxObTflD-Cak7cFxolEGhZaWkjMw== 01:25:55 INFO - x-amz-version-id: tlldmenZnEXbICnb7_0_lM4bqSRxjXf. 01:25:55 INFO - Expected file size: 14409006 01:25:55 INFO - Obtained file size: 14409006 01:25: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')]} 01:25:55 INFO - trying https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/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 01:25:58 INFO - Downloaded 59711881 bytes. 01:25:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:58 INFO - mkdir: /builds/slave/test/properties 01:25:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:58 INFO - Contents: 01:25:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:58 INFO - Running post-action listener: _resource_record_post_action 01:25:58 INFO - Running post-action listener: set_extra_try_arguments 01:25:58 INFO - [mozharness: 2016-10-07 08:25:58.641023Z] Finished download-and-extract step (success) 01:25:58 INFO - [mozharness: 2016-10-07 08:25:58.641249Z] Running populate-webroot step. 01:25:58 INFO - Running pre-action listener: _resource_record_pre_action 01:25:58 INFO - Running main action method: populate_webroot 01:25:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:58 INFO - '--tppagecycles', 01:25:58 INFO - '7'], 01:25:58 INFO - 'tests': ['tsvgm']}}, 01:25:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['damp', 'tps']}, 01:25:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'tests': ['damp', 'tps']}, 01:25:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['dromaeo_dom']}, 01:25:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['basic_compositor_video']}, 01:25:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['a11yr', 01:25:58 INFO - 'ts_paint', 01:25:58 INFO - 'tpaint', 01:25:58 INFO - 'sessionrestore', 01:25:58 INFO - 'sessionrestore_no_auto_restore', 01:25:58 INFO - 'tabpaint']}, 01:25:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['tsvgx', 01:25:58 INFO - 'tsvgr_opacity', 01:25:58 INFO - 'tart', 01:25:58 INFO - 'tscrollx', 01:25:58 INFO - 'cart']}, 01:25:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:58 INFO - 'tsvgr_opacity', 01:25:58 INFO - 'tart', 01:25:58 INFO - 'tscrollx', 01:25:58 INFO - 'cart']}, 01:25:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'talos_options': ['--disable-e10s'], 01:25:58 INFO - 'tests': ['tp5o']}, 01:25:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'tests': ['tp5o']}, 01:25:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'talos_options': ['--disable-e10s', 01:25:58 INFO - '--xperf_path', 01:25:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:58 INFO - 'tests': ['tp5n']}, 01:25:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:58 INFO - 'talos_options': ['--xperf_path', 01:25:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:58 INFO - 'tests': ['tp5n']}}, 01:25:58 INFO - 'talos.zip': {'path': '', 01:25:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:58 INFO - Running post-action listener: _resource_record_post_action 01:25:58 INFO - [mozharness: 2016-10-07 08:25:58.659234Z] Finished populate-webroot step (success) 01:25:58 INFO - [mozharness: 2016-10-07 08:25:58.659322Z] Running create-virtualenv step. 01:25:58 INFO - Running pre-action listener: _resource_record_pre_action 01:25:58 INFO - Running main action method: create_virtualenv 01:25:58 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:58 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 01:25:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:58 INFO - Using real prefix '/usr' 01:25:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:01 INFO - Installing pip.................done. 01:26:01 INFO - Return code: 0 01:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:26:01 INFO - Reading from file tmpfile_stdout 01:26:01 INFO - Output received: 01:26:01 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) 01:26:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:01 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:01 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 01:26:01 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 01:26:01 INFO - Using env: {'DISPLAY': ':0', 01:26:01 INFO - 'HOME': '/home/cltbld', 01:26:01 INFO - 'LANG': 'en_US.UTF-8', 01:26:01 INFO - 'LANGUAGE': 'en_US:en', 01:26:01 INFO - 'LOGNAME': 'cltbld', 01:26:01 INFO - 'MAIL': '/var/mail/cltbld', 01:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:01 INFO - 'MOZ_NO_REMOTE': '1', 01:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:01 INFO - 'NO_EM_RESTART': '1', 01:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:01 INFO - 'PWD': '/builds/slave/test', 01:26:01 INFO - 'SHELL': '/bin/bash', 01:26:01 INFO - 'SHLVL': '1', 01:26:01 INFO - 'TERM': 'linux', 01:26:01 INFO - 'TMOUT': '86400', 01:26:01 INFO - 'USER': 'cltbld', 01:26:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:01 INFO - '_': '/tools/buildbot/bin/python'} 01:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:01 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 01:26:01 INFO - Cleaning up... 01:26:01 INFO - Return code: 0 01:26:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:01 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:01 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 01:26:01 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 01:26:01 INFO - Using env: {'DISPLAY': ':0', 01:26:01 INFO - 'HOME': '/home/cltbld', 01:26:01 INFO - 'LANG': 'en_US.UTF-8', 01:26:01 INFO - 'LANGUAGE': 'en_US:en', 01:26:01 INFO - 'LOGNAME': 'cltbld', 01:26:01 INFO - 'MAIL': '/var/mail/cltbld', 01:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:01 INFO - 'MOZ_NO_REMOTE': '1', 01:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:01 INFO - 'NO_EM_RESTART': '1', 01:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:01 INFO - 'PWD': '/builds/slave/test', 01:26:01 INFO - 'SHELL': '/bin/bash', 01:26:01 INFO - 'SHLVL': '1', 01:26:01 INFO - 'TERM': 'linux', 01:26:01 INFO - 'TMOUT': '86400', 01:26:01 INFO - 'USER': 'cltbld', 01:26:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:01 INFO - '_': '/tools/buildbot/bin/python'} 01:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:01 INFO - Downloading/unpacking psutil>=3.1.1 01:26:01 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 01:26:01 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 01:26:01 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 01:26:01 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 01:26:01 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 01:26:01 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 01:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:03 INFO - Installing collected packages: psutil 01:26:03 INFO - Running setup.py install for psutil 01:26:03 INFO - building 'psutil._psutil_linux' extension 01:26:03 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 01:26:04 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 01:26:04 INFO - building 'psutil._psutil_posix' extension 01:26:04 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 01:26:04 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 01:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:04 INFO - Successfully installed psutil 01:26:04 INFO - Cleaning up... 01:26:04 INFO - Return code: 0 01:26:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:04 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 01:26:04 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 01:26:04 INFO - Using env: {'DISPLAY': ':0', 01:26:04 INFO - 'HOME': '/home/cltbld', 01:26:04 INFO - 'LANG': 'en_US.UTF-8', 01:26:04 INFO - 'LANGUAGE': 'en_US:en', 01:26:04 INFO - 'LOGNAME': 'cltbld', 01:26:04 INFO - 'MAIL': '/var/mail/cltbld', 01:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:04 INFO - 'MOZ_NO_REMOTE': '1', 01:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:04 INFO - 'NO_EM_RESTART': '1', 01:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:04 INFO - 'PWD': '/builds/slave/test', 01:26:04 INFO - 'SHELL': '/bin/bash', 01:26:04 INFO - 'SHLVL': '1', 01:26:04 INFO - 'TERM': 'linux', 01:26:04 INFO - 'TMOUT': '86400', 01:26:04 INFO - 'USER': 'cltbld', 01:26:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:04 INFO - '_': '/tools/buildbot/bin/python'} 01:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:26:06 INFO - Installing collected packages: mozsystemmonitor 01:26:06 INFO - Running setup.py install for mozsystemmonitor 01:26:06 INFO - Successfully installed mozsystemmonitor 01:26:06 INFO - Cleaning up... 01:26:06 INFO - Return code: 0 01:26:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:26:06 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')]} 01:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:06 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')]} 01:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:06 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:06 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 01:26:06 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 01:26:06 INFO - Using env: {'DISPLAY': ':0', 01:26:06 INFO - 'HOME': '/home/cltbld', 01:26:06 INFO - 'LANG': 'en_US.UTF-8', 01:26:06 INFO - 'LANGUAGE': 'en_US:en', 01:26:06 INFO - 'LOGNAME': 'cltbld', 01:26:06 INFO - 'MAIL': '/var/mail/cltbld', 01:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:06 INFO - 'MOZ_NO_REMOTE': '1', 01:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:06 INFO - 'NO_EM_RESTART': '1', 01:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:06 INFO - 'PWD': '/builds/slave/test', 01:26:06 INFO - 'SHELL': '/bin/bash', 01:26:06 INFO - 'SHLVL': '1', 01:26:06 INFO - 'TERM': 'linux', 01:26:06 INFO - 'TMOUT': '86400', 01:26:06 INFO - 'USER': 'cltbld', 01:26:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:06 INFO - '_': '/tools/buildbot/bin/python'} 01:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:06 INFO - Downloading/unpacking jsonschema==2.5.1 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:06 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 01:26:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:08 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 01:26:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:09 INFO - warning: no files found matching '*.txt' 01:26:09 INFO - no previously-included directories found matching 'build' 01:26:09 INFO - no previously-included directories found matching 'dist' 01:26:09 INFO - no previously-included directories found matching '.git*' 01:26:09 INFO - Installing collected packages: jsonschema, functools32 01:26:09 INFO - Running setup.py install for functools32 01:26:09 INFO - warning: no files found matching '*.txt' 01:26:09 INFO - no previously-included directories found matching 'build' 01:26:09 INFO - no previously-included directories found matching 'dist' 01:26:09 INFO - no previously-included directories found matching '.git*' 01:26:09 INFO - Successfully installed jsonschema functools32 01:26:09 INFO - Cleaning up... 01:26:09 INFO - Return code: 0 01:26:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:26:09 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')]} 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:09 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')]} 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:09 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:09 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 01:26:09 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 01:26:09 INFO - Using env: {'DISPLAY': ':0', 01:26:09 INFO - 'HOME': '/home/cltbld', 01:26:09 INFO - 'LANG': 'en_US.UTF-8', 01:26:09 INFO - 'LANGUAGE': 'en_US:en', 01:26:09 INFO - 'LOGNAME': 'cltbld', 01:26:09 INFO - 'MAIL': '/var/mail/cltbld', 01:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:09 INFO - 'MOZ_NO_REMOTE': '1', 01:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:09 INFO - 'NO_EM_RESTART': '1', 01:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:09 INFO - 'PWD': '/builds/slave/test', 01:26:09 INFO - 'SHELL': '/bin/bash', 01:26:09 INFO - 'SHLVL': '1', 01:26:09 INFO - 'TERM': 'linux', 01:26:09 INFO - 'TMOUT': '86400', 01:26:09 INFO - 'USER': 'cltbld', 01:26:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:09 INFO - '_': '/tools/buildbot/bin/python'} 01:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:26:09 INFO - Cleaning up... 01:26:09 INFO - Return code: 0 01:26:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26:09 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')]} 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:09 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')]} 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:09 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:09 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 01:26:09 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 01:26:09 INFO - Using env: {'DISPLAY': ':0', 01:26:09 INFO - 'HOME': '/home/cltbld', 01:26:09 INFO - 'LANG': 'en_US.UTF-8', 01:26:09 INFO - 'LANGUAGE': 'en_US:en', 01:26:09 INFO - 'LOGNAME': 'cltbld', 01:26:09 INFO - 'MAIL': '/var/mail/cltbld', 01:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:09 INFO - 'MOZ_NO_REMOTE': '1', 01:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:09 INFO - 'NO_EM_RESTART': '1', 01:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:09 INFO - 'PWD': '/builds/slave/test', 01:26:09 INFO - 'SHELL': '/bin/bash', 01:26:09 INFO - 'SHLVL': '1', 01:26:09 INFO - 'TERM': 'linux', 01:26:09 INFO - 'TMOUT': '86400', 01:26:09 INFO - 'USER': 'cltbld', 01:26:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:09 INFO - '_': '/tools/buildbot/bin/python'} 01:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:09 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:09 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 01:26:11 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:11 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 01:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:12 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 01:26:12 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 01:26:12 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 01:26:12 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 01:26:12 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 01:26:12 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 01:26:12 INFO - Downloading docopt-0.6.1.tar.gz 01:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:12 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:12 INFO - Running setup.py install for blobuploader 01:26:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:12 INFO - Running setup.py install for requests 01:26:12 INFO - Running setup.py install for docopt 01:26:13 INFO - Successfully installed blobuploader requests docopt 01:26:13 INFO - Cleaning up... 01:26:13 INFO - Return code: 0 01:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01: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')]} 01:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:13 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:13 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 01:26:13 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 01:26:13 INFO - Using env: {'DISPLAY': ':0', 01:26:13 INFO - 'HOME': '/home/cltbld', 01:26:13 INFO - 'LANG': 'en_US.UTF-8', 01:26:13 INFO - 'LANGUAGE': 'en_US:en', 01:26:13 INFO - 'LOGNAME': 'cltbld', 01:26:13 INFO - 'MAIL': '/var/mail/cltbld', 01:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:13 INFO - 'MOZ_NO_REMOTE': '1', 01:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:13 INFO - 'NO_EM_RESTART': '1', 01:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:13 INFO - 'PWD': '/builds/slave/test', 01:26:13 INFO - 'SHELL': '/bin/bash', 01:26:13 INFO - 'SHLVL': '1', 01:26:13 INFO - 'TERM': 'linux', 01:26:13 INFO - 'TMOUT': '86400', 01:26:13 INFO - 'USER': 'cltbld', 01:26:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:13 INFO - '_': '/tools/buildbot/bin/python'} 01:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:13 INFO - Running setup.py (path:/tmp/pip-XyXgjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:13 INFO - Running setup.py (path:/tmp/pip-BRXP1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:13 INFO - Running setup.py (path:/tmp/pip-_1DfRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:13 INFO - Running setup.py (path:/tmp/pip-7xSyEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:13 INFO - Running setup.py (path:/tmp/pip-U2U4zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:13 INFO - Running setup.py (path:/tmp/pip-e2Oc9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:13 INFO - Running setup.py (path:/tmp/pip-iJHeSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:13 INFO - Running setup.py (path:/tmp/pip-DnxVs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Running setup.py (path:/tmp/pip-tlL4HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:13 INFO - Running setup.py (path:/tmp/pip-2N_Ql3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:14 INFO - Running setup.py (path:/tmp/pip-O2fijQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:14 INFO - Running setup.py (path:/tmp/pip-0lcAMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:14 INFO - Running setup.py (path:/tmp/pip-_xDNvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:14 INFO - Running setup.py (path:/tmp/pip-D3_EiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:14 INFO - Running setup.py (path:/tmp/pip-VxmfkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:14 INFO - Running setup.py (path:/tmp/pip-fZ_guz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:14 INFO - Running setup.py (path:/tmp/pip-Mwh1C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:14 INFO - Running setup.py install for manifestparser 01:26:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozcrash 01:26:14 INFO - Running setup.py install for mozdebug 01:26:14 INFO - Running setup.py install for mozdevice 01:26:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozfile 01:26:15 INFO - Running setup.py install for mozhttpd 01:26:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozinfo 01:26:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozInstall 01:26:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozleak 01:26:15 INFO - Running setup.py install for mozlog 01:26:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for moznetwork 01:26:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozprocess 01:26:15 INFO - Running setup.py install for mozprofile 01:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozrunner 01:26:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:16 INFO - Running setup.py install for mozscreenshot 01:26:16 INFO - Running setup.py install for moztest 01:26:16 INFO - Running setup.py install for mozversion 01:26:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:16 INFO - Cleaning up... 01:26:16 INFO - Return code: 0 01:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:16 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')]} 01:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 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')]} 01:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:16 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 01:26:16 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 01:26:16 INFO - Using env: {'DISPLAY': ':0', 01:26:16 INFO - 'HOME': '/home/cltbld', 01:26:16 INFO - 'LANG': 'en_US.UTF-8', 01:26:16 INFO - 'LANGUAGE': 'en_US:en', 01:26:16 INFO - 'LOGNAME': 'cltbld', 01:26:16 INFO - 'MAIL': '/var/mail/cltbld', 01:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:16 INFO - 'MOZ_NO_REMOTE': '1', 01:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:16 INFO - 'NO_EM_RESTART': '1', 01:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:16 INFO - 'PWD': '/builds/slave/test', 01:26:16 INFO - 'SHELL': '/bin/bash', 01:26:16 INFO - 'SHLVL': '1', 01:26:16 INFO - 'TERM': 'linux', 01:26:16 INFO - 'TMOUT': '86400', 01:26:16 INFO - 'USER': 'cltbld', 01:26:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:16 INFO - '_': '/tools/buildbot/bin/python'} 01:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 INFO - Running setup.py (path:/tmp/pip-Qh2XNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 INFO - Running setup.py (path:/tmp/pip-x1sA2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 INFO - Running setup.py (path:/tmp/pip-lxJr1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 INFO - Running setup.py (path:/tmp/pip-7KxIXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Running setup.py (path:/tmp/pip-2dnHSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Running setup.py (path:/tmp/pip-ypUPKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:17 INFO - Running setup.py (path:/tmp/pip-xxsmNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:17 INFO - Running setup.py (path:/tmp/pip-x9x3wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:17 INFO - Running setup.py (path:/tmp/pip-MajjX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:17 INFO - Running setup.py (path:/tmp/pip-hv6YMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 INFO - Running setup.py (path:/tmp/pip-os4u24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 INFO - Running setup.py (path:/tmp/pip-BjACzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 INFO - Running setup.py (path:/tmp/pip-3_WK1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 INFO - Running setup.py (path:/tmp/pip-oYWnQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 INFO - Running setup.py (path:/tmp/pip-0ZPsxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:17 INFO - Running setup.py (path:/tmp/pip-pG8JiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:17 INFO - Running setup.py (path:/tmp/pip-iVXtam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:19 INFO - Downloading blessings-1.6.tar.gz 01:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:19 INFO - Installing collected packages: blessings 01:26:19 INFO - Running setup.py install for blessings 01:26:19 INFO - Successfully installed blessings 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:20 INFO - Reading from file tmpfile_stdout 01:26:20 INFO - Current package versions: 01:26:20 INFO - argparse == 1.2.1 01:26:20 INFO - blessings == 1.6 01:26:20 INFO - blobuploader == 1.2.4 01:26:20 INFO - docopt == 0.6.1 01:26:20 INFO - functools32 == 3.2.3-2 01:26:20 INFO - jsonschema == 2.5.1 01:26:20 INFO - manifestparser == 1.1 01:26:20 INFO - mozInstall == 1.12 01:26:20 INFO - mozcrash == 0.17 01:26:20 INFO - mozdebug == 0.1 01:26:20 INFO - mozdevice == 0.48 01:26:20 INFO - mozfile == 1.2 01:26:20 INFO - mozhttpd == 0.7 01:26:20 INFO - mozinfo == 0.9 01:26:20 INFO - mozleak == 0.1 01:26:20 INFO - mozlog == 3.4 01:26:20 INFO - moznetwork == 0.27 01:26:20 INFO - mozprocess == 0.23 01:26:20 INFO - mozprofile == 0.28 01:26:20 INFO - mozrunner == 6.12 01:26:20 INFO - mozscreenshot == 0.1 01:26:20 INFO - mozsystemmonitor == 0.3 01:26:20 INFO - moztest == 0.7 01:26:20 INFO - mozversion == 1.4 01:26:20 INFO - psutil == 3.1.1 01:26:20 INFO - requests == 1.2.3 01:26:20 INFO - wsgiref == 0.1.2 01:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:20 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')]} 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 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')]} 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:20 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 01:26:20 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 01:26:20 INFO - Using env: {'DISPLAY': ':0', 01:26:20 INFO - 'HOME': '/home/cltbld', 01:26:20 INFO - 'LANG': 'en_US.UTF-8', 01:26:20 INFO - 'LANGUAGE': 'en_US:en', 01:26:20 INFO - 'LOGNAME': 'cltbld', 01:26:20 INFO - 'MAIL': '/var/mail/cltbld', 01:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:20 INFO - 'MOZ_NO_REMOTE': '1', 01:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:20 INFO - 'NO_EM_RESTART': '1', 01:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:20 INFO - 'PWD': '/builds/slave/test', 01:26:20 INFO - 'SHELL': '/bin/bash', 01:26:20 INFO - 'SHLVL': '1', 01:26:20 INFO - 'TERM': 'linux', 01:26:20 INFO - 'TMOUT': '86400', 01:26:20 INFO - 'USER': 'cltbld', 01:26:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:20 INFO - '_': '/tools/buildbot/bin/python'} 01:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 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)) 01:26:20 INFO - Cleaning up... 01:26:20 INFO - Return code: 0 01:26:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:20 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')]} 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 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')]} 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 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 0x7eff8d902f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2147790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, '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': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', '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 01:26:20 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 01:26:20 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 01:26:20 INFO - Using env: {'DISPLAY': ':0', 01:26:20 INFO - 'HOME': '/home/cltbld', 01:26:20 INFO - 'LANG': 'en_US.UTF-8', 01:26:20 INFO - 'LANGUAGE': 'en_US:en', 01:26:20 INFO - 'LOGNAME': 'cltbld', 01:26:20 INFO - 'MAIL': '/var/mail/cltbld', 01:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:20 INFO - 'MOZ_NO_REMOTE': '1', 01:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:20 INFO - 'NO_EM_RESTART': '1', 01:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:20 INFO - 'PWD': '/builds/slave/test', 01:26:20 INFO - 'SHELL': '/bin/bash', 01:26:20 INFO - 'SHLVL': '1', 01:26:20 INFO - 'TERM': 'linux', 01:26:20 INFO - 'TMOUT': '86400', 01:26:20 INFO - 'USER': 'cltbld', 01:26:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:20 INFO - '_': '/tools/buildbot/bin/python'} 01:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:26:20 INFO - Cleaning up... 01:26:20 INFO - Return code: 0 01:26:20 INFO - Running post-action listener: _resource_record_post_action 01:26:20 INFO - Running post-action listener: _start_resource_monitoring 01:26:20 INFO - Starting resource monitoring. 01:26:20 INFO - [mozharness: 2016-10-07 08:26:20.649303Z] Finished create-virtualenv step (success) 01:26:20 INFO - [mozharness: 2016-10-07 08:26:20.649821Z] Running install step. 01:26:20 INFO - Running pre-action listener: _resource_record_pre_action 01:26:20 INFO - Running main action method: install 01:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:20 INFO - Reading from file tmpfile_stdout 01:26:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:20 INFO - Reading from file tmpfile_stdout 01:26:20 INFO - Output received: 01:26:20 INFO - Usage: mozinstall [options] installer 01:26:20 INFO - Options: 01:26:20 INFO - -h, --help show this help message and exit 01:26:20 INFO - -d DEST, --destination=DEST 01:26:20 INFO - Directory to install application into. [default: 01:26:20 INFO - "/builds/slave/test"] 01:26:20 INFO - --app=APP Application being installed. [default: firefox] 01:26:20 INFO - mkdir: /builds/slave/test/build/application 01:26:20 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'] 01:26:20 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 01:26:37 INFO - Reading from file tmpfile_stdout 01:26:37 INFO - Output received: 01:26:37 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:37 INFO - Running post-action listener: _resource_record_post_action 01:26:37 INFO - [mozharness: 2016-10-07 08:26:37.976474Z] Finished install step (success) 01:26:37 INFO - [mozharness: 2016-10-07 08:26:37.976787Z] Running run-tests step. 01:26:37 INFO - Running pre-action listener: _resource_record_pre_action 01:26:37 INFO - Running main action method: run_tests 01:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:37 INFO - Python 2.7.3 01:26:37 INFO - Return code: 0 01:26:37 INFO - grabbing minidump binary from tooltool 01: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')]} 01:26:37 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 0x2144930>, '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 0x2145830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2145cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:37 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 01:26:37 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 01:26:37 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 01:26:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:38 INFO - Return code: 0 01:26:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:26:38 INFO - Using env: {'DISPLAY': ':0', 01:26:38 INFO - 'HOME': '/home/cltbld', 01:26:38 INFO - 'LANG': 'en_US.UTF-8', 01:26:38 INFO - 'LANGUAGE': 'en_US:en', 01:26:38 INFO - 'LOGNAME': 'cltbld', 01:26:38 INFO - 'MAIL': '/var/mail/cltbld', 01:26:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:38 INFO - 'MOZ_NO_REMOTE': '1', 01:26:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:38 INFO - 'NO_EM_RESTART': '1', 01:26:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:38 INFO - 'PWD': '/builds/slave/test', 01:26:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:38 INFO - 'SHELL': '/bin/bash', 01:26:38 INFO - 'SHLVL': '1', 01:26:38 INFO - 'TERM': 'linux', 01:26:38 INFO - 'TMOUT': '86400', 01:26:38 INFO - 'USER': 'cltbld', 01:26:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160', 01:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:38 INFO - '_': '/tools/buildbot/bin/python'} 01:26:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:26:38 INFO - mozversion application_buildid: 20161006223005 01:26:38 INFO - mozversion application_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 01:26:38 INFO - mozversion application_display_name: Nightly 01:26:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:38 INFO - mozversion application_name: Firefox 01:26:38 INFO - mozversion application_remotingname: firefox 01:26:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:26:38 INFO - mozversion application_vendor: Mozilla 01:26:38 INFO - mozversion application_version: 52.0a1 01:26:38 INFO - mozversion platform_buildid: 20161006223005 01:26:38 INFO - mozversion platform_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 01:26:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:26:38 INFO - mozversion platform_version: 52.0a1 01:26:38 INFO - using testdate: 1475828798 01:26:38 INFO - actual date: 1475828798 01:26:38 INFO - starting webserver on 'localhost:60464' 01:26:38 INFO - SUITE-START | Running 2 tests 01:26:38 INFO - TEST-START | dromaeo_css 01:26:38 INFO - operating with platform_type : linux_ 01:26:38 INFO - Initialising browser for dromaeo_css test... 01:26:38 INFO - TEST-INFO | started process 14277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mjCYy/profile http://localhost:60464/getInfo.html) 01:26:42 INFO - PROCESS | 14277 | __metrics Screen width/height:1600/1200 01:26:42 INFO - PROCESS | 14277 | colorDepth:24 01:26:42 INFO - PROCESS | 14277 | Browser inner width/height: 1024/697 01:26:42 INFO - PROCESS | 14277 | __metrics 01:26:43 ERROR - PROCESS | 14277 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 01:26:44 INFO - TEST-INFO | 14277: exit 0 01:26:44 INFO - Browser initialized. 01:26:44 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:44 INFO - TEST-INFO | started process 14401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mjCYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:56 INFO - PROCESS | 14401 | RSS: Main: 185524224 01:26:56 INFO - PROCESS | 14401 | 01:27:45 INFO - PROCESS | 14401 | 1475828865968 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] 01:29:56 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60464/tests/dromaeo/cssquery-ext.html) 01:29:58 INFO - PROCESS | 14401 | RSS: Main: 200916992 01:29:58 INFO - PROCESS | 14401 | 01:33:00 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-ext.html (next: http://localhost:60464/tests/dromaeo/cssquery-jquery.html) 01:33:01 INFO - PROCESS | 14401 | RSS: Main: 200531968 01:33:01 INFO - PROCESS | 14401 | 01:36:03 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60464/tests/dromaeo/cssquery-mootools.html) 01:36:03 INFO - PROCESS | 14401 | RSS: Main: 201592832 01:36:03 INFO - PROCESS | 14401 | 01:39:05 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60464/tests/dromaeo/cssquery-prototype.html) 01:39:06 INFO - PROCESS | 14401 | RSS: Main: 196124672 01:39:06 INFO - PROCESS | 14401 | 01:42:08 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60464/tests/dromaeo/cssquery-yui.html) 01:42:09 INFO - PROCESS | 14401 | RSS: Main: 199647232 01:42:09 INFO - PROCESS | 14401 | 01:45:11 INFO - PROCESS | 14401 | Cycle 1(1): loaded http://localhost:60464/tests/dromaeo/cssquery-yui.html (next: http://localhost:60464/tests/dromaeo/cssquery-dojo.html) 01:45:12 INFO - PROCESS | 14401 | RSS: Main: 199671808 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | __start_tp_report 01:45:12 INFO - PROCESS | 14401 | _x_x_mozilla_page_load 01:45:12 INFO - PROCESS | 14401 | _x_x_mozilla_page_load_details 01:45:12 INFO - PROCESS | 14401 | |i|pagename|runs| 01:45:12 INFO - PROCESS | 14401 | |0;dojo.html;3039.6352437707474;3047.847607619621;3072.324088700486;3074.538819177123;3103.162146220519;5070.442251352349;5189.506996835299;5302.504511293106;5303.946960530398;5404.000259951912;5124.026434977361;5228.581713462923;5302.1781623848365;5320.14877619581;5369.087255166622;4793.9280910786365;4898.485659005806;4919.335889654904;4951.43058548268;4954.380702412199;4920.434150072751;4943.604511639078;4950.826721064764;4965.602751779867;5024.62315326352;4630.421197350332;4663.207254766698;4719.362886010379;4827.8551643450755;4844.709317440947;4764.976175119137;4787.32443644725;4811.639127065484;4831.855044348676;4855.951440485621;4831.734254615994;4846.7818948147415;4893.730844803535;4895.9755201224125;4907.533784290486;5102.928385039109;5133.230015497668;5336.252924590561;5341.43914888935;5397.055515284809;5564.8052318169075;5597;5616.1014237722175;5643.266375371217;5702.144678298288;5613.80351687693;5640.125780504029;5657.547396208293;5664.49019588239;5670.801521946753;5048.949510504922;5260.999999999962;5281.39263984639;5303.443138470482;5340.145576707708;5541.196526503634;5656.8868622627315;5699.914501282484;5710.571707121982;5797.507211887037;5507.449255074541;5512;5514.117741161475;5516.172574113915;5526.281583394133;5364.088105022156;5442.455754424526;5533.501984821305;5545.833624991256;5606.439356064442;5460.372057213472;5616.073347897551;5617.297837770278;5717.514011309002;5726.427357264323;5639.097744360883;5653.830385088454;5654.97172514143;5659.660420374708;5676.772929082873;4343.326784348431;4388.714733542373;4390.62679672225;4410.25025745624;4425.513193548707;3815.1606646537716;3833.0800607853917;3907.1404291055924;3954.8022598869943;3971.5234171899556;5430.15832545956;5466.426025267369;5466.972665136649;5470.261514695545;5533.944660553343;5643.802466913638;5706.229658996065;5727.656340619493;5738.053221218535;5753.367129615739;5163.845084647466;5206.609504287194;5295.258663787073;5301.734913254322;5498.5876059295715;4826.710397376099;4835.178019736582;4835.516448355136;4869.245266983623;4887.242477416006;5651.067573850269;5673.864927917748;5676.176954341515;5683.403242659544;5736.139579063174;5416.106342453451;5463.180522921593;5588;5599.300087489064;5613.382527922007;5704.885902281848;5758.568107391879;5776.162456443876;5834.358220595816;5839.824805255849;5528.502434780889;5568.972155139199;5577.721113944205;5594.692291923983;5625.324961004706;5317.654352467077;5416.350037995308;5666.206731057573;5711.685857277724;5718.3423906249645;5379.757910893941;5405.8918821622565;5420.864478388072;5456.017916775018;5507.9449205507435;5422.701751403711;5427.294451721251;5429.972850135724;5432.592555558428;5433.239346491573;5244.580433565229;5262.973720124539;5408.296921400193;5411.864703382447;5479.369872464717;5531.03206938776;5618.831435056954;5625.071863142535;5672.347680016685;5716.171155182392;5433.022056029795;5468.4531546845;5479.013777520085;5494.752736126964;5501.229827824028 01:45:12 INFO - PROCESS | 14401 | |1;ext.html;529.7827890564866;550.573305688092;568.2612603615299;595.306467964821;600.1118344849624;39550.802245988765;41127.17745645089;41214.58785412145;44798.32802507965;45020.54979450205;43993.34009989845;44338.556614433845;44376;44488.55511444885;44556.55443445565;8884;8945.373823832302;8945.865812012826;8946.552672366355;9038.276937844958;8632.697855575056;8766.167214114648;8796.604152813139;8891.11088891109;8913.77715557113;8905.599248033821;8924.910750892474;8959.552022398886;8965.058668839776;8977.967533733607;8873.68942087027;8885.42244754089;8891.155340242667;8904.376693631448;8907.73276801697;8735.257503112243;8761.605727742266;8789.428687135316;8801.383903126783;8834.646614135427;41019.794901025605;41145.382819257735;41276.38085428721;41374.1725165495;41475.7926210367;3522.929541409183;3551.3430015447225;3687.8893633191046;3842.212346468967;3964.226975739732;30941.535876961865;31225;31308.686913130805;31407.214819629462;33036.17409564756;4228.175505776375;4365.738055716667;4398.7580683062415;4476.686631935766;4543.091381723635;330272;331057;331642;332762;333760;53423.46576534185;53449.46550534523;53590;53615;53677.7316113417;50830.74584627053;51110;51392.48607513877;51657;51711.22433163506;16464;16626.418075367303;16683.6663266734;16751.832481675272;16825.326986920387;12552.686182845502;12594.244345339126;12596.55912043074;12599.811002834966;12620.495180192689;14948;14996.625084372978;15148.182218133674;15166.393344266105;15337.30982105808;5503.807366742225;5594.272744543184;5606.747696353674;5725.656460612377;5741.827745167651;873.8427083125099;975.11264749078;1026.1226651213256;1052.1372474570778;1056.7041228455892;30506.38987220243;31056;31513.842430788158;31587.037785663106;31733.523997140062;1017.3488967061087;1053.089077947585;1086.8424078508572;1091.2906610703108;1115.481301194932;15825.841741582668;16439.753403698716;16509;16519.91740041292;16599.41902033423;447655;451315.6907939085;453288;453962;454164;55419.44580554143;56042.71978640162;56125.438745612024;56454.7177264111;56479.15281270784;1209.564556759566;1237.406045098358;1250.9562165324353;1266.3984607311454;1302.3683513495946;29047.854760726907;30381.544276835422;30808.845955770077;30985.53521697131;31314.686853131177;47200.69595128308;47872.76063619799;47961.32135375245;48056.5194348052;48106.27840582464;389197;390487;393227;393588;394015;38163;38548.6145138545;38884.416733748454;38913.610863891;39231;44477;45212.54787452083;45566;46786.76606616945;47084.29373559468;38493.615063849;38641.68149911014;38948.2210355797;40314.596854031086;40545.59454405536;38070.048248794;38261.234775304896;38873;39505.209895802494;39882.60117398905;38498.6150138495;38900.6109938897;39548.802255988536;39574;42037.36943945782;30632.84683576568;35042.649573503935;35890.10274743152;35908.4613730789;36287.81856090808;26668.59997100084;26877.328066798487;26977;27288.317792055357;27734 01:45:12 INFO - PROCESS | 14401 | |2;jquery.html;383.15323135869727;389.60649743758796;393.6752179451952;395.8871721559356;420.77067997941117;17691.64616707665;19428.51428714283;19454.41636750898;19612.70580941287;20058.297959571417;17544.210510527024;18958.43124706261;19344.80655193448;19401.805981940175;19695.5076123097;5484.561235101202;5534.529564986981;5596.244506991545;5679.261695979538;5752.050911599581;5589.972050139743;5621.325440947092;5669.886602267952;5691.601587888849;5704.11586204137;5457.645253058538;5557.194206840026;5595.580331475136;5605.327360716719;5658.43415658435;5405.540529055035;5415.864603384907;5417.783288668468;5440.782368705267;5443.537299329581;4812.435958313562;4845.200541910581;5022.8196373852115;5024.899502009976;5033.144365457844;22752.886235568716;22842.543149136924;22900.770992290032;22924.312270631908;23364.7663523366;2076.781937896529;2140.475583482041;2144.9249276275254;2293.724753029647;2540.5808041673104;9948.90051099487;10072.798544029152;10139.340942838766;10317.226208034428;10490.108340791043;1920.6446807340687;1928.807119288074;1938.8545859060628;1961.1763059515038;1989.6816509358578;79643.20356796416;82702.58648706778;83463.58268208681;83538.58230708868;84219.15780842175;10545.525451354708;10621;10825.512851921683;11415.942920285512;11607.129465290138;14871.256437178097;15089.698206035819;15100.697986040217;15365.6158596036;15454.845451545565;7791.181925897699;8168.550729709923;8186.140455252113;8352.290055345242;8443.74668759926;7994.440389172818;7994.84010319802;8111.9594402027615;8366.748997530083;8395;4338.7830608470085;4477.350784136282;4506.121306345297;4753.287006948916;4763.952360476351;1920.4910698664864;1961.146901098027;1978.9703154452695;1992.282778199847;2029.289748588012;909.2453263791169;944.1596978688972;959.738759906015;972.5526257921435;973.6105557776946;18230.427112579768;19367;19577.902110489358;19884.304049358492;20048.298309559097;955.3217215776876;967.9304368672656;985.9507024648882;1002.3184234720314;1029.0686928329874;10472.68581942543;11007.449627518752;11011.559537618567;11052.889471105185;11072.723181920517;439416;440566;445700;446528;450739;86310;87999;88966;91136;96099;871.2724874729672;924.3668087360314;937.1659223291276;939.2298315381458;941.4727752458645;16684;16902.57743556421;17355.219015144095;17646.558836029202;17892.642147156723;39927.40108898427;39941.40087898626;40208.396874047496;40579.79710101431;41162;54301;54962.90074198414;56553.43446565482;56800;57509.712451437474;8320.500769953822;8387.496750194763;8405.327573794204;8606.483610983361;8750.037495875322;9447.81104377895;11977.461014254206;12669.239845609292;12778.936105319413;13159;11386.316820990767;11544.653660390202;11636.12729045342;11775.52897884075;11840.348780817138;11143.554257829595;11268.267562608733;11356.26184298018;11401.144914131639;11410.087193024705;11472.770544588895;11648;11648.592299269485;11910.52357905674;11927;8430.15698430152;8625.69810056645;8679.132086791271;8767.342449316198;8948.373613846969;10122.44326562046;11357.602483913024;11543.249688770538;11590.072794176276;11742.060635148997 01:45:12 INFO - PROCESS | 14401 | |3;mootools.html;1417.6101572067682;1447.4789075932665;1538.2616344154806;1663.8585720213782;1741.1903464888824;7761.3402860756905;7947.960260198705;8536.274416674582;9190.44857308561;9208.217301529377;8513.489190648565;8829.867551986725;8844.513551754651;9036.09639036096;9055.456672599648;2264.116994372196;2311.387482317179;2314.884255787212;2315.166540045582;2315.7452680205165;2287.5245466673987;2312.4218945263683;2326.5928462519078;2329.9184528541505;2334.206369834256;2310.480141968052;2315.5716192504356;2336.8597884127007;2353.5528249632516;2359.0563774490256;2259.5706815705043;2264.830137739676;2273.761255068219;2284.23478134825;2297.7127859017623;2267.1384873748034;2273.090763694519;2277.339571524256;2277.4761804784825;2278.1343089625834;8934.151255630704;8996.055414181548;9052.185303322733;9067.54662266884;9085.091490850928;5074.416442109131;5218.13900706383;5234.0840352938085;5239.607029472805;5244.868878278074;3206.1022913584234;3240.578724765789;3381.104007438006;3416.572928383952;3437.5359326491102;1026.3739119137394;1027.36648728522;1029.541853875026;1043.6034306963306;1053.5627714498473;12314.50741970329;12392.752144957141;12475.376231188404;12489.75020499594;12525.624231273076;4471.8658440246845;4575.405197324327;4720.598749106296;4737.194676904935;4771.5467030632035;10410.531526081344;10484.63303784364;10556.683299501028;10584.576616935236;10638.627648032436;5253.632245742838;5257.921131183035;5259.105951988095;5260;5290.338707661543;4246.363045543193;4427.712198707074;4732.645051621143;4798.640101992295;4830.879228019257;3912.4522566840665;3969.364901615728;3979.7015223858325;4015.417764424142;4047.1500984793524;1198.1493139870615;1212.8483939507562;1214.5445457953267;1222.5537678747194;1271.2817258249245;759.5860256160406;829.9377546684022;837.1084794693631;841.3479553346206;898.4339865884451;5344.9732751336;5410.8917821643345;5433.8369848904595;5573.108302671553;5596.86007849807;907.7790371949717;928.2388441478058;929.6560272699145;944.8661606072603;970.9611615535441;3443;3653.451982202691;3735.14091758897;3811.733178677521;3833.639058134322;10987.066099381642;11225.775484490265;11244.156688248415;11323.490442930088;11337.773244535063;11143.665690029313;11205.663830084948;11241.044511216638;11246.831297530543;11258.943705281421;8011.319037881729;8150.429469937166;8186.672533098728;8208.056073551617;8219.54792486407;5256.6583172095225;5260.868478288074;5286.603504737083;5395.190721391823;5536.307961504812;9655.22758179358;9778.804423911339;9812.411255324703;9876.950615246878;10020.498975051072;10003.099721025143;10082.395056296646;10142.797144057226;10171.643992460524;10193.490325483845;6739.528233023641;6950.6177160256675;7483.139438964588;7517.398608111447;7647.464677472523;8591.828163436572;8865.778355541162;8880;8894.911050889408;8916.375853690179;7758.107817600822;7855;7909.920900791149;8178.427510074475;8208.794780130305;7373.520721153108;7527.924720752722;7661.195574464601;7702.768916932501;7857.096433910174;6675.699593518206;6794.082798822095;6796.422304104207;6803.319668033157;6804.693788779417;4769.141554520081;4895.657303988829;4946.35697359341;5096.745162741774;5130.102232109291;4962.213603102808;4986.7257300848805;5076.593872490118;5107.974460127675;5123.257127716534 01:45:12 INFO - PROCESS | 14401 | |4;prototype.html;309.91322429719685;322.40194439315076;323.1678428047775;328.2990814610805;333.9432296509593;5183.770978479252;5325.281087053257;5421.566274698024;5498;5506.394296627373;5147.613928955325;5297.814576489824;5298.36419629644;5401.297831281928;5408.3509978802595;4252.319628859375;4260.105377870651;4266.018815672397;4275.850345237917;4283.593058659422;4151.813168407429;4241.533431322568;4258.74447533149;4263.91472170558;4292.549282325358;4220.430241917333;4222.387753775701;4226.788660566975;4229.471316085489;4241.957580424202;4196.202721482939;4230.534641189467;4244.681648876332;4247.490301163849;4257.850380397306;3685.318216129998;3781.7541859779026;3787.3182827091114;3789.2232092420986;3794.2221844521805;5200.92198617021;5216.895662086775;5217.269582258449;5231;5253.44838791929;4840.177169881129;4843.2250839865455;4846.297286893416;4860.125177468054;4875.488073752241;5323.577772113679;5572.944270557283;5586.581006424534;5603.775848966036;5648.406917273668;4048.3522636378334;4048.7975601220114;4059.106996460774;4059.5128584569748;4062.4921884764403;5831.9416805831825;5850.5612079094235;5905.911411328833;5911.586188966774;5945.197398351211;4015.698822588259;4089.284375234322;4098.221337945841;4102.343625019982;4112.930638034132;4130.380442933584;4150.460440142822;4151.107511884959;4151.335786274181;4183.414321994923;4756.857294281177;4768.472709463989;4770.379850619397;4779.856604301876;4805.423349198119;5460.481254280917;5643.40744221859;5658.264425624642;5669.376368599451;5688.40271771458;1411.682371466412;1440.819897512811;1451.5717863230373;1452.5279284232668;1453.4186325469684;878.991210087891;908.6774195160623;914.693577651481;923.2244914272044;925.796324808541;4752.5485078917445;4766.285057241442;4771.260454629538;4779.450363208275;4812.5081224820415;5114.974425127925;5124.180131178993;5150.253213284052;5162.612804039637;5172.560332371715;4829.2997515360075;4855.36880205571;4928.486471899286;4932.358793356912;5107.897842043139;3018.3510545232443;3057.5260834570677;3063.9582541935847;3078.322768990863;3096.5664806927048;5906.911396329058;5952.375000624958;5967.433093856077;5976.818461261695;6012.819615411545;5605.971970140124;5891.646501209942;5958.791442299499;5965.910511342333;5984.251968503937;5819.6508209507565;5903.35063143054;5909.2908850938165;5932.3474417814;6006.429389208019;5631.605787594829;5832.445917637818;5842.078960519741;5872.412758724265;5912.793052243151;5731.423858438962;5757.36668966405;5765.875654247381;5795.449432304093;5800.970995145166;5957.4042595740075;5958.1360702697;5959.4934430573885;5964.970175149097;5997.970010149921;4151.709380343347;4241.3637954307105;4255.553166917429;4264.808083636306;4273.077115298066;5837.766489340379;5856.180134781219;5879.206307148651;5892.970535147297;5894.498967587803;5500.202470641814;5706.514946229617;5721.570882183936;5740.856478587902;5742.224799652161;5610.326760788732;5633.746481408264;5640.5769567281795;5644.887102258014;5664.178694089416;5636.661800291996;5652.823662889735;5676.801311954062;5688.516476099578;5689.516391106802;5507.256520369699;5655.539840169539;5689.573282003949;5693.743781529758;5708.65748055118;5467.781288748564;5513.483791957244;5522.972385138049;5542.307211598551;5557.527610153183 01:45:12 INFO - PROCESS | 14401 | |5;yui.html;699.9090118284623;766.1610536462575;771.4753967302236;783.6277768060169;786.7993661616287;16318.83681163188;16966.660666786658;17020.829791702112;17051;17057.488275351727;15143;15171.696566068673;15243.085414875088;15280.083195008307;15433.228338583081;765.1124695353377;785.1049803224329;786.1273985875673;786.8622990976585;787.0751866556801;755.5391211361066;783.4359261331832;784.1139512351035;785.9174786647377;788.0779487999055;838.6310023589601;843.3337663246059;843.7806170395711;844.1727107434717;844.8648216285395;821.8233079887852;825.6903661127077;830.4477522447565;831.2020460358063;833.8123922117536;607.8146165419545;609.0377204017685;611.8990366589508;611.9326874043852;612.7334609444906;14519.637009074857;14592.708145837023;14723.631909202248;14737.705245895022;14742.041767285093;14427.49503767363;14593.489227876973;14613.634659133606;14763.483278085216;14800.481983130647;12223.755524889453;12233.510659573607;12344.938275308567;12634;12662;3676.3750162472443;3765.1340191755776;3767.6797472214894;3768.4510579769576;3926.3717805151323;80490.59754701247;81199.14432515665;82022;82465.58767206185;82976.58511707404;10653.627123050655;10771.83842242367;10814.35113893169;11003;11124;18942;18966.71549926752;18985.525361866064;19108.426747197605;19221.90389048046;8197.959010204911;8213.589320533949;8293.95853020731;8300.792480188044;8404.94078950661;4605.171069207575;4732.574068333797;4744.572988431058;4748.833790817304;4762.809487620526;3629.274145170976;3646.4712616670963;3696.094456858087;3745.3445647011663;3762.360398732222;618.2025187508065;619.8698273362644;625.221599109112;630.180765005491;647.543481845298;619.4394073363613;663.7378235597009;668.9130413046273;675.2740803636111;678.7510979797098;8913;9295;9473.526323683926;9495.43027418357;9514.33399662031;694.9583025018516;706.2231545300232;710;716.4125417157985;718.5114122396716;4348.9565104349185;4688.2733176357715;4707.576318131385;4751.572358487752;4751.691140075953;62988.685056574424;63379.683101584196;63631;118262.408687956;123306;73147.26852731405;105274;106533.4673326644;107494;109002;55179.72410137924;56662.15006774902;76107.23892761001;85968.57015714882;91918.10614203828;9278.814423711623;9280.489573073275;9524.333296669443;9789.510524473606;10234.437105959243;48769;49927.75036124796;50894;51112.48887511077;52440.47559524356;70182;71411.64294178496;76972.61513692395;77004.61497692476;79773;12775.680607984874;12888.097833151964;12941.482340706267;13066.281354525212;13329.866701332863;14310.284485775877;14520.636984075483;14565.490207843099;14889.329980150702;15371.538853834403;13444.39500222512;13644.93177534106;13716.24560649134;13795.241261730702;14280.571582852532;13632.795508067586;13757.38091785852;14069.296535172996;14221.64445888861;14379.928100359431;11601.941990289995;12931.159474634118;12949.287789171685;13045.217286962812;13520.391582379014;10980.725481863017;11207.159463040467;11241.943790280997;11606.70983225426;11654.53381864716;10050.321013361156;10201.591936322464;10325.586976520855;11819.940900295443;11905.40472976365 01:45:12 INFO - PROCESS | 14401 | __end_tp_report 01:45:12 INFO - PROCESS | 14401 | __start_cc_report 01:45:12 INFO - PROCESS | 14401 | _x_x_mozilla_cycle_collect,311 01:45:12 INFO - PROCESS | 14401 | __end_cc_report 01:45:12 INFO - PROCESS | 14401 | __startTimestamp1475829912099__endTimestamp 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | ------- Summary: start ------- 01:45:12 INFO - PROCESS | 14401 | Number of tests: 6 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#0] dojo.html Cycles:165 Average:5234.55 Median:5429.97 stddev:570.51 (10.5%) stddev-sans-first:545.66 01:45:12 INFO - PROCESS | 14401 | Values: 3039.6 3047.8 3072.3 3074.5 3103.2 5070.4 5189.5 5302.5 5303.9 5404.0 5124.0 5228.6 5302.2 5320.1 5369.1 4793.9 4898.5 4919.3 4951.4 4954.4 4920.4 4943.6 4950.8 4965.6 5024.6 4630.4 4663.2 4719.4 4827.9 4844.7 4765.0 4787.3 4811.6 4831.9 4856.0 4831.7 4846.8 4893.7 4896.0 4907.5 5102.9 5133.2 5336.3 5341.4 5397.1 5564.8 5597.0 5616.1 5643.3 5702.1 5613.8 5640.1 5657.5 5664.5 5670.8 5048.9 5261.0 5281.4 5303.4 5340.1 5541.2 5656.9 5699.9 5710.6 5797.5 5507.4 5512.0 5514.1 5516.2 5526.3 5364.1 5442.5 5533.5 5545.8 5606.4 5460.4 5616.1 5617.3 5717.5 5726.4 5639.1 5653.8 5655.0 5659.7 5676.8 4343.3 4388.7 4390.6 4410.3 4425.5 3815.2 3833.1 3907.1 3954.8 3971.5 5430.2 5466.4 5467.0 5470.3 5533.9 5643.8 5706.2 5727.7 5738.1 5753.4 5163.8 5206.6 5295.3 5301.7 5498.6 4826.7 4835.2 4835.5 4869.2 4887.2 5651.1 5673.9 5676.2 5683.4 5736.1 5416.1 5463.2 5588.0 5599.3 5613.4 5704.9 5758.6 5776.2 5834.4 5839.8 5528.5 5569.0 5577.7 5594.7 5625.3 5317.7 5416.4 5666.2 5711.7 5718.3 5379.8 5405.9 5420.9 5456.0 5507.9 5422.7 5427.3 5430.0 5432.6 5433.2 5244.6 5263.0 5408.3 5411.9 5479.4 5531.0 5618.8 5625.1 5672.3 5716.2 5433.0 5468.5 5479.0 5494.8 5501.2 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#1] ext.html Cycles:180 Average:55374.13 Median:40098.60 stddev:104213.79 (259.9%) stddev-sans-first:104424.78 01:45:12 INFO - PROCESS | 14401 | Values: 529.8 550.6 568.3 595.3 600.1 39550.8 41127.2 41214.6 44798.3 45020.5 43993.3 44338.6 44376.0 44488.6 44556.6 8884.0 8945.4 8945.9 8946.6 9038.3 8632.7 8766.2 8796.6 8891.1 8913.8 8905.6 8924.9 8959.6 8965.1 8978.0 8873.7 8885.4 8891.2 8904.4 8907.7 8735.3 8761.6 8789.4 8801.4 8834.6 41019.8 41145.4 41276.4 41374.2 41475.8 3522.9 3551.3 3687.9 3842.2 3964.2 30941.5 31225.0 31308.7 31407.2 33036.2 4228.2 4365.7 4398.8 4476.7 4543.1 330272.0 331057.0 331642.0 332762.0 333760.0 53423.5 53449.5 53590.0 53615.0 53677.7 50830.7 51110.0 51392.5 51657.0 51711.2 16464.0 16626.4 16683.7 16751.8 16825.3 12552.7 12594.2 12596.6 12599.8 12620.5 14948.0 14996.6 15148.2 15166.4 15337.3 5503.8 5594.3 5606.7 5725.7 5741.8 873.8 975.1 1026.1 1052.1 1056.7 30506.4 31056.0 31513.8 31587.0 31733.5 1017.3 1053.1 1086.8 1091.3 1115.5 15825.8 16439.8 16509.0 16519.9 16599.4 447655.0 451315.7 453288.0 453962.0 454164.0 55419.4 56042.7 56125.4 56454.7 56479.2 1209.6 1237.4 1251.0 1266.4 1302.4 29047.9 30381.5 30808.8 30985.5 31314.7 47200.7 47872.8 47961.3 48056.5 48106.3 389197.0 390487.0 393227.0 393588.0 394015.0 38163.0 38548.6 38884.4 38913.6 39231.0 44477.0 45212.5 45566.0 46786.8 47084.3 38493.6 38641.7 38948.2 40314.6 40545.6 38070.0 38261.2 38873.0 39505.2 39882.6 38498.6 38900.6 39548.8 39574.0 42037.4 30632.8 35042.6 35890.1 35908.5 36287.8 26668.6 26877.3 26977.0 27288.3 27734.0 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#2] jquery.html Cycles:180 Average:27547.31 Median:40074.90 stddev:73567.19 (183.6%) stddev-sans-first:73745.29 01:45:12 INFO - PROCESS | 14401 | Values: 383.2 389.6 393.7 395.9 420.8 17691.6 19428.5 19454.4 19612.7 20058.3 17544.2 18958.4 19344.8 19401.8 19695.5 5484.6 5534.5 5596.2 5679.3 5752.1 5590.0 5621.3 5669.9 5691.6 5704.1 5457.6 5557.2 5595.6 5605.3 5658.4 5405.5 5415.9 5417.8 5440.8 5443.5 4812.4 4845.2 5022.8 5024.9 5033.1 22752.9 22842.5 22900.8 22924.3 23364.8 2076.8 2140.5 2144.9 2293.7 2540.6 9948.9 10072.8 10139.3 10317.2 10490.1 1920.6 1928.8 1938.9 1961.2 1989.7 79643.2 82702.6 83463.6 83538.6 84219.2 10545.5 10621.0 10825.5 11415.9 11607.1 14871.3 15089.7 15100.7 15365.6 15454.8 7791.2 8168.6 8186.1 8352.3 8443.7 7994.4 7994.8 8112.0 8366.7 8395.0 4338.8 4477.4 4506.1 4753.3 4764.0 1920.5 1961.1 1979.0 1992.3 2029.3 909.2 944.2 959.7 972.6 973.6 18230.4 19367.0 19577.9 19884.3 20048.3 955.3 967.9 986.0 1002.3 1029.1 10472.7 11007.4 11011.6 11052.9 11072.7 439416.0 440566.0 445700.0 446528.0 450739.0 86310.0 87999.0 88966.0 91136.0 96099.0 871.3 924.4 937.2 939.2 941.5 16684.0 16902.6 17355.2 17646.6 17892.6 39927.4 39941.4 40208.4 40579.8 41162.0 54301.0 54962.9 56553.4 56800.0 57509.7 8320.5 8387.5 8405.3 8606.5 8750.0 9447.8 11977.5 12669.2 12778.9 13159.0 11386.3 11544.7 11636.1 11775.5 11840.3 11143.6 11268.3 11356.3 11401.1 11410.1 11472.8 11648.0 11648.6 11910.5 11927.0 8430.2 8625.7 8679.1 8767.3 8948.4 10122.4 11357.6 11543.2 11590.1 11742.1 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#3] mootools.html Cycles:180 Average:5752.60 Median:4814.76 stddev:3358.86 (69.8%) stddev-sans-first:3352.48 01:45:12 INFO - PROCESS | 14401 | Values: 1417.6 1447.5 1538.3 1663.9 1741.2 7761.3 7948.0 8536.3 9190.4 9208.2 8513.5 8829.9 8844.5 9036.1 9055.5 2264.1 2311.4 2314.9 2315.2 2315.7 2287.5 2312.4 2326.6 2329.9 2334.2 2310.5 2315.6 2336.9 2353.6 2359.1 2259.6 2264.8 2273.8 2284.2 2297.7 2267.1 2273.1 2277.3 2277.5 2278.1 8934.2 8996.1 9052.2 9067.5 9085.1 5074.4 5218.1 5234.1 5239.6 5244.9 3206.1 3240.6 3381.1 3416.6 3437.5 1026.4 1027.4 1029.5 1043.6 1053.6 12314.5 12392.8 12475.4 12489.8 12525.6 4471.9 4575.4 4720.6 4737.2 4771.5 10410.5 10484.6 10556.7 10584.6 10638.6 5253.6 5257.9 5259.1 5260.0 5290.3 4246.4 4427.7 4732.6 4798.6 4830.9 3912.5 3969.4 3979.7 4015.4 4047.2 1198.1 1212.8 1214.5 1222.6 1271.3 759.6 829.9 837.1 841.3 898.4 5345.0 5410.9 5433.8 5573.1 5596.9 907.8 928.2 929.7 944.9 971.0 3443.0 3653.5 3735.1 3811.7 3833.6 10987.1 11225.8 11244.2 11323.5 11337.8 11143.7 11205.7 11241.0 11246.8 11258.9 8011.3 8150.4 8186.7 8208.1 8219.5 5256.7 5260.9 5286.6 5395.2 5536.3 9655.2 9778.8 9812.4 9877.0 10020.5 10003.1 10082.4 10142.8 10171.6 10193.5 6739.5 6950.6 7483.1 7517.4 7647.5 8591.8 8865.8 8880.0 8894.9 8916.4 7758.1 7855.0 7909.9 8178.4 8208.8 7373.5 7527.9 7661.2 7702.8 7857.1 6675.7 6794.1 6796.4 6803.3 6804.7 4769.1 4895.7 4946.4 5096.7 5130.1 4962.2 4986.7 5076.6 5108.0 5123.3 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#4] prototype.html Cycles:180 Average:4717.24 Median:5242.22 stddev:1383.51 (26.4%) stddev-sans-first:1347.26 01:45:12 INFO - PROCESS | 14401 | Values: 309.9 322.4 323.2 328.3 333.9 5183.8 5325.3 5421.6 5498.0 5506.4 5147.6 5297.8 5298.4 5401.3 5408.4 4252.3 4260.1 4266.0 4275.9 4283.6 4151.8 4241.5 4258.7 4263.9 4292.5 4220.4 4222.4 4226.8 4229.5 4242.0 4196.2 4230.5 4244.7 4247.5 4257.9 3685.3 3781.8 3787.3 3789.2 3794.2 5200.9 5216.9 5217.3 5231.0 5253.4 4840.2 4843.2 4846.3 4860.1 4875.5 5323.6 5572.9 5586.6 5603.8 5648.4 4048.4 4048.8 4059.1 4059.5 4062.5 5831.9 5850.6 5905.9 5911.6 5945.2 4015.7 4089.3 4098.2 4102.3 4112.9 4130.4 4150.5 4151.1 4151.3 4183.4 4756.9 4768.5 4770.4 4779.9 4805.4 5460.5 5643.4 5658.3 5669.4 5688.4 1411.7 1440.8 1451.6 1452.5 1453.4 879.0 908.7 914.7 923.2 925.8 4752.5 4766.3 4771.3 4779.5 4812.5 5115.0 5124.2 5150.3 5162.6 5172.6 4829.3 4855.4 4928.5 4932.4 5107.9 3018.4 3057.5 3064.0 3078.3 3096.6 5906.9 5952.4 5967.4 5976.8 6012.8 5606.0 5891.6 5958.8 5965.9 5984.3 5819.7 5903.4 5909.3 5932.3 6006.4 5631.6 5832.4 5842.1 5872.4 5912.8 5731.4 5757.4 5765.9 5795.4 5801.0 5957.4 5958.1 5959.5 5965.0 5998.0 4151.7 4241.4 4255.6 4264.8 4273.1 5837.8 5856.2 5879.2 5893.0 5894.5 5500.2 5706.5 5721.6 5740.9 5742.2 5610.3 5633.7 5640.6 5644.9 5664.2 5636.7 5652.8 5676.8 5688.5 5689.5 5507.3 5655.5 5689.6 5693.7 5708.7 5467.8 5513.5 5523.0 5542.3 5557.5 01:45:12 INFO - PROCESS | 14401 | 01:45:12 INFO - PROCESS | 14401 | [#5] yui.html Cycles:180 Average:19786.02 Median:4720.08 stddev:27953.97 (592.2%) stddev-sans-first:27995.65 01:45:12 INFO - PROCESS | 14401 | Values: 699.9 766.2 771.5 783.6 786.8 16318.8 16966.7 17020.8 17051.0 17057.5 15143.0 15171.7 15243.1 15280.1 15433.2 765.1 785.1 786.1 786.9 787.1 755.5 783.4 784.1 785.9 788.1 838.6 843.3 843.8 844.2 844.9 821.8 825.7 830.4 831.2 833.8 607.8 609.0 611.9 611.9 612.7 14519.6 14592.7 14723.6 14737.7 14742.0 14427.5 14593.5 14613.6 14763.5 14800.5 12223.8 12233.5 12344.9 12634.0 12662.0 3676.4 3765.1 3767.7 3768.5 3926.4 80490.6 81199.1 82022.0 82465.6 82976.6 10653.6 10771.8 10814.4 11003.0 11124.0 18942.0 18966.7 18985.5 19108.4 19221.9 8198.0 8213.6 8294.0 8300.8 8404.9 4605.2 4732.6 4744.6 4748.8 4762.8 3629.3 3646.5 3696.1 3745.3 3762.4 618.2 619.9 625.2 630.2 647.5 619.4 663.7 668.9 675.3 678.8 8913.0 9295.0 9473.5 9495.4 9514.3 695.0 706.2 710.0 716.4 718.5 4349.0 4688.3 4707.6 4751.6 4751.7 62988.7 63379.7 63631.0 118262.4 123306.0 73147.3 105274.0 106533.5 107494.0 109002.0 55179.7 56662.2 76107.2 85968.6 91918.1 9278.8 9280.5 9524.3 9789.5 10234.4 48769.0 49927.8 50894.0 51112.5 52440.5 70182.0 71411.6 76972.6 77004.6 79773.0 12775.7 12888.1 12941.5 13066.3 13329.9 14310.3 14520.6 14565.5 14889.3 15371.5 13444.4 13644.9 13716.2 13795.2 14280.6 13632.8 13757.4 14069.3 14221.6 14379.9 11601.9 12931.2 12949.3 13045.2 13520.4 10980.7 11207.2 11241.9 11606.7 11654.5 10050.3 10201.6 10325.6 11819.9 11905.4 01:45:12 INFO - PROCESS | 14401 | -------- Summary: end -------- 01:45:12 INFO - PROCESS | 14401 | 01:45:13 INFO - TEST-INFO | 14401: exit 0 01:45:13 INFO - TEST-OK | dromaeo_css | took 1114893ms 01:45:13 INFO - TEST-START | kraken 01:45:13 INFO - operating with platform_type : linux_ 01:45:13 INFO - Initialising browser for kraken test... 01:45:13 INFO - TEST-INFO | started process 14763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp10Sko1/profile http://localhost:60464/getInfo.html) 01:45:17 INFO - PROCESS | 14763 | __metrics Screen width/height:1600/1200 01:45:17 INFO - PROCESS | 14763 | colorDepth:24 01:45:17 INFO - PROCESS | 14763 | Browser inner width/height: 1024/697 01:45:17 INFO - PROCESS | 14763 | __metrics 01:45:18 ERROR - PROCESS | 14763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 01:45:19 INFO - TEST-INFO | 14763: exit 0 01:45:19 INFO - Browser initialized. 01:45:19 INFO - Running cycle 1/1 for kraken test... 01:45:19 INFO - TEST-INFO | started process 14889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp10Sko1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:31 INFO - PROCESS | 14889 | RSS: Main: 185696256 01:45:31 INFO - PROCESS | 14889 | 01:45:33 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60464/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:34 INFO - PROCESS | 14889 | RSS: Main: 199274496 01:45:34 INFO - PROCESS | 14889 | 01:45:37 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60464/tests/kraken/driver.html?testName=audio-dft) 01:45:38 INFO - PROCESS | 14889 | RSS: Main: 197496832 01:45:38 INFO - PROCESS | 14889 | 01:45:41 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60464/tests/kraken/driver.html?testName=audio-fft) 01:45:41 INFO - PROCESS | 14889 | RSS: Main: 192782336 01:45:41 INFO - PROCESS | 14889 | 01:45:43 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60464/tests/kraken/driver.html?testName=audio-oscillator) 01:45:44 INFO - PROCESS | 14889 | RSS: Main: 193421312 01:45:44 INFO - PROCESS | 14889 | 01:45:46 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:47 INFO - PROCESS | 14889 | RSS: Main: 194056192 01:45:47 INFO - PROCESS | 14889 | 01:45:50 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60464/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:50 INFO - PROCESS | 14889 | RSS: Main: 194043904 01:45:50 INFO - PROCESS | 14889 | 01:45:54 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60464/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:55 INFO - PROCESS | 14889 | RSS: Main: 191922176 01:45:55 INFO - PROCESS | 14889 | 01:45:57 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60464/tests/kraken/driver.html?testName=json-parse-financial) 01:45:58 INFO - PROCESS | 14889 | RSS: Main: 193499136 01:45:58 INFO - PROCESS | 14889 | 01:46:00 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:00 INFO - PROCESS | 14889 | RSS: Main: 193855488 01:46:00 INFO - PROCESS | 14889 | 01:46:02 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:03 INFO - PROCESS | 14889 | RSS: Main: 193855488 01:46:03 INFO - PROCESS | 14889 | 01:46:05 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:05 INFO - PROCESS | 14889 | RSS: Main: 194404352 01:46:05 INFO - PROCESS | 14889 | 01:46:08 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:09 INFO - PROCESS | 14889 | RSS: Main: 194670592 01:46:09 INFO - PROCESS | 14889 | 01:46:12 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:12 INFO - PROCESS | 14889 | RSS: Main: 194838528 01:46:12 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | Cycle 1(1): loaded http://localhost:60464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60464/tests/kraken/driver.html?testName=ai-astar) 01:46:14 INFO - PROCESS | 14889 | RSS: Main: 195874816 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | __start_tp_report 01:46:14 INFO - PROCESS | 14889 | _x_x_mozilla_page_load 01:46:14 INFO - PROCESS | 14889 | _x_x_mozilla_page_load_details 01:46:14 INFO - PROCESS | 14889 | |i|pagename|runs| 01:46:14 INFO - PROCESS | 14889 | |0;ai-astar;107;112;113;112;112;113;112;112;112;113 01:46:14 INFO - PROCESS | 14889 | |1;audio-beat-detection;155;122;125;178;130;128;124;127;152;132 01:46:14 INFO - PROCESS | 14889 | |2;audio-dft;163;163;166;172;167;164;164;163;166;163 01:46:14 INFO - PROCESS | 14889 | |3;audio-fft;76;77;75;116;79;76;77;84;115;76 01:46:14 INFO - PROCESS | 14889 | |4;audio-oscillator;83;82;109;83;82;84;99;84;82;122 01:46:14 INFO - PROCESS | 14889 | |5;imaging-gaussian-blur;118;117;119;119;119;117;118;118;117;119 01:46:14 INFO - PROCESS | 14889 | |6;imaging-darkroom;149;146;147;147;150;147;148;146;147;149 01:46:14 INFO - PROCESS | 14889 | |7;imaging-desaturate;96;98;95;95;96;95;95;96;97;96 01:46:14 INFO - PROCESS | 14889 | |8;json-parse-financial;54;52;56;53;54;55;54;55;57;54 01:46:14 INFO - PROCESS | 14889 | |9;json-stringify-tinderbox;64;64;63;63;63;63;63;62;62;65 01:46:14 INFO - PROCESS | 14889 | |10;stanford-crypto-aes;81;81;90;82;81;86;82;80;80;80 01:46:14 INFO - PROCESS | 14889 | |11;stanford-crypto-ccm;139;138;150;136;136;131;152;148;183;134 01:46:14 INFO - PROCESS | 14889 | |12;stanford-crypto-pbkdf2;170;167;171;167;168;170;168;167;166;166 01:46:14 INFO - PROCESS | 14889 | |13;stanford-crypto-sha256-iterative;67;68;67;73;65;68;67;69;69;66 01:46:14 INFO - PROCESS | 14889 | __end_tp_report 01:46:14 INFO - PROCESS | 14889 | __start_cc_report 01:46:14 INFO - PROCESS | 14889 | _x_x_mozilla_cycle_collect,777 01:46:14 INFO - PROCESS | 14889 | __end_cc_report 01:46:14 INFO - PROCESS | 14889 | __startTimestamp1475829974894__endTimestamp 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | ------- Summary: start ------- 01:46:14 INFO - PROCESS | 14889 | Number of tests: 14 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.75 (1.6%) stddev-sans-first:0.50 01:46:14 INFO - PROCESS | 14889 | Values: 107.0 112.0 113.0 112.0 112.0 113.0 112.0 112.0 112.0 113.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:131.00 stddev:18.32 (14.0%) stddev-sans-first:18.28 01:46:14 INFO - PROCESS | 14889 | Values: 155.0 122.0 125.0 178.0 130.0 128.0 124.0 127.0 152.0 132.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.85 (1.7%) stddev-sans-first:2.92 01:46:14 INFO - PROCESS | 14889 | Values: 163.0 163.0 166.0 172.0 167.0 164.0 164.0 163.0 166.0 163.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#3] audio-fft Cycles:10 Average:85.10 Median:76.50 stddev:16.22 (21.2%) stddev-sans-first:16.87 01:46:14 INFO - PROCESS | 14889 | Values: 76.0 77.0 75.0 116.0 79.0 76.0 77.0 84.0 115.0 76.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:14.21 (17.1%) stddev-sans-first:14.78 01:46:14 INFO - PROCESS | 14889 | Values: 83.0 82.0 109.0 83.0 82.0 84.0 99.0 84.0 82.0 122.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.93 01:46:14 INFO - PROCESS | 14889 | Values: 118.0 117.0 119.0 119.0 119.0 117.0 118.0 118.0 117.0 119.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.33 01:46:14 INFO - PROCESS | 14889 | Values: 149.0 146.0 147.0 147.0 150.0 147.0 148.0 146.0 147.0 149.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 01:46:14 INFO - PROCESS | 14889 | Values: 96.0 98.0 95.0 95.0 96.0 95.0 95.0 96.0 97.0 96.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.43 (2.6%) stddev-sans-first:1.51 01:46:14 INFO - PROCESS | 14889 | Values: 54.0 52.0 56.0 53.0 54.0 55.0 54.0 55.0 57.0 54.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 01:46:14 INFO - PROCESS | 14889 | Values: 64.0 64.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 65.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.50 stddev:3.23 (4.0%) stddev-sans-first:3.40 01:46:14 INFO - PROCESS | 14889 | Values: 81.0 81.0 90.0 82.0 81.0 86.0 82.0 80.0 80.0 80.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:143.50 stddev:15.24 (10.6%) stddev-sans-first:16.02 01:46:14 INFO - PROCESS | 14889 | Values: 139.0 138.0 150.0 136.0 136.0 131.0 152.0 148.0 183.0 134.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:1.76 (1.0%) stddev-sans-first:1.72 01:46:14 INFO - PROCESS | 14889 | Values: 170.0 167.0 171.0 167.0 168.0 170.0 168.0 167.0 166.0 166.0 01:46:14 INFO - PROCESS | 14889 | 01:46:14 INFO - PROCESS | 14889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.18 (3.2%) stddev-sans-first:2.29 01:46:14 INFO - PROCESS | 14889 | Values: 67.0 68.0 67.0 73.0 65.0 68.0 67.0 69.0 69.0 66.0 01:46:14 INFO - PROCESS | 14889 | -------- Summary: end -------- 01:46:14 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | 01:46:15 INFO - PROCESS | 14889 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 01:46:15 INFO - PROCESS | 14889 | 01:46:16 INFO - TEST-INFO | 14889: exit 0 01:46:16 INFO - TEST-OK | kraken | took 62910ms 01:46:16 INFO - SUITE-END | took 1177s 01:46:16 INFO - Completed test suite (00:19:38) 01:46:16 INFO - javascript benchmark 01:46:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7128.969746786457, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.6352437707474, 3047.847607619621, 3072.324088700486, 3074.538819177123, 3103.162146220519, 5070.442251352349, 5189.506996835299, 5302.504511293106, 5303.946960530398, 5404.000259951912, 5124.026434977361, 5228.581713462923, 5302.1781623848365, 5320.14877619581, 5369.087255166622, 4793.9280910786365, 4898.485659005806, 4919.335889654904, 4951.43058548268, 4954.380702412199, 4920.434150072751, 4943.604511639078, 4950.826721064764, 4965.602751779867, 5024.62315326352, 4630.421197350332, 4663.207254766698, 4719.362886010379, 4827.8551643450755, 4844.709317440947, 4764.976175119137, 4787.32443644725, 4811.639127065484, 4831.855044348676, 4855.951440485621, 4831.734254615994, 4846.7818948147415, 4893.730844803535, 4895.9755201224125, 4907.533784290486, 5102.928385039109, 5133.230015497668, 5336.252924590561, 5341.43914888935, 5397.055515284809, 5564.8052318169075, 5597.0, 5616.1014237722175, 5643.266375371217, 5702.144678298288, 5613.80351687693, 5640.125780504029, 5657.547396208293, 5664.49019588239, 5670.801521946753, 5048.949510504922, 5260.999999999962, 5281.39263984639, 5303.443138470482, 5340.145576707708, 5541.196526503634, 5656.8868622627315, 5699.914501282484, 5710.571707121982, 5797.507211887037, 5507.449255074541, 5512.0, 5514.117741161475, 5516.172574113915, 5526.281583394133, 5364.088105022156, 5442.455754424526, 5533.501984821305, 5545.833624991256, 5606.439356064442, 5460.372057213472, 5616.073347897551, 5617.297837770278, 5717.514011309002, 5726.427357264323, 5639.097744360883, 5653.830385088454, 5654.97172514143, 5659.660420374708, 5676.772929082873, 4343.326784348431, 4388.714733542373, 4390.62679672225, 4410.25025745624, 4425.513193548707, 3815.1606646537716, 3833.0800607853917, 3907.1404291055924, 3954.8022598869943, 3971.5234171899556, 5430.15832545956, 5466.426025267369, 5466.972665136649, 5470.261514695545, 5533.944660553343, 5643.802466913638, 5706.229658996065, 5727.656340619493, 5738.053221218535, 5753.367129615739, 5163.845084647466, 5206.609504287194, 5295.258663787073, 5301.734913254322, 5498.5876059295715, 4826.710397376099, 4835.178019736582, 4835.516448355136, 4869.245266983623, 4887.242477416006, 5651.067573850269, 5673.864927917748, 5676.176954341515, 5683.403242659544, 5736.139579063174, 5416.106342453451, 5463.180522921593, 5588.0, 5599.300087489064, 5613.382527922007, 5704.885902281848, 5758.568107391879, 5776.162456443876, 5834.358220595816, 5839.824805255849, 5528.502434780889, 5568.972155139199, 5577.721113944205, 5594.692291923983, 5625.324961004706, 5317.654352467077, 5416.350037995308, 5666.206731057573, 5711.685857277724, 5718.3423906249645, 5379.757910893941, 5405.8918821622565, 5420.864478388072, 5456.017916775018, 5507.9449205507435, 5422.701751403711, 5427.294451721251, 5429.972850135724, 5432.592555558428, 5433.239346491573, 5244.580433565229, 5262.973720124539, 5408.296921400193, 5411.864703382447, 5479.369872464717, 5531.03206938776, 5618.831435056954, 5625.071863142535, 5672.347680016685, 5716.171155182392, 5433.022056029795, 5468.4531546845, 5479.013777520085, 5494.752736126964, 5501.229827824028], "value": 5197.588629423653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.7827890564866, 550.573305688092, 568.2612603615299, 595.306467964821, 600.1118344849624, 39550.802245988765, 41127.17745645089, 41214.58785412145, 44798.32802507965, 45020.54979450205, 43993.34009989845, 44338.556614433845, 44376.0, 44488.55511444885, 44556.55443445565, 8884.0, 8945.373823832302, 8945.865812012826, 8946.552672366355, 9038.276937844958, 8632.697855575056, 8766.167214114648, 8796.604152813139, 8891.11088891109, 8913.77715557113, 8905.599248033821, 8924.910750892474, 8959.552022398886, 8965.058668839776, 8977.967533733607, 8873.68942087027, 8885.42244754089, 8891.155340242667, 8904.376693631448, 8907.73276801697, 8735.257503112243, 8761.605727742266, 8789.428687135316, 8801.383903126783, 8834.646614135427, 41019.794901025605, 41145.382819257735, 41276.38085428721, 41374.1725165495, 41475.7926210367, 3522.929541409183, 3551.3430015447225, 3687.8893633191046, 3842.212346468967, 3964.226975739732, 30941.535876961865, 31225.0, 31308.686913130805, 31407.214819629462, 33036.17409564756, 4228.175505776375, 4365.738055716667, 4398.7580683062415, 4476.686631935766, 4543.091381723635, 330272.0, 331057.0, 331642.0, 332762.0, 333760.0, 53423.46576534185, 53449.46550534523, 53590.0, 53615.0, 53677.7316113417, 50830.74584627053, 51110.0, 51392.48607513877, 51657.0, 51711.22433163506, 16464.0, 16626.418075367303, 16683.6663266734, 16751.832481675272, 16825.326986920387, 12552.686182845502, 12594.244345339126, 12596.55912043074, 12599.811002834966, 12620.495180192689, 14948.0, 14996.625084372978, 15148.182218133674, 15166.393344266105, 15337.30982105808, 5503.807366742225, 5594.272744543184, 5606.747696353674, 5725.656460612377, 5741.827745167651, 873.8427083125099, 975.11264749078, 1026.1226651213256, 1052.1372474570778, 1056.7041228455892, 30506.38987220243, 31056.0, 31513.842430788158, 31587.037785663106, 31733.523997140062, 1017.3488967061087, 1053.089077947585, 1086.8424078508572, 1091.2906610703108, 1115.481301194932, 15825.841741582668, 16439.753403698716, 16509.0, 16519.91740041292, 16599.41902033423, 447655.0, 451315.6907939085, 453288.0, 453962.0, 454164.0, 55419.44580554143, 56042.71978640162, 56125.438745612024, 56454.7177264111, 56479.15281270784, 1209.564556759566, 1237.406045098358, 1250.9562165324353, 1266.3984607311454, 1302.3683513495946, 29047.854760726907, 30381.544276835422, 30808.845955770077, 30985.53521697131, 31314.686853131177, 47200.69595128308, 47872.76063619799, 47961.32135375245, 48056.5194348052, 48106.27840582464, 389197.0, 390487.0, 393227.0, 393588.0, 394015.0, 38163.0, 38548.6145138545, 38884.416733748454, 38913.610863891, 39231.0, 44477.0, 45212.54787452083, 45566.0, 46786.76606616945, 47084.29373559468, 38493.615063849, 38641.68149911014, 38948.2210355797, 40314.596854031086, 40545.59454405536, 38070.048248794, 38261.234775304896, 38873.0, 39505.209895802494, 39882.60117398905, 38498.6150138495, 38900.6109938897, 39548.802255988536, 39574.0, 42037.36943945782, 30632.84683576568, 35042.649573503935, 35890.10274743152, 35908.4613730789, 36287.81856090808, 26668.59997100084, 26877.328066798487, 26977.0, 27288.317792055357, 27734.0], "value": 19348.162036696936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.15323135869727, 389.60649743758796, 393.6752179451952, 395.8871721559356, 420.77067997941117, 17691.64616707665, 19428.51428714283, 19454.41636750898, 19612.70580941287, 20058.297959571417, 17544.210510527024, 18958.43124706261, 19344.80655193448, 19401.805981940175, 19695.5076123097, 5484.561235101202, 5534.529564986981, 5596.244506991545, 5679.261695979538, 5752.050911599581, 5589.972050139743, 5621.325440947092, 5669.886602267952, 5691.601587888849, 5704.11586204137, 5457.645253058538, 5557.194206840026, 5595.580331475136, 5605.327360716719, 5658.43415658435, 5405.540529055035, 5415.864603384907, 5417.783288668468, 5440.782368705267, 5443.537299329581, 4812.435958313562, 4845.200541910581, 5022.8196373852115, 5024.899502009976, 5033.144365457844, 22752.886235568716, 22842.543149136924, 22900.770992290032, 22924.312270631908, 23364.7663523366, 2076.781937896529, 2140.475583482041, 2144.9249276275254, 2293.724753029647, 2540.5808041673104, 9948.90051099487, 10072.798544029152, 10139.340942838766, 10317.226208034428, 10490.108340791043, 1920.6446807340687, 1928.807119288074, 1938.8545859060628, 1961.1763059515038, 1989.6816509358578, 79643.20356796416, 82702.58648706778, 83463.58268208681, 83538.58230708868, 84219.15780842175, 10545.525451354708, 10621.0, 10825.512851921683, 11415.942920285512, 11607.129465290138, 14871.256437178097, 15089.698206035819, 15100.697986040217, 15365.6158596036, 15454.845451545565, 7791.181925897699, 8168.550729709923, 8186.140455252113, 8352.290055345242, 8443.74668759926, 7994.440389172818, 7994.84010319802, 8111.9594402027615, 8366.748997530083, 8395.0, 4338.7830608470085, 4477.350784136282, 4506.121306345297, 4753.287006948916, 4763.952360476351, 1920.4910698664864, 1961.146901098027, 1978.9703154452695, 1992.282778199847, 2029.289748588012, 909.2453263791169, 944.1596978688972, 959.738759906015, 972.5526257921435, 973.6105557776946, 18230.427112579768, 19367.0, 19577.902110489358, 19884.304049358492, 20048.298309559097, 955.3217215776876, 967.9304368672656, 985.9507024648882, 1002.3184234720314, 1029.0686928329874, 10472.68581942543, 11007.449627518752, 11011.559537618567, 11052.889471105185, 11072.723181920517, 439416.0, 440566.0, 445700.0, 446528.0, 450739.0, 86310.0, 87999.0, 88966.0, 91136.0, 96099.0, 871.2724874729672, 924.3668087360314, 937.1659223291276, 939.2298315381458, 941.4727752458645, 16684.0, 16902.57743556421, 17355.219015144095, 17646.558836029202, 17892.642147156723, 39927.40108898427, 39941.40087898626, 40208.396874047496, 40579.79710101431, 41162.0, 54301.0, 54962.90074198414, 56553.43446565482, 56800.0, 57509.712451437474, 8320.500769953822, 8387.496750194763, 8405.327573794204, 8606.483610983361, 8750.037495875322, 9447.81104377895, 11977.461014254206, 12669.239845609292, 12778.936105319413, 13159.0, 11386.316820990767, 11544.653660390202, 11636.12729045342, 11775.52897884075, 11840.348780817138, 11143.554257829595, 11268.267562608733, 11356.26184298018, 11401.144914131639, 11410.087193024705, 11472.770544588895, 11648.0, 11648.592299269485, 11910.52357905674, 11927.0, 8430.15698430152, 8625.69810056645, 8679.132086791271, 8767.342449316198, 8948.373613846969, 10122.44326562046, 11357.602483913024, 11543.249688770538, 11590.072794176276, 11742.060635148997], "value": 9038.034539187034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.6101572067682, 1447.4789075932665, 1538.2616344154806, 1663.8585720213782, 1741.1903464888824, 7761.3402860756905, 7947.960260198705, 8536.274416674582, 9190.44857308561, 9208.217301529377, 8513.489190648565, 8829.867551986725, 8844.513551754651, 9036.09639036096, 9055.456672599648, 2264.116994372196, 2311.387482317179, 2314.884255787212, 2315.166540045582, 2315.7452680205165, 2287.5245466673987, 2312.4218945263683, 2326.5928462519078, 2329.9184528541505, 2334.206369834256, 2310.480141968052, 2315.5716192504356, 2336.8597884127007, 2353.5528249632516, 2359.0563774490256, 2259.5706815705043, 2264.830137739676, 2273.761255068219, 2284.23478134825, 2297.7127859017623, 2267.1384873748034, 2273.090763694519, 2277.339571524256, 2277.4761804784825, 2278.1343089625834, 8934.151255630704, 8996.055414181548, 9052.185303322733, 9067.54662266884, 9085.091490850928, 5074.416442109131, 5218.13900706383, 5234.0840352938085, 5239.607029472805, 5244.868878278074, 3206.1022913584234, 3240.578724765789, 3381.104007438006, 3416.572928383952, 3437.5359326491102, 1026.3739119137394, 1027.36648728522, 1029.541853875026, 1043.6034306963306, 1053.5627714498473, 12314.50741970329, 12392.752144957141, 12475.376231188404, 12489.75020499594, 12525.624231273076, 4471.8658440246845, 4575.405197324327, 4720.598749106296, 4737.194676904935, 4771.5467030632035, 10410.531526081344, 10484.63303784364, 10556.683299501028, 10584.576616935236, 10638.627648032436, 5253.632245742838, 5257.921131183035, 5259.105951988095, 5260.0, 5290.338707661543, 4246.363045543193, 4427.712198707074, 4732.645051621143, 4798.640101992295, 4830.879228019257, 3912.4522566840665, 3969.364901615728, 3979.7015223858325, 4015.417764424142, 4047.1500984793524, 1198.1493139870615, 1212.8483939507562, 1214.5445457953267, 1222.5537678747194, 1271.2817258249245, 759.5860256160406, 829.9377546684022, 837.1084794693631, 841.3479553346206, 898.4339865884451, 5344.9732751336, 5410.8917821643345, 5433.8369848904595, 5573.108302671553, 5596.86007849807, 907.7790371949717, 928.2388441478058, 929.6560272699145, 944.8661606072603, 970.9611615535441, 3443.0, 3653.451982202691, 3735.14091758897, 3811.733178677521, 3833.639058134322, 10987.066099381642, 11225.775484490265, 11244.156688248415, 11323.490442930088, 11337.773244535063, 11143.665690029313, 11205.663830084948, 11241.044511216638, 11246.831297530543, 11258.943705281421, 8011.319037881729, 8150.429469937166, 8186.672533098728, 8208.056073551617, 8219.54792486407, 5256.6583172095225, 5260.868478288074, 5286.603504737083, 5395.190721391823, 5536.307961504812, 9655.22758179358, 9778.804423911339, 9812.411255324703, 9876.950615246878, 10020.498975051072, 10003.099721025143, 10082.395056296646, 10142.797144057226, 10171.643992460524, 10193.490325483845, 6739.528233023641, 6950.6177160256675, 7483.139438964588, 7517.398608111447, 7647.464677472523, 8591.828163436572, 8865.778355541162, 8880.0, 8894.911050889408, 8916.375853690179, 7758.107817600822, 7855.0, 7909.920900791149, 8178.427510074475, 8208.794780130305, 7373.520721153108, 7527.924720752722, 7661.195574464601, 7702.768916932501, 7857.096433910174, 6675.699593518206, 6794.082798822095, 6796.422304104207, 6803.319668033157, 6804.693788779417, 4769.141554520081, 4895.657303988829, 4946.35697359341, 5096.745162741774, 5130.102232109291, 4962.213603102808, 4986.7257300848805, 5076.593872490118, 5107.974460127675, 5123.257127716534], "value": 4556.060416575894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.91322429719685, 322.40194439315076, 323.1678428047775, 328.2990814610805, 333.9432296509593, 5183.770978479252, 5325.281087053257, 5421.566274698024, 5498.0, 5506.394296627373, 5147.613928955325, 5297.814576489824, 5298.36419629644, 5401.297831281928, 5408.3509978802595, 4252.319628859375, 4260.105377870651, 4266.018815672397, 4275.850345237917, 4283.593058659422, 4151.813168407429, 4241.533431322568, 4258.74447533149, 4263.91472170558, 4292.549282325358, 4220.430241917333, 4222.387753775701, 4226.788660566975, 4229.471316085489, 4241.957580424202, 4196.202721482939, 4230.534641189467, 4244.681648876332, 4247.490301163849, 4257.850380397306, 3685.318216129998, 3781.7541859779026, 3787.3182827091114, 3789.2232092420986, 3794.2221844521805, 5200.92198617021, 5216.895662086775, 5217.269582258449, 5231.0, 5253.44838791929, 4840.177169881129, 4843.2250839865455, 4846.297286893416, 4860.125177468054, 4875.488073752241, 5323.577772113679, 5572.944270557283, 5586.581006424534, 5603.775848966036, 5648.406917273668, 4048.3522636378334, 4048.7975601220114, 4059.106996460774, 4059.5128584569748, 4062.4921884764403, 5831.9416805831825, 5850.5612079094235, 5905.911411328833, 5911.586188966774, 5945.197398351211, 4015.698822588259, 4089.284375234322, 4098.221337945841, 4102.343625019982, 4112.930638034132, 4130.380442933584, 4150.460440142822, 4151.107511884959, 4151.335786274181, 4183.414321994923, 4756.857294281177, 4768.472709463989, 4770.379850619397, 4779.856604301876, 4805.423349198119, 5460.481254280917, 5643.40744221859, 5658.264425624642, 5669.376368599451, 5688.40271771458, 1411.682371466412, 1440.819897512811, 1451.5717863230373, 1452.5279284232668, 1453.4186325469684, 878.991210087891, 908.6774195160623, 914.693577651481, 923.2244914272044, 925.796324808541, 4752.5485078917445, 4766.285057241442, 4771.260454629538, 4779.450363208275, 4812.5081224820415, 5114.974425127925, 5124.180131178993, 5150.253213284052, 5162.612804039637, 5172.560332371715, 4829.2997515360075, 4855.36880205571, 4928.486471899286, 4932.358793356912, 5107.897842043139, 3018.3510545232443, 3057.5260834570677, 3063.9582541935847, 3078.322768990863, 3096.5664806927048, 5906.911396329058, 5952.375000624958, 5967.433093856077, 5976.818461261695, 6012.819615411545, 5605.971970140124, 5891.646501209942, 5958.791442299499, 5965.910511342333, 5984.251968503937, 5819.6508209507565, 5903.35063143054, 5909.2908850938165, 5932.3474417814, 6006.429389208019, 5631.605787594829, 5832.445917637818, 5842.078960519741, 5872.412758724265, 5912.793052243151, 5731.423858438962, 5757.36668966405, 5765.875654247381, 5795.449432304093, 5800.970995145166, 5957.4042595740075, 5958.1360702697, 5959.4934430573885, 5964.970175149097, 5997.970010149921, 4151.709380343347, 4241.3637954307105, 4255.553166917429, 4264.808083636306, 4273.077115298066, 5837.766489340379, 5856.180134781219, 5879.206307148651, 5892.970535147297, 5894.498967587803, 5500.202470641814, 5706.514946229617, 5721.570882183936, 5740.856478587902, 5742.224799652161, 5610.326760788732, 5633.746481408264, 5640.5769567281795, 5644.887102258014, 5664.178694089416, 5636.661800291996, 5652.823662889735, 5676.801311954062, 5688.516476099578, 5689.516391106802, 5507.256520369699, 5655.539840169539, 5689.573282003949, 5693.743781529758, 5708.65748055118, 5467.781288748564, 5513.483791957244, 5522.972385138049, 5542.307211598551, 5557.527610153183], "value": 4269.862638929934, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.9090118284623, 766.1610536462575, 771.4753967302236, 783.6277768060169, 786.7993661616287, 16318.83681163188, 16966.660666786658, 17020.829791702112, 17051.0, 17057.488275351727, 15143.0, 15171.696566068673, 15243.085414875088, 15280.083195008307, 15433.228338583081, 765.1124695353377, 785.1049803224329, 786.1273985875673, 786.8622990976585, 787.0751866556801, 755.5391211361066, 783.4359261331832, 784.1139512351035, 785.9174786647377, 788.0779487999055, 838.6310023589601, 843.3337663246059, 843.7806170395711, 844.1727107434717, 844.8648216285395, 821.8233079887852, 825.6903661127077, 830.4477522447565, 831.2020460358063, 833.8123922117536, 607.8146165419545, 609.0377204017685, 611.8990366589508, 611.9326874043852, 612.7334609444906, 14519.637009074857, 14592.708145837023, 14723.631909202248, 14737.705245895022, 14742.041767285093, 14427.49503767363, 14593.489227876973, 14613.634659133606, 14763.483278085216, 14800.481983130647, 12223.755524889453, 12233.510659573607, 12344.938275308567, 12634.0, 12662.0, 3676.3750162472443, 3765.1340191755776, 3767.6797472214894, 3768.4510579769576, 3926.3717805151323, 80490.59754701247, 81199.14432515665, 82022.0, 82465.58767206185, 82976.58511707404, 10653.627123050655, 10771.83842242367, 10814.35113893169, 11003.0, 11124.0, 18942.0, 18966.71549926752, 18985.525361866064, 19108.426747197605, 19221.90389048046, 8197.959010204911, 8213.589320533949, 8293.95853020731, 8300.792480188044, 8404.94078950661, 4605.171069207575, 4732.574068333797, 4744.572988431058, 4748.833790817304, 4762.809487620526, 3629.274145170976, 3646.4712616670963, 3696.094456858087, 3745.3445647011663, 3762.360398732222, 618.2025187508065, 619.8698273362644, 625.221599109112, 630.180765005491, 647.543481845298, 619.4394073363613, 663.7378235597009, 668.9130413046273, 675.2740803636111, 678.7510979797098, 8913.0, 9295.0, 9473.526323683926, 9495.43027418357, 9514.33399662031, 694.9583025018516, 706.2231545300232, 710.0, 716.4125417157985, 718.5114122396716, 4348.9565104349185, 4688.2733176357715, 4707.576318131385, 4751.572358487752, 4751.691140075953, 62988.685056574424, 63379.683101584196, 63631.0, 118262.408687956, 123306.0, 73147.26852731405, 105274.0, 106533.4673326644, 107494.0, 109002.0, 55179.72410137924, 56662.15006774902, 76107.23892761001, 85968.57015714882, 91918.10614203828, 9278.814423711623, 9280.489573073275, 9524.333296669443, 9789.510524473606, 10234.437105959243, 48769.0, 49927.75036124796, 50894.0, 51112.48887511077, 52440.47559524356, 70182.0, 71411.64294178496, 76972.61513692395, 77004.61497692476, 79773.0, 12775.680607984874, 12888.097833151964, 12941.482340706267, 13066.281354525212, 13329.866701332863, 14310.284485775877, 14520.636984075483, 14565.490207843099, 14889.329980150702, 15371.538853834403, 13444.39500222512, 13644.93177534106, 13716.24560649134, 13795.241261730702, 14280.571582852532, 13632.795508067586, 13757.38091785852, 14069.296535172996, 14221.64445888861, 14379.928100359431, 11601.941990289995, 12931.159474634118, 12949.287789171685, 13045.217286962812, 13520.391582379014, 10980.725481863017, 11207.159463040467, 11241.943790280997, 11606.70983225426, 11654.53381864716, 10050.321013361156, 10201.591936322464, 10325.586976520855, 11819.940900295443, 11905.40472976365], "value": 7423.309573270349, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 125.0, 178.0, 130.0, 128.0, 124.0, 127.0, 152.0, 132.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 172.0, 167.0, 164.0, 164.0, 163.0, 166.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 116.0, 79.0, 76.0, 77.0, 84.0, 115.0, 76.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 83.0, 82.0, 84.0, 99.0, 84.0, 82.0, 122.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 119.0, 119.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 147.0, 150.0, 147.0, 148.0, 146.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 56.0, 53.0, 54.0, 55.0, 54.0, 55.0, 57.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 65.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 90.0, 82.0, 81.0, 86.0, 82.0, 80.0, 80.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 150.0, 136.0, 136.0, 131.0, 152.0, 148.0, 183.0, 134.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 171.0, 167.0, 168.0, 170.0, 168.0, 167.0, 166.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 73.0, 65.0, 68.0, 67.0, 69.0, 69.0, 66.0], "value": 67.9, "unit": "score"}]}]} 01:46:16 INFO - Return code: 0 01:46:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:46:16 ERROR - # TBPL SUCCESS # 01:46:16 INFO - Running post-action listener: _resource_record_post_action 01:46:16 INFO - [mozharness: 2016-10-07 08:46:16.726011Z] Finished run-tests step (success) 01:46:16 INFO - Running post-run listener: _resource_record_post_run 01:46:16 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409620480; Read time: 8; Write time: 231888 01:46:16 INFO - TinderboxPrint: CPU usage
13.4% 01:46:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:46:16 INFO - TinderboxPrint: I/O write bytes / time
409,620,480 / 231,888 01:46:16 INFO - TinderboxPrint: CPU idle
8,259.1 (86.6%) 01:46:16 INFO - TinderboxPrint: CPU user
1,217.7 (12.8%) 01:46:16 INFO - TinderboxPrint: Swap in / out
0 / 0 01:46:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120811520; Read time: 0; Write time: 64804 01:46:16 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288808960; Read time: 0; Write time: 167084 01:46:17 INFO - Running post-run listener: _upload_blobber_files 01:46:17 INFO - Blob upload gear active. 01:46:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:17 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 01:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:46:17 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:46:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:46:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:18 INFO - (blobuploader) - INFO - Done attempting. 01:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:19 INFO - (blobuploader) - INFO - Done attempting. 01:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:22 INFO - (blobuploader) - INFO - Done attempting. 01:46:22 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:22 INFO - Return code: 0 01:46:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22db4c3033f266cd5db629fb104d6b5727771e16f9955c686021e291edc766c41a46771e8edbbd237d576d64fb001ab8bfdab3086e30a859d10877c77badc299", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94f99b43c710a4e07cf592d4019ac6cac1bc9db431ad89085344b91e3e96d787e407bb9aeb69b411191d038d1a256e3bc80ae208fe7076444bcb38683538f6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aedc4c107b1a756dd661bcd8453c5eb25e0722159dc8a59cabb7ba14a6b083111d59742a4ba83021f618c2b1cdcc9d847835b42c0efcfe9072c3f1529604c14"} 01:46:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:22 INFO - Contents: 01:46:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22db4c3033f266cd5db629fb104d6b5727771e16f9955c686021e291edc766c41a46771e8edbbd237d576d64fb001ab8bfdab3086e30a859d10877c77badc299", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94f99b43c710a4e07cf592d4019ac6cac1bc9db431ad89085344b91e3e96d787e407bb9aeb69b411191d038d1a256e3bc80ae208fe7076444bcb38683538f6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aedc4c107b1a756dd661bcd8453c5eb25e0722159dc8a59cabb7ba14a6b083111d59742a4ba83021f618c2b1cdcc9d847835b42c0efcfe9072c3f1529604c14"} 01:46:22 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:22 INFO - Copying logs to upload dir... 01:46:22 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.525423 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-07 01:46:21.852977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:21.856878) ========= 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=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22db4c3033f266cd5db629fb104d6b5727771e16f9955c686021e291edc766c41a46771e8edbbd237d576d64fb001ab8bfdab3086e30a859d10877c77badc299", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94f99b43c710a4e07cf592d4019ac6cac1bc9db431ad89085344b91e3e96d787e407bb9aeb69b411191d038d1a256e3bc80ae208fe7076444bcb38683538f6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aedc4c107b1a756dd661bcd8453c5eb25e0722159dc8a59cabb7ba14a6b083111d59742a4ba83021f618c2b1cdcc9d847835b42c0efcfe9072c3f1529604c14"} build_url:https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/Qo9cFjk1SryZVRKfqxFm8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22db4c3033f266cd5db629fb104d6b5727771e16f9955c686021e291edc766c41a46771e8edbbd237d576d64fb001ab8bfdab3086e30a859d10877c77badc299", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94f99b43c710a4e07cf592d4019ac6cac1bc9db431ad89085344b91e3e96d787e407bb9aeb69b411191d038d1a256e3bc80ae208fe7076444bcb38683538f6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8aedc4c107b1a756dd661bcd8453c5eb25e0722159dc8a59cabb7ba14a6b083111d59742a4ba83021f618c2b1cdcc9d847835b42c0efcfe9072c3f1529604c14"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:21.887733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:21.888129) ========= 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=523ca41ca1e0623de333ad52000001bf-1475828368.276506-1138085160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 01:46:21.971914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 01:46:21.972320) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 01:46:21.972681) ========= ========= Total master_lag: 0.19 =========