builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1466125226.38 results: success (0) buildid: 20160616163123 builduid: 4da5b2e960374af499b5667814982984 revision: 05873df0c0c268e419a714b8a6204cb852049098 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:26.376824) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:26.377290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-06-16 18:00:26.377625) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-06-16 18:00:27.814046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:27.814310) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 18:00:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-06-16 18:00:28 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078198 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:27.908074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:27.908404) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019963 ========= master_lag: 0.32 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:28.243598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:28.244003) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05873df0c0c268e419a714b8a6204cb852049098 --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 05873df0c0c268e419a714b8a6204cb852049098 --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=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 18:00:28,856 truncating revision to first 12 chars 2016-06-16 18:00:28,856 Setting DEBUG logging. 2016-06-16 18:00:28,857 attempt 1/10 2016-06-16 18:00:28,857 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05873df0c0c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 18:00:29,143 unpacking tar archive at: mozilla-central-05873df0c0c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641401 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:29.014067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:29.014354) ========= script_repo_revision: 05873df0c0c268e419a714b8a6204cb852049098 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:29.014760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:29.015144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 18:00:29.028564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-16 18:00:29.028829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:00:29 INFO - MultiFileLogger online at 20160616 18:00:29 in /builds/slave/test 18:00:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:00:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:00:29 INFO - {'append_to_log': False, 18:00:29 INFO - 'base_work_dir': '/builds/slave/test', 18:00:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:00:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:00:29 INFO - 'branch': 'Firefox-Non-PGO', 18:00:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:00:29 INFO - 'config_files': ('talos/linux_config.py',), 18:00:29 INFO - 'default_actions': ('clobber', 18:00:29 INFO - 'read-buildbot-config', 18:00:29 INFO - 'download-and-extract', 18:00:29 INFO - 'populate-webroot', 18:00:29 INFO - 'create-virtualenv', 18:00:29 INFO - 'install', 18:00:29 INFO - 'run-tests'), 18:00:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:00:29 INFO - 'download_minidump_stackwalk': True, 18:00:29 INFO - 'download_symbols': 'ondemand', 18:00:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:00:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:00:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:00:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:00:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:00:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:00:29 INFO - 'installer_path': 'installer.exe', 18:00:29 INFO - 'log_level': 'info', 18:00:29 INFO - 'log_name': 'talos', 18:00:29 INFO - 'log_to_console': True, 18:00:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:00:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:00:29 INFO - 'opt_config_files': (), 18:00:29 INFO - 'pip_index': False, 18:00:29 INFO - 'sps_profile': False, 18:00:29 INFO - 'sps_profile_interval': 0, 18:00:29 INFO - 'suite': 'dromaeojs-e10s', 18:00:29 INFO - 'system_bits': '32', 18:00:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:00:29 INFO - 'title': 'talos-linux64-ix-012', 18:00:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:00:29 INFO - 'use_talos_json': True, 18:00:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:00:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:00:29 INFO - 'work_dir': 'build'} 18:00:29 INFO - ##### 18:00:29 INFO - ##### Running clobber step. 18:00:29 INFO - ##### 18:00:29 INFO - Running pre-action listener: _resource_record_pre_action 18:00:29 INFO - Running main action method: clobber 18:00:29 INFO - rmtree: /builds/slave/test/build 18:00:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:00:30 INFO - Running post-action listener: _resource_record_post_action 18:00:30 INFO - ##### 18:00:30 INFO - ##### Finished clobber step (success) 18:00:30 INFO - ##### 18:00:30 INFO - ##### 18:00:30 INFO - ##### Running read-buildbot-config step. 18:00:30 INFO - ##### 18:00:30 INFO - Running pre-action listener: _resource_record_pre_action 18:00:30 INFO - Running main action method: read_buildbot_config 18:00:30 INFO - Using buildbot properties: 18:00:30 INFO - { 18:00:30 INFO - "project": "", 18:00:30 INFO - "product": "firefox", 18:00:30 INFO - "script_repo_revision": "production", 18:00:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:00:30 INFO - "repository": "", 18:00:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:00:30 INFO - "buildid": "20160616163123", 18:00:30 INFO - "pgo_build": "False", 18:00:30 INFO - "basedir": "/builds/slave/test", 18:00:30 INFO - "buildnumber": 376, 18:00:30 INFO - "slavename": "talos-linux64-ix-012", 18:00:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:00:30 INFO - "platform": "ubuntu64_hw", 18:00:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:00:30 INFO - "branch": "mozilla-central", 18:00:30 INFO - "repo_path": "mozilla-central", 18:00:30 INFO - "revision": "05873df0c0c268e419a714b8a6204cb852049098", 18:00:30 INFO - "stage_platform": "linux64", 18:00:30 INFO - "builduid": "4da5b2e960374af499b5667814982984", 18:00:30 INFO - "slavebuilddir": "test" 18:00:30 INFO - } 18:00:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:00:30 INFO - Running post-action listener: _resource_record_post_action 18:00:30 INFO - ##### 18:00:30 INFO - ##### Finished read-buildbot-config step (success) 18:00:30 INFO - ##### 18:00:30 INFO - ##### 18:00:30 INFO - ##### Running download-and-extract step. 18:00:30 INFO - ##### 18:00:30 INFO - Running pre-action listener: _resource_record_pre_action 18:00:30 INFO - Running main action method: download_and_extract 18:00:30 INFO - mkdir: /builds/slave/test/build/tests 18:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:30 INFO - https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:00:36 INFO - Downloaded 1361 bytes. 18:00:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:00:36 INFO - Using the following test package requirements: 18:00:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:00:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:00:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:00:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'jsshell-linux-x86_64.zip'], 18:00:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:00:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:00:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:00:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:00:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:00:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:00:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:00:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:36 INFO - https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:39 INFO - Downloaded 22654279 bytes. 18:00:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:40 INFO - Return code: 0 18:00:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:40 INFO - https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:43 INFO - Downloaded 22654279 bytes. 18:00:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:44 INFO - Return code: 0 18:00: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:44 INFO - https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:00:45 INFO - Downloaded 14405384 bytes. 18:00:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:00:45 INFO - Return code: 0 18:00:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:45 INFO - https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:00:47 INFO - Downloaded 55446540 bytes. 18:00:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:00:47 INFO - mkdir: /builds/slave/test/properties 18:00:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:47 INFO - Contents: 18:00:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:00:47 INFO - Running post-action listener: _resource_record_post_action 18:00:47 INFO - Running post-action listener: set_extra_try_arguments 18:00:47 INFO - ##### 18:00:47 INFO - ##### Finished download-and-extract step (success) 18:00:47 INFO - ##### 18:00:47 INFO - ##### 18:00:47 INFO - ##### Running populate-webroot step. 18:00:47 INFO - ##### 18:00:47 INFO - Running pre-action listener: _resource_record_pre_action 18:00:47 INFO - Running main action method: populate_webroot 18:00:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:47 INFO - '--tppagecycles', 18:00:47 INFO - '7'], 18:00:47 INFO - 'tests': ['tsvgm']}}, 18:00:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:00:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['damp', 'tps']}, 18:00:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'tests': ['damp', 'tps']}, 18:00:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['dromaeo_dom']}, 18:00:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['basic_compositor_video']}, 18:00:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:00:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['a11yr', 18:00:47 INFO - 'ts_paint', 18:00:47 INFO - 'tpaint', 18:00:47 INFO - 'sessionrestore', 18:00:47 INFO - 'sessionrestore_no_auto_restore', 18:00:47 INFO - 'tabpaint']}, 18:00:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['tsvgx', 18:00:47 INFO - 'tsvgr_opacity', 18:00:47 INFO - 'tart', 18:00:47 INFO - 'tscrollx', 18:00:47 INFO - 'cart']}, 18:00:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:47 INFO - 'tsvgr_opacity', 18:00:47 INFO - 'tart', 18:00:47 INFO - 'tscrollx', 18:00:47 INFO - 'cart']}, 18:00:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'talos_options': ['--disable-e10s'], 18:00:47 INFO - 'tests': ['tp5o']}, 18:00:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'tests': ['tp5o']}, 18:00:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'talos_options': ['--disable-e10s', 18:00:47 INFO - '--xperf_path', 18:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:47 INFO - 'tests': ['tp5n']}, 18:00:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:47 INFO - 'talos_options': ['--xperf_path', 18:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:47 INFO - 'tests': ['tp5n']}}, 18:00:47 INFO - 'talos.zip': {'path': '', 18:00:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:47 INFO - Running post-action listener: _resource_record_post_action 18:00:47 INFO - ##### 18:00:47 INFO - ##### Finished populate-webroot step (success) 18:00:47 INFO - ##### 18:00:47 INFO - ##### 18:00:47 INFO - ##### Running create-virtualenv step. 18:00:47 INFO - ##### 18:00:47 INFO - Running pre-action listener: _resource_record_pre_action 18:00:47 INFO - Running main action method: create_virtualenv 18:00:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:47 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 18:00:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:48 INFO - Using real prefix '/usr' 18:00:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:50 INFO - Installing pip.................done. 18:00:50 INFO - Return code: 0 18:00:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:00:50 INFO - Using env: {'DISPLAY': ':0', 18:00:50 INFO - 'HOME': '/home/cltbld', 18:00:50 INFO - 'LANG': 'en_US.UTF-8', 18:00:50 INFO - 'LANGUAGE': 'en_US:en', 18:00:50 INFO - 'LOGNAME': 'cltbld', 18:00:50 INFO - 'MAIL': '/var/mail/cltbld', 18:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:50 INFO - 'MOZ_NO_REMOTE': '1', 18:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:50 INFO - 'NO_EM_RESTART': '1', 18:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:50 INFO - 'PWD': '/builds/slave/test', 18:00:50 INFO - 'SHELL': '/bin/bash', 18:00:50 INFO - 'SHLVL': '1', 18:00:50 INFO - 'TERM': 'linux', 18:00:50 INFO - 'TMOUT': '86400', 18:00:50 INFO - 'USER': 'cltbld', 18:00:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:50 INFO - '_': '/tools/buildbot/bin/python'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 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 18:00:50 INFO - Cleaning up... 18:00:50 INFO - Return code: 0 18:00:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:00:50 INFO - Using env: {'DISPLAY': ':0', 18:00:50 INFO - 'HOME': '/home/cltbld', 18:00:50 INFO - 'LANG': 'en_US.UTF-8', 18:00:50 INFO - 'LANGUAGE': 'en_US:en', 18:00:50 INFO - 'LOGNAME': 'cltbld', 18:00:50 INFO - 'MAIL': '/var/mail/cltbld', 18:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:50 INFO - 'MOZ_NO_REMOTE': '1', 18:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:50 INFO - 'NO_EM_RESTART': '1', 18:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:50 INFO - 'PWD': '/builds/slave/test', 18:00:50 INFO - 'SHELL': '/bin/bash', 18:00:50 INFO - 'SHLVL': '1', 18:00:50 INFO - 'TERM': 'linux', 18:00:50 INFO - 'TMOUT': '86400', 18:00:50 INFO - 'USER': 'cltbld', 18:00:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:50 INFO - '_': '/tools/buildbot/bin/python'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 INFO - Downloading/unpacking psutil>=3.1.1 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:53 INFO - Installing collected packages: psutil 18:00:53 INFO - Running setup.py install for psutil 18:00:53 INFO - building 'psutil._psutil_linux' extension 18:00:53 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 18:00:53 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 18:00:53 INFO - building 'psutil._psutil_posix' extension 18:00:53 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 18:00:53 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 18:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:53 INFO - Successfully installed psutil 18:00:53 INFO - Cleaning up... 18:00:53 INFO - Return code: 0 18:00:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:53 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:00:53 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 18:00:53 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 18:00:53 INFO - Using env: {'DISPLAY': ':0', 18:00:53 INFO - 'HOME': '/home/cltbld', 18:00:53 INFO - 'LANG': 'en_US.UTF-8', 18:00:53 INFO - 'LANGUAGE': 'en_US:en', 18:00:53 INFO - 'LOGNAME': 'cltbld', 18:00:53 INFO - 'MAIL': '/var/mail/cltbld', 18:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:53 INFO - 'MOZ_NO_REMOTE': '1', 18:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:53 INFO - 'NO_EM_RESTART': '1', 18:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:53 INFO - 'PWD': '/builds/slave/test', 18:00:53 INFO - 'SHELL': '/bin/bash', 18:00:53 INFO - 'SHLVL': '1', 18:00:53 INFO - 'TERM': 'linux', 18:00:53 INFO - 'TMOUT': '86400', 18:00:53 INFO - 'USER': 'cltbld', 18:00:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:53 INFO - '_': '/tools/buildbot/bin/python'} 18:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:53 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 18:00:53 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 18:00:53 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 18:00:53 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 18:00:53 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 18:00:53 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 18:00:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:56 INFO - Installing collected packages: mozsystemmonitor 18:00:56 INFO - Running setup.py install for mozsystemmonitor 18:00:56 INFO - Successfully installed mozsystemmonitor 18:00:56 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:00:56 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 18:00:56 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 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:58 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 18:00:58 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 18:00:58 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 18:00:58 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 18:00:58 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 18:00:58 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 18:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:58 INFO - warning: no files found matching '*.txt' 18:00:58 INFO - no previously-included directories found matching 'build' 18:00:58 INFO - no previously-included directories found matching 'dist' 18:00:58 INFO - no previously-included directories found matching '.git*' 18:00:58 INFO - Installing collected packages: jsonschema, functools32 18:00:58 INFO - Running setup.py install for functools32 18:00:58 INFO - warning: no files found matching '*.txt' 18:00:58 INFO - no previously-included directories found matching 'build' 18:00:58 INFO - no previously-included directories found matching 'dist' 18:00:58 INFO - no previously-included directories found matching '.git*' 18:00:58 INFO - Successfully installed jsonschema functools32 18:00:58 INFO - Cleaning up... 18:00:58 INFO - Return code: 0 18:00:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:58 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:00:58 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 18:00:58 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 18:00:58 INFO - Using env: {'DISPLAY': ':0', 18:00:58 INFO - 'HOME': '/home/cltbld', 18:00:58 INFO - 'LANG': 'en_US.UTF-8', 18:00:58 INFO - 'LANGUAGE': 'en_US:en', 18:00:58 INFO - 'LOGNAME': 'cltbld', 18:00:58 INFO - 'MAIL': '/var/mail/cltbld', 18:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:58 INFO - 'MOZ_NO_REMOTE': '1', 18:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:58 INFO - 'NO_EM_RESTART': '1', 18:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:58 INFO - 'PWD': '/builds/slave/test', 18:00:58 INFO - 'SHELL': '/bin/bash', 18:00:58 INFO - 'SHLVL': '1', 18:00:58 INFO - 'TERM': 'linux', 18:00:58 INFO - 'TMOUT': '86400', 18:00:58 INFO - 'USER': 'cltbld', 18:00:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:58 INFO - '_': '/tools/buildbot/bin/python'} 18:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:01 INFO - Downloading docopt-0.6.1.tar.gz 18:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:01:01 INFO - Running setup.py install for blobuploader 18:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:01:01 INFO - Running setup.py install for requests 18:01:02 INFO - Running setup.py install for docopt 18:01:02 INFO - Successfully installed blobuploader requests docopt 18:01:02 INFO - Cleaning up... 18:01:02 INFO - Return code: 0 18:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:02 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:01:02 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 18:01:02 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 18:01:02 INFO - Using env: {'DISPLAY': ':0', 18:01:02 INFO - 'HOME': '/home/cltbld', 18:01:02 INFO - 'LANG': 'en_US.UTF-8', 18:01:02 INFO - 'LANGUAGE': 'en_US:en', 18:01:02 INFO - 'LOGNAME': 'cltbld', 18:01:02 INFO - 'MAIL': '/var/mail/cltbld', 18:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:02 INFO - 'MOZ_NO_REMOTE': '1', 18:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:02 INFO - 'NO_EM_RESTART': '1', 18:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:02 INFO - 'PWD': '/builds/slave/test', 18:01:02 INFO - 'SHELL': '/bin/bash', 18:01:02 INFO - 'SHLVL': '1', 18:01:02 INFO - 'TERM': 'linux', 18:01:02 INFO - 'TMOUT': '86400', 18:01:02 INFO - 'USER': 'cltbld', 18:01:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:02 INFO - '_': '/tools/buildbot/bin/python'} 18:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:02 INFO - Running setup.py (path:/tmp/pip-vlDCOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:02 INFO - Running setup.py (path:/tmp/pip-FmA3fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:02 INFO - Running setup.py (path:/tmp/pip-_L6dFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:02 INFO - Running setup.py (path:/tmp/pip-ZbW2Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:02 INFO - Running setup.py (path:/tmp/pip-6tgmEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:02 INFO - Running setup.py (path:/tmp/pip-9Reg_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:02 INFO - Running setup.py (path:/tmp/pip-WTqz7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:03 INFO - Running setup.py (path:/tmp/pip-aksozR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:03 INFO - Running setup.py (path:/tmp/pip-8Tc4Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:03 INFO - Running setup.py (path:/tmp/pip-eoFPwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:03 INFO - Running setup.py (path:/tmp/pip-oT91WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:03 INFO - Running setup.py (path:/tmp/pip-J0UuKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:03 INFO - Running setup.py (path:/tmp/pip-rrjwny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:03 INFO - Running setup.py (path:/tmp/pip-g4K3zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:03 INFO - Running setup.py (path:/tmp/pip-74Atem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:03 INFO - Running setup.py (path:/tmp/pip-i2yk2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:03 INFO - Running setup.py (path:/tmp/pip-rOwCQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:01:03 INFO - Running setup.py install for manifestparser 18:01:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:01:03 INFO - Running setup.py install for mozcrash 18:01:03 INFO - Running setup.py install for mozdebug 18:01:04 INFO - Running setup.py install for mozdevice 18:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for mozfile 18:01:04 INFO - Running setup.py install for mozhttpd 18:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for mozinfo 18:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for mozInstall 18:01:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for mozleak 18:01:04 INFO - Running setup.py install for mozlog 18:01:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for moznetwork 18:01:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:01:04 INFO - Running setup.py install for mozprocess 18:01:05 INFO - Running setup.py install for mozprofile 18:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:01:05 INFO - Running setup.py install for mozrunner 18:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:01:05 INFO - Running setup.py install for mozscreenshot 18:01:05 INFO - Running setup.py install for moztest 18:01:05 INFO - Running setup.py install for mozversion 18:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:01:05 INFO - Cleaning up... 18:01:05 INFO - Return code: 0 18:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:05 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:01:05 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 18:01:05 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 18:01:05 INFO - Using env: {'DISPLAY': ':0', 18:01:05 INFO - 'HOME': '/home/cltbld', 18:01:05 INFO - 'LANG': 'en_US.UTF-8', 18:01:05 INFO - 'LANGUAGE': 'en_US:en', 18:01:05 INFO - 'LOGNAME': 'cltbld', 18:01:05 INFO - 'MAIL': '/var/mail/cltbld', 18:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:05 INFO - 'MOZ_NO_REMOTE': '1', 18:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:05 INFO - 'NO_EM_RESTART': '1', 18:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:05 INFO - 'PWD': '/builds/slave/test', 18:01:05 INFO - 'SHELL': '/bin/bash', 18:01:05 INFO - 'SHLVL': '1', 18:01:05 INFO - 'TERM': 'linux', 18:01:05 INFO - 'TMOUT': '86400', 18:01:05 INFO - 'USER': 'cltbld', 18:01:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:05 INFO - '_': '/tools/buildbot/bin/python'} 18:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:05 INFO - Running setup.py (path:/tmp/pip-zUfyra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:05 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)) 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:05 INFO - Running setup.py (path:/tmp/pip-2Jh7YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:05 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)) 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:05 INFO - Running setup.py (path:/tmp/pip-k4L1Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:06 INFO - Running setup.py (path:/tmp/pip-kmf27M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:06 INFO - Running setup.py (path:/tmp/pip-hu72gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:06 INFO - Running setup.py (path:/tmp/pip-q9Uwdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:06 INFO - Running setup.py (path:/tmp/pip-zTpQ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:06 INFO - Running setup.py (path:/tmp/pip-4W85fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:06 INFO - Running setup.py (path:/tmp/pip-Vy8j9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:06 INFO - Running setup.py (path:/tmp/pip-BtzNjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:06 INFO - Running setup.py (path:/tmp/pip-n2vdU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:06 INFO - Running setup.py (path:/tmp/pip-uNLU2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:06 INFO - Running setup.py (path:/tmp/pip-3Ov_oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:06 INFO - Running setup.py (path:/tmp/pip-FhS74K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:06 INFO - Running setup.py (path:/tmp/pip-xlYfGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:06 INFO - Running setup.py (path:/tmp/pip-wKVqwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:06 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)) 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:06 INFO - Running setup.py (path:/tmp/pip-JcnbdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:07 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)) 18:01:07 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)) 18:01:07 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)) 18:01:07 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)) 18:01:07 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)) 18:01:07 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)) 18:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:07 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 18:01:07 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 18:01:07 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 18:01:07 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 18:01:07 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 18:01:07 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 18:01:08 INFO - Downloading blessings-1.6.tar.gz 18:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:01:09 INFO - Installing collected packages: blessings 18:01:09 INFO - Running setup.py install for blessings 18:01:09 INFO - Successfully installed blessings 18:01:09 INFO - Cleaning up... 18:01:09 INFO - Return code: 0 18:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:09 INFO - Reading from file tmpfile_stdout 18:01:09 INFO - Current package versions: 18:01:09 INFO - argparse == 1.2.1 18:01:09 INFO - blessings == 1.6 18:01:09 INFO - blobuploader == 1.2.4 18:01:09 INFO - docopt == 0.6.1 18:01:09 INFO - functools32 == 3.2.3-2 18:01:09 INFO - jsonschema == 2.5.1 18:01:09 INFO - manifestparser == 1.1 18:01:09 INFO - mozInstall == 1.12 18:01:09 INFO - mozcrash == 0.17 18:01:09 INFO - mozdebug == 0.1 18:01:09 INFO - mozdevice == 0.48 18:01:09 INFO - mozfile == 1.2 18:01:09 INFO - mozhttpd == 0.7 18:01:09 INFO - mozinfo == 0.9 18:01:09 INFO - mozleak == 0.1 18:01:09 INFO - mozlog == 3.2 18:01:09 INFO - moznetwork == 0.27 18:01:09 INFO - mozprocess == 0.22 18:01:09 INFO - mozprofile == 0.28 18:01:09 INFO - mozrunner == 6.11 18:01:09 INFO - mozscreenshot == 0.1 18:01:09 INFO - mozsystemmonitor == 0.3 18:01:09 INFO - moztest == 0.7 18:01:09 INFO - mozversion == 1.4 18:01:09 INFO - psutil == 3.1.1 18:01:09 INFO - requests == 1.2.3 18:01:09 INFO - wsgiref == 0.1.2 18:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:09 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 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:01:09 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 18:01:09 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 18:01:09 INFO - Using env: {'DISPLAY': ':0', 18:01:09 INFO - 'HOME': '/home/cltbld', 18:01:09 INFO - 'LANG': 'en_US.UTF-8', 18:01:09 INFO - 'LANGUAGE': 'en_US:en', 18:01:09 INFO - 'LOGNAME': 'cltbld', 18:01:09 INFO - 'MAIL': '/var/mail/cltbld', 18:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:09 INFO - 'MOZ_NO_REMOTE': '1', 18:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:09 INFO - 'NO_EM_RESTART': '1', 18:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:09 INFO - 'PWD': '/builds/slave/test', 18:01:09 INFO - 'SHELL': '/bin/bash', 18:01:09 INFO - 'SHLVL': '1', 18:01:09 INFO - 'TERM': 'linux', 18:01:09 INFO - 'TMOUT': '86400', 18:01:09 INFO - 'USER': 'cltbld', 18:01:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:09 INFO - '_': '/tools/buildbot/bin/python'} 18:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 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)) 18:01:09 INFO - Cleaning up... 18:01:09 INFO - Return code: 0 18:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:01: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', 'jsonschema'] in /builds/slave/test/build 18:01: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 jsonschema 18:01:09 INFO - Using env: {'DISPLAY': ':0', 18:01:09 INFO - 'HOME': '/home/cltbld', 18:01:09 INFO - 'LANG': 'en_US.UTF-8', 18:01:09 INFO - 'LANGUAGE': 'en_US:en', 18:01:09 INFO - 'LOGNAME': 'cltbld', 18:01:09 INFO - 'MAIL': '/var/mail/cltbld', 18:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:09 INFO - 'MOZ_NO_REMOTE': '1', 18:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:09 INFO - 'NO_EM_RESTART': '1', 18:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:09 INFO - 'PWD': '/builds/slave/test', 18:01:09 INFO - 'SHELL': '/bin/bash', 18:01:09 INFO - 'SHLVL': '1', 18:01:09 INFO - 'TERM': 'linux', 18:01:09 INFO - 'TMOUT': '86400', 18:01:09 INFO - 'USER': 'cltbld', 18:01:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:09 INFO - '_': '/tools/buildbot/bin/python'} 18:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:01:09 INFO - Cleaning up... 18:01:09 INFO - Return code: 0 18:01:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2d8ff3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', '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 18:01: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', 'flake8'] in /builds/slave/test/build 18:01: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 flake8 18:01:09 INFO - Using env: {'DISPLAY': ':0', 18:01:09 INFO - 'HOME': '/home/cltbld', 18:01:09 INFO - 'LANG': 'en_US.UTF-8', 18:01:09 INFO - 'LANGUAGE': 'en_US:en', 18:01:09 INFO - 'LOGNAME': 'cltbld', 18:01:09 INFO - 'MAIL': '/var/mail/cltbld', 18:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:09 INFO - 'MOZ_NO_REMOTE': '1', 18:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:09 INFO - 'NO_EM_RESTART': '1', 18:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:09 INFO - 'PWD': '/builds/slave/test', 18:01:09 INFO - 'SHELL': '/bin/bash', 18:01:09 INFO - 'SHLVL': '1', 18:01:09 INFO - 'TERM': 'linux', 18:01:09 INFO - 'TMOUT': '86400', 18:01:09 INFO - 'USER': 'cltbld', 18:01:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:09 INFO - '_': '/tools/buildbot/bin/python'} 18:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:10 INFO - Downloading/unpacking flake8 18:01:10 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 18:01:10 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 18:01:10 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 18:01:10 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 18:01:10 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 18:01:10 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 18:01:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:01:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:01:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01: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 18:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:01:12 INFO - no previously-included directories found matching 'docs/_build' 18:01:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:01:12 INFO - Running setup.py install for pep8 18:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:01:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:01:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:01:12 INFO - no previously-included directories found matching 'docs/_build' 18:01:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:01:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:01:12 INFO - Cleaning up... 18:01:12 INFO - Return code: 0 18:01:12 INFO - Running post-action listener: _resource_record_post_action 18:01:12 INFO - Running post-action listener: _start_resource_monitoring 18:01:12 INFO - Starting resource monitoring. 18:01:12 INFO - ##### 18:01:12 INFO - ##### Finished create-virtualenv step (success) 18:01:12 INFO - ##### 18:01:12 INFO - ##### 18:01:12 INFO - ##### Running install step. 18:01:12 INFO - ##### 18:01:12 INFO - Running pre-action listener: _resource_record_pre_action 18:01:12 INFO - Running main action method: install 18:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:13 INFO - Reading from file tmpfile_stdout 18:01:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:01:13 INFO - Reading from file tmpfile_stdout 18:01:13 INFO - Output received: 18:01:13 INFO - Usage: mozinstall [options] installer 18:01:13 INFO - Options: 18:01:13 INFO - -h, --help show this help message and exit 18:01:13 INFO - -d DEST, --destination=DEST 18:01:13 INFO - Directory to install application into. [default: 18:01:13 INFO - "/builds/slave/test"] 18:01:13 INFO - --app=APP Application being installed. [default: firefox] 18:01:13 INFO - mkdir: /builds/slave/test/build/application 18:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:01:29 INFO - Reading from file tmpfile_stdout 18:01:29 INFO - Output received: 18:01:29 INFO - /builds/slave/test/build/application/firefox/firefox 18:01:29 INFO - Running post-action listener: _resource_record_post_action 18:01:29 INFO - ##### 18:01:29 INFO - ##### Finished install step (success) 18:01:29 INFO - ##### 18:01:29 INFO - ##### 18:01:29 INFO - ##### Running run-tests step. 18:01:29 INFO - ##### 18:01:29 INFO - Running pre-action listener: _resource_record_pre_action 18:01:29 INFO - Running main action method: run_tests 18:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:29 INFO - Python 2.7.3 18:01:29 INFO - Return code: 0 18:01:29 INFO - grabbing minidump binary from tooltool 18:01:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:29 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 0x15201c0>, '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 0x15210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:29 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 18:01:29 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 18:01:29 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 18:01:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:29 INFO - Return code: 0 18:01:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:01:30 INFO - Return code: 0 18:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 18:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 18:01:30 INFO - Using env: {'DISPLAY': ':0', 18:01:30 INFO - 'HOME': '/home/cltbld', 18:01:30 INFO - 'LANG': 'en_US.UTF-8', 18:01:30 INFO - 'LANGUAGE': 'en_US:en', 18:01:30 INFO - 'LOGNAME': 'cltbld', 18:01:30 INFO - 'MAIL': '/var/mail/cltbld', 18:01:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:30 INFO - 'MOZ_NO_REMOTE': '1', 18:01:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:30 INFO - 'NO_EM_RESTART': '1', 18:01:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:30 INFO - 'PWD': '/builds/slave/test', 18:01:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:30 INFO - 'SHELL': '/bin/bash', 18:01:30 INFO - 'SHLVL': '1', 18:01:30 INFO - 'TERM': 'linux', 18:01:30 INFO - 'TMOUT': '86400', 18:01:30 INFO - 'USER': 'cltbld', 18:01:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726', 18:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:30 INFO - '_': '/tools/buildbot/bin/python'} 18:01:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 18:01:30 INFO - mozversion application_buildid: 20160616163123 18:01:30 INFO - mozversion application_changeset: 05873df0c0c268e419a714b8a6204cb852049098 18:01:30 INFO - mozversion application_display_name: Nightly 18:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:30 INFO - mozversion application_name: Firefox 18:01:30 INFO - mozversion application_remotingname: firefox 18:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:01:30 INFO - mozversion application_vendor: Mozilla 18:01:30 INFO - mozversion application_version: 50.0a1 18:01:30 INFO - mozversion platform_buildid: 20160616163123 18:01:30 INFO - mozversion platform_changeset: 05873df0c0c268e419a714b8a6204cb852049098 18:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:01:30 INFO - mozversion platform_version: 50.0a1 18:01:30 INFO - using testdate: 1466125290 18:01:30 INFO - actual date: 1466125290 18:01:30 INFO - starting webserver on 'localhost:33502' 18:01:30 INFO - SUITE-START | Running 2 tests 18:01:30 INFO - TEST-START | dromaeo_css 18:01:30 INFO - operating with platform_type : linux_ 18:01:30 INFO - Initialising browser for dromaeo_css test... 18:01:30 INFO - TEST-INFO | started process 20204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0BhJF/profile http://localhost:33502/getInfo.html) 18:01:34 INFO - PROCESS | 20204 | __metrics Screen width/height:1600/1200 18:01:34 INFO - PROCESS | 20204 | colorDepth:24 18:01:34 INFO - PROCESS | 20204 | Browser inner width/height: 1024/697 18:01:34 INFO - PROCESS | 20204 | __metrics 18:01:35 ERROR - PROCESS | 20204 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:01:36 INFO - TEST-INFO | 20204: exit 0 18:01:36 INFO - Browser initialized. 18:01:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:36 INFO - TEST-INFO | started process 20322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0BhJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:48 INFO - PROCESS | 20322 | RSS: Main: 186765312 18:01:48 INFO - PROCESS | 20322 | 18:02:38 INFO - PROCESS | 20322 | 1466125358014 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] 18:04:51 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33502/tests/dromaeo/cssquery-ext.html) 18:04:52 INFO - PROCESS | 20322 | RSS: Main: 187613184 18:04:52 INFO - PROCESS | 20322 | 18:07:54 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-ext.html (next: http://localhost:33502/tests/dromaeo/cssquery-jquery.html) 18:07:55 INFO - PROCESS | 20322 | RSS: Main: 188207104 18:07:55 INFO - PROCESS | 20322 | 18:10:57 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33502/tests/dromaeo/cssquery-mootools.html) 18:10:57 INFO - PROCESS | 20322 | RSS: Main: 189321216 18:10:57 INFO - PROCESS | 20322 | 18:13:59 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33502/tests/dromaeo/cssquery-prototype.html) 18:14:00 INFO - PROCESS | 20322 | RSS: Main: 187400192 18:14:00 INFO - PROCESS | 20322 | 18:17:02 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33502/tests/dromaeo/cssquery-yui.html) 18:17:03 INFO - PROCESS | 20322 | RSS: Main: 189800448 18:17:03 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | Cycle 1(1): loaded http://localhost:33502/tests/dromaeo/cssquery-yui.html (next: http://localhost:33502/tests/dromaeo/cssquery-dojo.html) 18:20:06 INFO - PROCESS | 20322 | RSS: Main: 190259200 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | __start_tp_report 18:20:06 INFO - PROCESS | 20322 | _x_x_mozilla_page_load 18:20:06 INFO - PROCESS | 20322 | _x_x_mozilla_page_load_details 18:20:06 INFO - PROCESS | 20322 | |i|pagename|runs| 18:20:06 INFO - PROCESS | 20322 | |0;dojo.html;2690.2736261209475;2717.782577393809;2734.2617493276803;2738.055370897041;2750.766184874284;4831.227003679408;4841.4190297164305;4881.585065269452;4897.975510122454;4934.654574179809;4844.297576851354;4898.8775280618;4922.876928076791;4951;4958.15711329074;4474.395956545874;4530.275155975045;4600.700954437968;4648.418947631546;4649.209634362167;541.3383757325661;4429.13631841791;4462.73223606583;4498.797554110057;4557.794899229526;4534.6145577625775;4542.523035081302;4543.159515489612;4547.8635640930825;4606.26299792035;4509.7970591323465;4537.137943790703;4544.02303504748;4561.064981678748;4571.565701258375;4416.050549131952;4427.247367947424;4438.955610443886;4439.489458712224;4441.089576636782;4840.564349208588;4861.124997500448;4872.854879103408;4899.436564795059;4957;5256.553192978601;5257.921131183035;5258.789648414059;5285.339332583427;5316.415194328621;5282.867928301785;5344.599155063347;5354.464553544653;5373.140297552372;5426;4959.801607935714;4971.353724015855;4980.551750342486;4983.700977941335;4989.675671081368;5370.704611246419;5372.811951581676;5387.676739395649;5493.615446918758;5501;5191.402988656353;5203.063448579292;5204.323437953042;5210.296609957607;5227.503387178212;5254;5254.185601231815;5259.815906443256;5305.814296499604;5356.330458692663;5151.124308867426;5185.403678576937;5186.247994040843;5208.869778255574;5247.842564723064;5221.086309895753;5230.7384630769075;5254.947450525522;5256.290400795843;5261.026710058652;4514.164879497238;4541.954580454153;4543.931841022388;4551.977240113844;4590.885227869263;3847.8653247136776;3894.2211557688574;3894.824732887027;3903.2583809076186;3936.0159960009996;4425.225585522585;4480.126375356775;4493.393391892118;4494.370793086081;4593.563611456906;5286.497782710637;5291.206319052173;5307.52232299095;5309.761060752276;5313.760880760375;4488.887777805516;4536.705114167568;4562.1788078146255;4599.149157405891;4610.10103029906;4780.067886762117;4796.616270698336;4820.276958456189;4820.855374338776;4862.902741945212;4845.41854977405;5001.24981252815;5012.624053195952;5025.195968644999;5059.569936555286;5292.894142117059;5302.496262855023;5325.467453254643;5352.678839269656;5362.356517217802;4957.132501812241;4961.08219979305;4961.950380496149;4996.975015125046;5039.521245481674;5107.846764597068;5128.076946149728;5171.276021356938;5174.922376164285;5180.559652429586;5216.191490319006;5253.842384728464;5274.7098909560345;5275.314209152785;5331.626786125089;5115.2582875483595;5151.433342332265;5159.174532075001;5162.251473536241;5198.324217851655;5033.773480193327;5110.259012443249;5129.666571672829;5147.150720131136;5148.073346797612;4971.751412429437;5016.523430274118;5028;5065.670731402447;5115.9232611510115;5199.29809475716;5213.739313034257;5216.087184742731;5216.321878155815;5252.395974462986;4988.176950803077;4995.375578052744;5027.421846487555;5077.77150028257;5096.337476128079 18:20:06 INFO - PROCESS | 20322 | |1;ext.html;533.7309407245255;582.423400833175;589.2516504039867;600.9879802403952;615.5014438304976;36319;37385.626143738555;40076.59923400765;40358;40454.79772601136;40458.39312410316;41378.17243655125;41412.58587414125;41513.37729934046;41551;7844.2155784421675;7960.203979602052;7968.12350641429;7969.920300796975;8000.519968801861;7819.491733037335;7934.642941067666;7948.046234451845;7968.322692571139;7977.680892764282;7883.093444253898;7894.3289820365335;7984.041914970212;7995.040595128593;8007.31937785286;7953.323967462744;7970.521768693897;8002.079760827522;8019.518828870287;8020.959895200486;7963.681452741884;7971.402144839102;8018.879716804253;8040.638171282307;8055.798605034863;30143.246418839484;39247.21505569901;39638.60361396407;39653.20693586141;39674.40488392676;2927.5608658701367;2955.5418910068975;3030.1818509002665;3101.565780790691;3139.5290706393994;27819.721802781914;28281.57577636337;28542.571861422097;28903;29268;3374.865005399806;3380.8309584520675;3443.8200856499147;3448;3512.947305790415;249456;249796;251314;251405.99999999817;254725;28037.299067523476;28591.285217869303;54575;55399.723001385544;55422;34084.44366672509;34183;34191.31617367688;34209.31581368409;34265;11394.202405831678;11499.137564682682;11625.59310424131;11650;11655.125865560118;9248.768780780534;9295.767605809773;9384.108509691569;9410.294227932933;9422.623095076257;7813.648385822652;7867.606619669108;7916.841663166704;7938.04743430792;7946.443748937519;3089.6292444906753;3104.6740092289983;3116.548100525411;3129.530570414456;3160.1309639849223;855.8758979947872;888.813349196676;903.9412438191628;952.1002652493465;957.8323793336139;27768.58347124795;28483.430331393258;28483.857580711963;28658.426831463672;28807.135785926457;915.5788337364887;927.9628814847465;986.7927735175693;1011.2011510906449;1035.7669524356959;14518.782218266735;15030.849691502945;15170;15298;15448.304826282843;416262;418671;420624;425073;428322;49519;49588.50411495839;49888.251676224885;49917;50088;1104.364990130662;1148.982765258505;1191.3090407563593;1193.0455635491571;1193.3675152169365;26802;28185.577216342183;28282.71717282801;28571.42857142887;28652.42695146044;41954.790226049896;42273.365899512144;42516.787416062725;42583.787081064394;42609.573904260564;265888;266379;267743;268437;330765;25574.488510230065;25612.743872561037;26072.739272607032;26089.869550652125;26162.73837261603;42289.365659514515;42575.787121065434;42620.78689606532;42901.14197716091;43770;36557.90326290215;36764.44853327149;37338.8133059333;37425.81287093547;37486.6251337494;36617.45073823948;36655.434119611375;36978;37093.43458282024;37326.25347493089;36091.458628120075;36483.635163648025;36582.26835463329;37058.6294137066;37080.25839483249;31445.685543144275;32582.511262331558;32956.50565241571;33297.167570810925;33325.16687082745;25260.494790103727;25430.364240894127;25804.483910321313;25918.35204119912;26098.86950565235 18:20:06 INFO - PROCESS | 20322 | |2;jquery.html;366.85509223856576;367.75360508459323;376.13113707336055;385.80324034742273;389.5578518381636;15810.288537015833;16873.49379518615;17695.29218831245;17731.379401720944;17742.46772596821;14981.92509037456;15257.694846103072;15873.04761714298;15876.603084922883;15939.203039847991;5138.871528211796;5314;5354.651947623412;5357.196420536931;5357.249985002103;3785.2807966486416;5240.973795131038;5920.407959204088;6259.749610015617;6263.31103578606;6205.5345849061505;6216.689165541728;6290.056491526262;6294.653794041325;6301.212348456443;6246.937530624681;6310.5267104967315;6320.715567799437;6326.240851097875;6328.620282783025;5279.894402111936;5428.077226871442;5437.401885792559;5498.917516237259;5543.695096769676;19951.80048199514;20270.69593956092;20781.68827467574;20797.06413211409;21089.367318980454;1885.53804317943;1939.4181745476442;2017.1326329678232;2018.760602734261;2080.001599232377;13094.47622095115;13157.407916643773;13312.134711243834;13331.533396331179;13357.198568085945;1702.5062731807761;1787.5263055290359;1806.656735220304;1846.095413247499;1847.8706490545667;67087.3291267086;69154;69358;69700.6514967432;69991.65004174998;9483.383580067273;9602.279829012712;9609;9986.300958932805;10014.24893133018;13497.865021349857;13574.25341606221;13608.93195534016;13621.523246686318;13635.659108522168;6800.489963252677;6806.149231346082;6861.4853885958755;6879.5184337096925;6939.722411103499;6322.209723784527;6323.241211054703;6389.552731308764;6530.967345163243;6544.265769570972;6187.5149964009215;6206.782762603287;6207.81376558704;6256.749730010749;6276.202897247191;1632.959176020609;1692.2300353339201;1831.1210618903;1854.4807453912927;1856.5637075287298;764.289211033744;851.8211175653058;870.6822009966317;910.1808372464702;940.6519587752575;16748.83251167497;16992.235349409308;17239.913800431168;17323.56691082733;17470.388536401166;864.9827003459895;878.8110556230441;953.3755390219279;968.5593055159885;969.5588507229194;9856.112949834549;10007.649732259482;10042.096211341015;10060.949695251624;10109.292349535463;361937;367334;368626;372525;373946;66919.66540167366;68480;70904.64547677332;71156;71470.64264678644;937.4000639590668;947.4741518457184;950.6150009246267;951.2390087929629;956.933014688965;15153.696926061197;15428.382864685287;15447.382104716135;15720.449784257497;15900.363985440916;28726;32164;34345.82827085849;35316.64683353133;35592.46611300884;47731.52268477271;50953.490465094874;51050.74474627603;51189.23216151686;51578.48421515737;7387.335139837441;7628.389728821792;7690.423218258541;7696.230376962483;7805.063392392949;8790.560471976247;11199.10407167441;11367.920047595466;11556.24884382546;11943.701407464536;5175.611829112907;7979.281864631978;10497.842532362174;10512.948705129731;10626.256162068581;10368.429736364573;10489.265751397328;10499.265051446326;10623.150147988297;10748.570057197625;10218.080372766486;10518.368897866152;10617;10739.463026848782;10946.45267736594;7414.406847452083;7477.738279160203;7527.473076884785;7546.434017448603;7868.134505204537;9840.261980351359;10213.131883789962;10299;10735.355878647306;10817.783644326912 18:20:06 INFO - PROCESS | 20322 | |3;mootools.html;1359.164114069847;1407.6281465730244;1465.8900582456317;1648.0606054548912;1665.3588368478147;6850.965745171279;7536.81157971051;7556.395488360931;8065.637046332914;8124.228198321158;7708.421868359867;7860.724874629374;7875.566843823587;7898.565578893159;7957.681692732298;2167.2306331252416;2202.031106313225;2202.130158587357;2207.4922767763424;2211.3918672365066;2191.0906973605934;2213.9335819925345;2239.395363251929;2244.9887750561224;2248.774417942225;2192.3861318830754;2194.4623567226054;2201.218567408563;2204.911803527865;2228.064213030531;2124.808767210943;2126.25581046634;2133.9466513337134;2144.6782982552663;2154.859934104286;2118.480972161815;2175.3582693105573;2176.1077958037285;2177.7822217778253;2184.3774524260666;7876.527408355517;7931.563763992978;7932.325752311061;7936.6825326986855;7939.364850811921;4193.056562273464;4332.9566704332865;4353.586409291112;4398.956010439887;4416.624586910117;2746.5056289867816;2867.899623513167;2980.910572682823;3000.774941879368;3003.23417528531;879.0637970561331;894.5035505294559;918.3433844801;919.3564504846634;920.5075284722708;10407.895921040768;10437.478126093665;10441.947790261;10466.162706983423;10509.369437833679;4103.138340948374;4191.895202619959;4276.957230427718;4294.6993710439965;4305.956940430556;9081.409708369067;9093.81812363749;9109.544522773967;9109.90890091104;9127.22418594427;4317.546657600969;4318.071614602813;4355.324924636687;4361.17137743834;4364.454443194601;3434.5019972103905;3828.559715632682;3878.5345758508597;3955.7626542407547;3958.4062390641634;3583.1937813992163;3594.98202508991;3689.557253129588;3713.1459764254373;3716.851325946932;1134.0813940708053;1144.513581727779;1147.0880649883195;1151.7063148897146;1165.4172913543227;786.7561056072636;793.1037927142293;794.9920500794918;814.9837003259902;823.0452674897091;4749.26386410107;4944.60443164546;5028.069807085701;5057.8229761958155;5097.898042039138;371.91817800083936;373.4323827781811;375.31692319977924;378.05486284289276;380.3571963381876;3264.3144939562485;3374.9662503375143;3383.002014405756;3436.621971583124;3442.535257740223;9376.48429336393;9776.266779991529;9822.361546499598;9865.80268394628;9883.752906177258;9678.95160524207;9715.805683886283;9716.417014979124;9720.833499979906;9723.416595004323;7250.564966102051;7385.4460915431555;7405.555666660018;7412.407007439392;7469.589172595451;4705.717656940595;4807.831725889577;4945.431275403231;4950.257461380822;4959.57843583285;8799.076097009722;8981.281497480317;9021.233195178484;9031.729048128567;9163.908360916306;9066.95466522663;9105.27157827359;9160.633574657206;9208.953955230181;9318.161365477139;5882.499987500939;6315.715792789244;6329.493640508656;6357.872842543031;6560.343965603402;7475.2151024141685;7492.288232617892;7519.43604229674;7530.736424225126;7541.4343924207005;6697.732090716317;6821.1814582250445;6913.688884000131;6983.580985140908;7023.578585284899;6652;6746.392824645805;6775.93224067753;6820.386165244953;6835;5964.433378829004;6056.66688332146;6080.635161890301;6149.169862068564;6175.907361389673;4381.934270986001;4434.578715022197;4437.511873693827;4462.308342206963;4476.194285028596;4491.30384790358;4509.549045095464;4530.927989008723;4577.519360467236;4590.495045544921 18:20:06 INFO - PROCESS | 20322 | |4;prototype.html;290.4017723489612;292.7482365165957;294.7406282471425;295.8772109574527;300.75788989863156;5105.897882042357;5118.6416950813455;5143.382794064718;5144.434112247654;5161.922571161431;5070.79716811328;5080.491950804918;5083.1612783890705;5101.668391554546;5136.229565565167;3779.9055023624355;3875.6628963007715;3993.361062230044;3995.380715989026;4005.459262999487;3971.5829837866895;3975.1652153047894;3985.7807820569856;3992.6406623403886;3999.500062492174;3945.408188771693;3962.1877515109477;3963.326234540135;3965.781881996489;3973.3443981742976;3738.327101121797;3964;3969.3847453644444;3987.6411122998925;3989.2021595680835;3462.4979377990303;3468.3410152071024;3470.7396945228957;3475.58293004841;3476.2699833035094;4996.25056241563;4997.225430058346;5000.174971129759;5014.874628134289;5018.949810501921;4297.548757380461;4519.548045195487;4520.932186017212;4532.70537415067;4534.41052663155;5284.762185701614;5306.681599104066;5335.1730481775;5383.057964856134;5391.137418013138;3833.923321533554;3834.213986132836;3843.7117216208894;3845.3847384418636;3849.268638958589;5312.867178320573;5608.439156084359;5619.4942455178825;5632.662040277596;5651.350094739117;3706.5173930427504;3718.9442158367647;3736.178040831013;3738.2336620992633;3751.118487155516;3772.43413487979;3772.490713753663;3778.301014312361;3778.6221377861993;3787.16682329887;4383.145286669069;4390.672943340035;4391.978040109779;4396.208682437192;4411.09572537629;5232.9591459330895;5363.517283444431;5369.221462887859;5370.4629537045985;5383.111786555174;1364.740699267136;1375.5487960202083;1377.937992790327;1380.5444203412849;1381.544090450169;869.2437579306044;869.4870026684287;876.1413814461863;893.1738142218552;904.624580798961;4627.236505976476;4643.767811609406;4646.651501137429;4656.511066338054;4661.5804577587505;5449.536789372948;5452.236686863842;5480.91778623321;5485.314335708036;5508.228847961289;4448.911021779546;4504.369388285642;4599.4710608280475;4622.2835460503675;4652.348671186037;2871.899483518109;2872.8077847692975;2920.532714765627;2931.9560206596916;2935.33954860159;5040.31955685985;5052.469490703496;5053.772580233898;5065.594752419797;5079.974600126976;5395.271638328853;5568.359638641527;5606.943930560724;5763.4812866842185;5788.160716696056;5185.885034717478;5211.166213405837;5211.817586384458;5220.190870415092;5225.738713064332;5541.085720856014;5555.500004999408;5591.182865568625;5596;5618.494335509824;5233.869153271199;5394.595405344693;5412.161115027177;5423.864403389789;5503.743465179257;5156.56169225605;5172.818951336685;5182.637215395037;5189.273501709839;5235.3717553893775;3773.4717139601025;3796.8291426885303;3799.886003419902;3801.790901500444;3817.6564109229193;5394.757235924314;5596.216529685928;5600.915986260128;5604.206653870885;5610.7755689773585;5389.8113566025;5395.298611180521;5403.621746477709;5420.4850539198715;5442.945570544244;5282.4717528246865;5311.467873863838;5422.213779002102;5422.295101636762;5434.83695489136;5239.790408383622;5253.842384728464;5268.998890211001;5273.235380869829;5281.234221037851;5206.583473322201;5311.814086506954;5447.700376479332;5457.481539253765;5462.535684466865;5217.478252174752;5239.554637855825;5254;5284.709340986283;5347.598930080338 18:20:06 INFO - PROCESS | 20322 | |5;yui.html;655.259556700928;663.6814329122018;666.3935818405253;692.4564217089586;717.877960746673;12418.689532761686;12434.440450179742;12570.497180112796;12951.870481295184;13279.800802987938;12921.612351629467;13034.478620855178;13123.671908202276;13128.474861005572;13143;625.1060982794602;758.7951253161643;777.3043126401881;783.6473586885895;791.3629528229773;782.6556315221313;784.6625950841136;785.9096203936534;788.0189164490217;789.2699253190805;828.9751307460785;829.1294141151767;830.3855147191096;831.5966756123306;832.138736407818;807.7899746066036;813.4143416739968;816.6243527977138;818.7830224990323;819.3363375665671;597.6563476001317;599.403593424541;599.6492052149498;600.7596961215548;601.0503404620689;13208;13282.136661116996;13349.866501335056;13383.263920484369;13385.129966552144;13355.532556360578;13504.459821607124;13522.459101635923;13767.862321376859;14238.28808559568;10261.897381026243;10397.688069357931;10444.26890117692;10533.157347412265;10708.036276735053;3224.4034853552166;3275.96724032759;3278.541004259406;3279.2949515853966;3284.720798732111;58478.41521584772;59576;59586.70206648982;60973;61744.382556174314;9840.950795245977;10307.587696492057;10452.947735261276;10604.204684648683;11007.394593297446;18242.543936401697;18301.7254741179;18436.446906592824;18541.629167416577;18577.16402761879;6488.351164883474;6551.344865513411;6589.439897608661;6613.702383392759;6761.8647627047185;3666.816659167031;3677.099110717891;3764.6235376462137;3773.4339849022867;3801.201747632973;2894.247495651146;2974.0631701014113;3000.234940090263;3012.3824615953677;3039.5136778115398;512.718005097195;522.6237109281311;524.3157679228643;528.8413475957275;537.704262655538;467.2244074835824;470.11148928525114;476.23088711730304;478.4234996828813;494.6784590016446;7236.819079523054;7254.202037775946;7358.926410735931;7374.299441553044;7591.924080759232;473.5879784587431;474.1536357601664;480.329939734076;492.6649878082938;496.53325873678625;3467.4625433057918;3473.4616134499192;3513.0514761014383;3541.769784963969;3605.7295702822394;91136.54431727799;92775.53612231895;93142.53428732813;93530.53234733782;94075;80789.59605202054;83090.58454707688;84138;84392.57803710942;84902.15097849067;45679.77160114178;71048.64475677692;71364.64317678378;71973.64013179901;74585.99999999891;6681.1314529110905;6703.966480167568;6751.426128778912;6809.387155155861;6861.348171923659;37882.81058594689;42571.3614295792;43593.56406436022;43657.78171109251;45137.77431112823;40286.79856600698;45029.54970450253;51918.740406299235;53201.73399133134;58210.4178958205;10149.441780702133;10342.896571034193;10401.63594274227;10461.424621645578;10531.05220530156;11511.884881151416;12087.637370878887;12101.515939362327;12197.51209951592;12353.444095015926;10150.390976541432;10296.639617613348;10362.740931476472;10685.786284274427;10754.247202695737;11445.599404020819;11520.654380368602;11542.711432214262;11585.131115166228;11643.476043578228;10918.399488027917;11028.28316159447;11370.431478426211;11371;11548.884511155116;8824.735257942271;8928.10718928102;8939.508327042075;9071.183593476619;9124;9103.635854565744;9347.532623368668;9393.389429687048;9449.338546301693;9497.192738617296 18:20:06 INFO - PROCESS | 20322 | __end_tp_report 18:20:06 INFO - PROCESS | 20322 | __start_cc_report 18:20:06 INFO - PROCESS | 20322 | _x_x_mozilla_cycle_collect,408 18:20:06 INFO - PROCESS | 20322 | __end_cc_report 18:20:06 INFO - PROCESS | 20322 | __startTimestamp1466126406334__endTimestamp 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | ------- Summary: start ------- 18:20:06 INFO - PROCESS | 20322 | Number of tests: 6 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#0] dojo.html Cycles:165 Average:4851.24 Median:5001.25 stddev:617.48 (12.3%) stddev-sans-first:595.65 18:20:06 INFO - PROCESS | 20322 | Values: 2690.3 2717.8 2734.3 2738.1 2750.8 4831.2 4841.4 4881.6 4898.0 4934.7 4844.3 4898.9 4922.9 4951.0 4958.2 4474.4 4530.3 4600.7 4648.4 4649.2 541.3 4429.1 4462.7 4498.8 4557.8 4534.6 4542.5 4543.2 4547.9 4606.3 4509.8 4537.1 4544.0 4561.1 4571.6 4416.1 4427.2 4439.0 4439.5 4441.1 4840.6 4861.1 4872.9 4899.4 4957.0 5256.6 5257.9 5258.8 5285.3 5316.4 5282.9 5344.6 5354.5 5373.1 5426.0 4959.8 4971.4 4980.6 4983.7 4989.7 5370.7 5372.8 5387.7 5493.6 5501.0 5191.4 5203.1 5204.3 5210.3 5227.5 5254.0 5254.2 5259.8 5305.8 5356.3 5151.1 5185.4 5186.2 5208.9 5247.8 5221.1 5230.7 5254.9 5256.3 5261.0 4514.2 4542.0 4543.9 4552.0 4590.9 3847.9 3894.2 3894.8 3903.3 3936.0 4425.2 4480.1 4493.4 4494.4 4593.6 5286.5 5291.2 5307.5 5309.8 5313.8 4488.9 4536.7 4562.2 4599.1 4610.1 4780.1 4796.6 4820.3 4820.9 4862.9 4845.4 5001.2 5012.6 5025.2 5059.6 5292.9 5302.5 5325.5 5352.7 5362.4 4957.1 4961.1 4962.0 4997.0 5039.5 5107.8 5128.1 5171.3 5174.9 5180.6 5216.2 5253.8 5274.7 5275.3 5331.6 5115.3 5151.4 5159.2 5162.3 5198.3 5033.8 5110.3 5129.7 5147.2 5148.1 4971.8 5016.5 5028.0 5065.7 5115.9 5199.3 5213.7 5216.1 5216.3 5252.4 4988.2 4995.4 5027.4 5077.8 5096.3 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#1] ext.html Cycles:180 Average:46153.74 Median:37086.85 stddev:86396.12 (233.0%) stddev-sans-first:86570.59 18:20:06 INFO - PROCESS | 20322 | Values: 533.7 582.4 589.3 601.0 615.5 36319.0 37385.6 40076.6 40358.0 40454.8 40458.4 41378.2 41412.6 41513.4 41551.0 7844.2 7960.2 7968.1 7969.9 8000.5 7819.5 7934.6 7948.0 7968.3 7977.7 7883.1 7894.3 7984.0 7995.0 8007.3 7953.3 7970.5 8002.1 8019.5 8021.0 7963.7 7971.4 8018.9 8040.6 8055.8 30143.2 39247.2 39638.6 39653.2 39674.4 2927.6 2955.5 3030.2 3101.6 3139.5 27819.7 28281.6 28542.6 28903.0 29268.0 3374.9 3380.8 3443.8 3448.0 3512.9 249456.0 249796.0 251314.0 251406.0 254725.0 28037.3 28591.3 54575.0 55399.7 55422.0 34084.4 34183.0 34191.3 34209.3 34265.0 11394.2 11499.1 11625.6 11650.0 11655.1 9248.8 9295.8 9384.1 9410.3 9422.6 7813.6 7867.6 7916.8 7938.0 7946.4 3089.6 3104.7 3116.5 3129.5 3160.1 855.9 888.8 903.9 952.1 957.8 27768.6 28483.4 28483.9 28658.4 28807.1 915.6 928.0 986.8 1011.2 1035.8 14518.8 15030.8 15170.0 15298.0 15448.3 416262.0 418671.0 420624.0 425073.0 428322.0 49519.0 49588.5 49888.3 49917.0 50088.0 1104.4 1149.0 1191.3 1193.0 1193.4 26802.0 28185.6 28282.7 28571.4 28652.4 41954.8 42273.4 42516.8 42583.8 42609.6 265888.0 266379.0 267743.0 268437.0 330765.0 25574.5 25612.7 26072.7 26089.9 26162.7 42289.4 42575.8 42620.8 42901.1 43770.0 36557.9 36764.4 37338.8 37425.8 37486.6 36617.5 36655.4 36978.0 37093.4 37326.3 36091.5 36483.6 36582.3 37058.6 37080.3 31445.7 32582.5 32956.5 33297.2 33325.2 25260.5 25430.4 25804.5 25918.4 26098.9 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#2] jquery.html Cycles:180 Average:23547.88 Median:387.68 stddev:60824.12 (15689.2%) stddev-sans-first:60969.84 18:20:06 INFO - PROCESS | 20322 | Values: 366.9 367.8 376.1 385.8 389.6 15810.3 16873.5 17695.3 17731.4 17742.5 14981.9 15257.7 15873.0 15876.6 15939.2 5138.9 5314.0 5354.7 5357.2 5357.2 3785.3 5241.0 5920.4 6259.7 6263.3 6205.5 6216.7 6290.1 6294.7 6301.2 6246.9 6310.5 6320.7 6326.2 6328.6 5279.9 5428.1 5437.4 5498.9 5543.7 19951.8 20270.7 20781.7 20797.1 21089.4 1885.5 1939.4 2017.1 2018.8 2080.0 13094.5 13157.4 13312.1 13331.5 13357.2 1702.5 1787.5 1806.7 1846.1 1847.9 67087.3 69154.0 69358.0 69700.7 69991.7 9483.4 9602.3 9609.0 9986.3 10014.2 13497.9 13574.3 13608.9 13621.5 13635.7 6800.5 6806.1 6861.5 6879.5 6939.7 6322.2 6323.2 6389.6 6531.0 6544.3 6187.5 6206.8 6207.8 6256.7 6276.2 1633.0 1692.2 1831.1 1854.5 1856.6 764.3 851.8 870.7 910.2 940.7 16748.8 16992.2 17239.9 17323.6 17470.4 865.0 878.8 953.4 968.6 969.6 9856.1 10007.6 10042.1 10060.9 10109.3 361937.0 367334.0 368626.0 372525.0 373946.0 66919.7 68480.0 70904.6 71156.0 71470.6 937.4 947.5 950.6 951.2 956.9 15153.7 15428.4 15447.4 15720.4 15900.4 28726.0 32164.0 34345.8 35316.6 35592.5 47731.5 50953.5 51050.7 51189.2 51578.5 7387.3 7628.4 7690.4 7696.2 7805.1 8790.6 11199.1 11367.9 11556.2 11943.7 5175.6 7979.3 10497.8 10512.9 10626.3 10368.4 10489.3 10499.3 10623.2 10748.6 10218.1 10518.4 10617.0 10739.5 10946.5 7414.4 7477.7 7527.5 7546.4 7868.1 9840.3 10213.1 10299.0 10735.4 10817.8 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#3] mootools.html Cycles:180 Average:5075.30 Median:4727.49 stddev:2916.98 (61.7%) stddev-sans-first:2911.79 18:20:06 INFO - PROCESS | 20322 | Values: 1359.2 1407.6 1465.9 1648.1 1665.4 6851.0 7536.8 7556.4 8065.6 8124.2 7708.4 7860.7 7875.6 7898.6 7957.7 2167.2 2202.0 2202.1 2207.5 2211.4 2191.1 2213.9 2239.4 2245.0 2248.8 2192.4 2194.5 2201.2 2204.9 2228.1 2124.8 2126.3 2133.9 2144.7 2154.9 2118.5 2175.4 2176.1 2177.8 2184.4 7876.5 7931.6 7932.3 7936.7 7939.4 4193.1 4333.0 4353.6 4399.0 4416.6 2746.5 2867.9 2980.9 3000.8 3003.2 879.1 894.5 918.3 919.4 920.5 10407.9 10437.5 10441.9 10466.2 10509.4 4103.1 4191.9 4277.0 4294.7 4306.0 9081.4 9093.8 9109.5 9109.9 9127.2 4317.5 4318.1 4355.3 4361.2 4364.5 3434.5 3828.6 3878.5 3955.8 3958.4 3583.2 3595.0 3689.6 3713.1 3716.9 1134.1 1144.5 1147.1 1151.7 1165.4 786.8 793.1 795.0 815.0 823.0 4749.3 4944.6 5028.1 5057.8 5097.9 371.9 373.4 375.3 378.1 380.4 3264.3 3375.0 3383.0 3436.6 3442.5 9376.5 9776.3 9822.4 9865.8 9883.8 9679.0 9715.8 9716.4 9720.8 9723.4 7250.6 7385.4 7405.6 7412.4 7469.6 4705.7 4807.8 4945.4 4950.3 4959.6 8799.1 8981.3 9021.2 9031.7 9163.9 9067.0 9105.3 9160.6 9209.0 9318.2 5882.5 6315.7 6329.5 6357.9 6560.3 7475.2 7492.3 7519.4 7530.7 7541.4 6697.7 6821.2 6913.7 6983.6 7023.6 6652.0 6746.4 6775.9 6820.4 6835.0 5964.4 6056.7 6080.6 6149.2 6175.9 4381.9 4434.6 4437.5 4462.3 4476.2 4491.3 4509.5 4530.9 4577.5 4590.5 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#4] prototype.html Cycles:180 Average:4423.41 Median:5080.23 stddev:1305.42 (25.7%) stddev-sans-first:1271.69 18:20:06 INFO - PROCESS | 20322 | Values: 290.4 292.7 294.7 295.9 300.8 5105.9 5118.6 5143.4 5144.4 5161.9 5070.8 5080.5 5083.2 5101.7 5136.2 3779.9 3875.7 3993.4 3995.4 4005.5 3971.6 3975.2 3985.8 3992.6 3999.5 3945.4 3962.2 3963.3 3965.8 3973.3 3738.3 3964.0 3969.4 3987.6 3989.2 3462.5 3468.3 3470.7 3475.6 3476.3 4996.3 4997.2 5000.2 5014.9 5018.9 4297.5 4519.5 4520.9 4532.7 4534.4 5284.8 5306.7 5335.2 5383.1 5391.1 3833.9 3834.2 3843.7 3845.4 3849.3 5312.9 5608.4 5619.5 5632.7 5651.4 3706.5 3718.9 3736.2 3738.2 3751.1 3772.4 3772.5 3778.3 3778.6 3787.2 4383.1 4390.7 4392.0 4396.2 4411.1 5233.0 5363.5 5369.2 5370.5 5383.1 1364.7 1375.5 1377.9 1380.5 1381.5 869.2 869.5 876.1 893.2 904.6 4627.2 4643.8 4646.7 4656.5 4661.6 5449.5 5452.2 5480.9 5485.3 5508.2 4448.9 4504.4 4599.5 4622.3 4652.3 2871.9 2872.8 2920.5 2932.0 2935.3 5040.3 5052.5 5053.8 5065.6 5080.0 5395.3 5568.4 5606.9 5763.5 5788.2 5185.9 5211.2 5211.8 5220.2 5225.7 5541.1 5555.5 5591.2 5596.0 5618.5 5233.9 5394.6 5412.2 5423.9 5503.7 5156.6 5172.8 5182.6 5189.3 5235.4 3773.5 3796.8 3799.9 3801.8 3817.7 5394.8 5596.2 5600.9 5604.2 5610.8 5389.8 5395.3 5403.6 5420.5 5442.9 5282.5 5311.5 5422.2 5422.3 5434.8 5239.8 5253.8 5269.0 5273.2 5281.2 5206.6 5311.8 5447.7 5457.5 5462.5 5217.5 5239.6 5254.0 5284.7 5347.6 18:20:06 INFO - PROCESS | 20322 | 18:20:06 INFO - PROCESS | 20322 | [#5] yui.html Cycles:180 Average:16722.63 Median:475.19 stddev:23820.40 (5012.8%) stddev-sans-first:23856.67 18:20:06 INFO - PROCESS | 20322 | Values: 655.3 663.7 666.4 692.5 717.9 12418.7 12434.4 12570.5 12951.9 13279.8 12921.6 13034.5 13123.7 13128.5 13143.0 625.1 758.8 777.3 783.6 791.4 782.7 784.7 785.9 788.0 789.3 829.0 829.1 830.4 831.6 832.1 807.8 813.4 816.6 818.8 819.3 597.7 599.4 599.6 600.8 601.1 13208.0 13282.1 13349.9 13383.3 13385.1 13355.5 13504.5 13522.5 13767.9 14238.3 10261.9 10397.7 10444.3 10533.2 10708.0 3224.4 3276.0 3278.5 3279.3 3284.7 58478.4 59576.0 59586.7 60973.0 61744.4 9841.0 10307.6 10452.9 10604.2 11007.4 18242.5 18301.7 18436.4 18541.6 18577.2 6488.4 6551.3 6589.4 6613.7 6761.9 3666.8 3677.1 3764.6 3773.4 3801.2 2894.2 2974.1 3000.2 3012.4 3039.5 512.7 522.6 524.3 528.8 537.7 467.2 470.1 476.2 478.4 494.7 7236.8 7254.2 7358.9 7374.3 7591.9 473.6 474.2 480.3 492.7 496.5 3467.5 3473.5 3513.1 3541.8 3605.7 91136.5 92775.5 93142.5 93530.5 94075.0 80789.6 83090.6 84138.0 84392.6 84902.2 45679.8 71048.6 71364.6 71973.6 74586.0 6681.1 6704.0 6751.4 6809.4 6861.3 37882.8 42571.4 43593.6 43657.8 45137.8 40286.8 45029.5 51918.7 53201.7 58210.4 10149.4 10342.9 10401.6 10461.4 10531.1 11511.9 12087.6 12101.5 12197.5 12353.4 10150.4 10296.6 10362.7 10685.8 10754.2 11445.6 11520.7 11542.7 11585.1 11643.5 10918.4 11028.3 11370.4 11371.0 11548.9 8824.7 8928.1 8939.5 9071.2 9124.0 9103.6 9347.5 9393.4 9449.3 9497.2 18:20:06 INFO - PROCESS | 20322 | -------- Summary: end -------- 18:20:06 INFO - PROCESS | 20322 | 18:20:07 INFO - TEST-INFO | 20322: exit 0 18:20:07 INFO - TEST-OK | dromaeo_css | took 1116678ms 18:20:07 INFO - TEST-START | kraken 18:20:07 INFO - operating with platform_type : linux_ 18:20:07 INFO - Initialising browser for kraken test... 18:20:07 INFO - TEST-INFO | started process 20560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFgngJ/profile http://localhost:33502/getInfo.html) 18:20:11 INFO - PROCESS | 20560 | __metrics Screen width/height:1600/1200 18:20:11 INFO - PROCESS | 20560 | colorDepth:24 18:20:11 INFO - PROCESS | 20560 | Browser inner width/height: 1024/697 18:20:11 INFO - PROCESS | 20560 | __metrics 18:20:11 ERROR - PROCESS | 20560 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 18:20:12 INFO - TEST-INFO | 20560: exit 0 18:20:12 INFO - Browser initialized. 18:20:12 INFO - Running cycle 1/1 for kraken test... 18:20:12 INFO - TEST-INFO | started process 20678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmFgngJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:25 INFO - PROCESS | 20678 | RSS: Main: 186388480 18:20:25 INFO - PROCESS | 20678 | 18:20:27 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:28 INFO - PROCESS | 20678 | RSS: Main: 191119360 18:20:28 INFO - PROCESS | 20678 | 18:20:31 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-dft) 18:20:32 INFO - PROCESS | 20678 | RSS: Main: 190595072 18:20:32 INFO - PROCESS | 20678 | 18:20:35 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-fft) 18:20:35 INFO - PROCESS | 20678 | RSS: Main: 186580992 18:20:35 INFO - PROCESS | 20678 | 18:20:37 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33502/tests/kraken/driver.html?testName=audio-oscillator) 18:20:38 INFO - PROCESS | 20678 | RSS: Main: 187506688 18:20:38 INFO - PROCESS | 20678 | 18:20:40 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:41 INFO - PROCESS | 20678 | RSS: Main: 187822080 18:20:41 INFO - PROCESS | 20678 | 18:20:44 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:45 INFO - PROCESS | 20678 | RSS: Main: 187813888 18:20:45 INFO - PROCESS | 20678 | 18:20:48 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33502/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:49 INFO - PROCESS | 20678 | RSS: Main: 184369152 18:20:49 INFO - PROCESS | 20678 | 18:20:52 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33502/tests/kraken/driver.html?testName=json-parse-financial) 18:20:53 INFO - PROCESS | 20678 | RSS: Main: 185790464 18:20:53 INFO - PROCESS | 20678 | 18:20:54 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:55 INFO - PROCESS | 20678 | RSS: Main: 186941440 18:20:55 INFO - PROCESS | 20678 | 18:20:57 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:57 INFO - PROCESS | 20678 | RSS: Main: 187031552 18:20:57 INFO - PROCESS | 20678 | 18:21:00 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:00 INFO - PROCESS | 20678 | RSS: Main: 186949632 18:21:00 INFO - PROCESS | 20678 | 18:21:03 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:04 INFO - PROCESS | 20678 | RSS: Main: 187650048 18:21:04 INFO - PROCESS | 20678 | 18:21:07 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:07 INFO - PROCESS | 20678 | RSS: Main: 187105280 18:21:07 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | Cycle 1(1): loaded http://localhost:33502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33502/tests/kraken/driver.html?testName=ai-astar) 18:21:09 INFO - PROCESS | 20678 | RSS: Main: 188416000 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | __start_tp_report 18:21:09 INFO - PROCESS | 20678 | _x_x_mozilla_page_load 18:21:09 INFO - PROCESS | 20678 | _x_x_mozilla_page_load_details 18:21:09 INFO - PROCESS | 20678 | |i|pagename|runs| 18:21:09 INFO - PROCESS | 20678 | |0;ai-astar;114;109;115;114;113;112;113;113;113;112 18:21:09 INFO - PROCESS | 20678 | |1;audio-beat-detection;162;135;157;180;137;159;166;136;186;132 18:21:09 INFO - PROCESS | 20678 | |2;audio-dft;165;177;163;165;165;164;163;164;162;166 18:21:09 INFO - PROCESS | 20678 | |3;audio-fft;76;79;76;182;77;75;75;76;158;77 18:21:09 INFO - PROCESS | 20678 | |4;audio-oscillator;87;89;149;87;88;86;148;87;86;145 18:21:09 INFO - PROCESS | 20678 | |5;imaging-gaussian-blur;122;118;117;119;118;118;117;117;117;119 18:21:09 INFO - PROCESS | 20678 | |6;imaging-darkroom;147;149;149;147;148;148;148;148;148;147 18:21:09 INFO - PROCESS | 20678 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;96;96 18:21:09 INFO - PROCESS | 20678 | |8;json-parse-financial;64;64;63;63;64;63;62;63;62;64 18:21:09 INFO - PROCESS | 20678 | |9;json-stringify-tinderbox;65;65;65;66;65;65;65;65;65;65 18:21:09 INFO - PROCESS | 20678 | |10;stanford-crypto-aes;84;84;83;85;85;85;84;90;109;85 18:21:09 INFO - PROCESS | 20678 | |11;stanford-crypto-ccm;136;136;138;129;129;129;134;137;146;145 18:21:09 INFO - PROCESS | 20678 | |12;stanford-crypto-pbkdf2;173;171;172;171;167;177;168;175;177;172 18:21:09 INFO - PROCESS | 20678 | |13;stanford-crypto-sha256-iterative;69;74;69;67;72;67;66;68;69;66 18:21:09 INFO - PROCESS | 20678 | __end_tp_report 18:21:09 INFO - PROCESS | 20678 | __start_cc_report 18:21:09 INFO - PROCESS | 20678 | _x_x_mozilla_cycle_collect,1021 18:21:09 INFO - PROCESS | 20678 | __end_cc_report 18:21:09 INFO - PROCESS | 20678 | __startTimestamp1466126469894__endTimestamp 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | ------- Summary: start ------- 18:21:09 INFO - PROCESS | 20678 | Number of tests: 14 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.62 (1.4%) stddev-sans-first:1.66 18:21:09 INFO - PROCESS | 20678 | Values: 114.0 109.0 115.0 114.0 113.0 112.0 113.0 113.0 113.0 112.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:160.50 stddev:19.41 (12.1%) stddev-sans-first:20.42 18:21:09 INFO - PROCESS | 20678 | Values: 162.0 135.0 157.0 180.0 137.0 159.0 166.0 136.0 186.0 132.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:4.25 (2.6%) stddev-sans-first:4.50 18:21:09 INFO - PROCESS | 20678 | Values: 165.0 177.0 163.0 165.0 165.0 164.0 163.0 164.0 162.0 166.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.90 (52.5%) stddev-sans-first:41.71 18:21:09 INFO - PROCESS | 20678 | Values: 76.0 79.0 76.0 182.0 77.0 75.0 75.0 76.0 158.0 77.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:87.00 stddev:29.10 (33.5%) stddev-sans-first:30.12 18:21:09 INFO - PROCESS | 20678 | Values: 87.0 89.0 149.0 87.0 88.0 86.0 148.0 87.0 86.0 145.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.55 (1.3%) stddev-sans-first:0.83 18:21:09 INFO - PROCESS | 20678 | Values: 122.0 118.0 117.0 119.0 118.0 118.0 117.0 117.0 117.0 119.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 18:21:09 INFO - PROCESS | 20678 | Values: 147.0 149.0 149.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:21:09 INFO - PROCESS | 20678 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:21:09 INFO - PROCESS | 20678 | Values: 64.0 64.0 63.0 63.0 64.0 63.0 62.0 63.0 62.0 64.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 18:21:09 INFO - PROCESS | 20678 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.00 stddev:7.82 (9.2%) stddev-sans-first:8.20 18:21:09 INFO - PROCESS | 20678 | Values: 84.0 84.0 83.0 85.0 85.0 85.0 84.0 90.0 109.0 85.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:136.50 stddev:6.12 (4.5%) stddev-sans-first:6.49 18:21:09 INFO - PROCESS | 20678 | Values: 136.0 136.0 138.0 129.0 129.0 129.0 134.0 137.0 146.0 145.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:3.37 (2.0%) stddev-sans-first:3.56 18:21:09 INFO - PROCESS | 20678 | Values: 173.0 171.0 172.0 171.0 167.0 177.0 168.0 175.0 177.0 172.0 18:21:09 INFO - PROCESS | 20678 | 18:21:09 INFO - PROCESS | 20678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.58 (3.7%) stddev-sans-first:2.74 18:21:09 INFO - PROCESS | 20678 | Values: 69.0 74.0 69.0 67.0 72.0 67.0 66.0 68.0 69.0 66.0 18:21:09 INFO - PROCESS | 20678 | -------- Summary: end -------- 18:21:09 INFO - PROCESS | 20678 | 18:21:10 INFO - TEST-INFO | 20678: exit 0 18:21:10 INFO - TEST-OK | kraken | took 63824ms 18:21:10 INFO - SUITE-END | took 1180s 18:21:11 INFO - Completed test suite (00:19:40) 18:21:11 INFO - javascript benchmark 18:21:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6356.132359105056, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2690.2736261209475, 2717.782577393809, 2734.2617493276803, 2738.055370897041, 2750.766184874284, 4831.227003679408, 4841.4190297164305, 4881.585065269452, 4897.975510122454, 4934.654574179809, 4844.297576851354, 4898.8775280618, 4922.876928076791, 4951.0, 4958.15711329074, 4474.395956545874, 4530.275155975045, 4600.700954437968, 4648.418947631546, 4649.209634362167, 541.3383757325661, 4429.13631841791, 4462.73223606583, 4498.797554110057, 4557.794899229526, 4534.6145577625775, 4542.523035081302, 4543.159515489612, 4547.8635640930825, 4606.26299792035, 4509.7970591323465, 4537.137943790703, 4544.02303504748, 4561.064981678748, 4571.565701258375, 4416.050549131952, 4427.247367947424, 4438.955610443886, 4439.489458712224, 4441.089576636782, 4840.564349208588, 4861.124997500448, 4872.854879103408, 4899.436564795059, 4957.0, 5256.553192978601, 5257.921131183035, 5258.789648414059, 5285.339332583427, 5316.415194328621, 5282.867928301785, 5344.599155063347, 5354.464553544653, 5373.140297552372, 5426.0, 4959.801607935714, 4971.353724015855, 4980.551750342486, 4983.700977941335, 4989.675671081368, 5370.704611246419, 5372.811951581676, 5387.676739395649, 5493.615446918758, 5501.0, 5191.402988656353, 5203.063448579292, 5204.323437953042, 5210.296609957607, 5227.503387178212, 5254.0, 5254.185601231815, 5259.815906443256, 5305.814296499604, 5356.330458692663, 5151.124308867426, 5185.403678576937, 5186.247994040843, 5208.869778255574, 5247.842564723064, 5221.086309895753, 5230.7384630769075, 5254.947450525522, 5256.290400795843, 5261.026710058652, 4514.164879497238, 4541.954580454153, 4543.931841022388, 4551.977240113844, 4590.885227869263, 3847.8653247136776, 3894.2211557688574, 3894.824732887027, 3903.2583809076186, 3936.0159960009996, 4425.225585522585, 4480.126375356775, 4493.393391892118, 4494.370793086081, 4593.563611456906, 5286.497782710637, 5291.206319052173, 5307.52232299095, 5309.761060752276, 5313.760880760375, 4488.887777805516, 4536.705114167568, 4562.1788078146255, 4599.149157405891, 4610.10103029906, 4780.067886762117, 4796.616270698336, 4820.276958456189, 4820.855374338776, 4862.902741945212, 4845.41854977405, 5001.24981252815, 5012.624053195952, 5025.195968644999, 5059.569936555286, 5292.894142117059, 5302.496262855023, 5325.467453254643, 5352.678839269656, 5362.356517217802, 4957.132501812241, 4961.08219979305, 4961.950380496149, 4996.975015125046, 5039.521245481674, 5107.846764597068, 5128.076946149728, 5171.276021356938, 5174.922376164285, 5180.559652429586, 5216.191490319006, 5253.842384728464, 5274.7098909560345, 5275.314209152785, 5331.626786125089, 5115.2582875483595, 5151.433342332265, 5159.174532075001, 5162.251473536241, 5198.324217851655, 5033.773480193327, 5110.259012443249, 5129.666571672829, 5147.150720131136, 5148.073346797612, 4971.751412429437, 5016.523430274118, 5028.0, 5065.670731402447, 5115.9232611510115, 5199.29809475716, 5213.739313034257, 5216.087184742731, 5216.321878155815, 5252.395974462986, 4988.176950803077, 4995.375578052744, 5027.421846487555, 5077.77150028257, 5096.337476128079], "value": 4813.10251372458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.7309407245255, 582.423400833175, 589.2516504039867, 600.9879802403952, 615.5014438304976, 36319.0, 37385.626143738555, 40076.59923400765, 40358.0, 40454.79772601136, 40458.39312410316, 41378.17243655125, 41412.58587414125, 41513.37729934046, 41551.0, 7844.2155784421675, 7960.203979602052, 7968.12350641429, 7969.920300796975, 8000.519968801861, 7819.491733037335, 7934.642941067666, 7948.046234451845, 7968.322692571139, 7977.680892764282, 7883.093444253898, 7894.3289820365335, 7984.041914970212, 7995.040595128593, 8007.31937785286, 7953.323967462744, 7970.521768693897, 8002.079760827522, 8019.518828870287, 8020.959895200486, 7963.681452741884, 7971.402144839102, 8018.879716804253, 8040.638171282307, 8055.798605034863, 30143.246418839484, 39247.21505569901, 39638.60361396407, 39653.20693586141, 39674.40488392676, 2927.5608658701367, 2955.5418910068975, 3030.1818509002665, 3101.565780790691, 3139.5290706393994, 27819.721802781914, 28281.57577636337, 28542.571861422097, 28903.0, 29268.0, 3374.865005399806, 3380.8309584520675, 3443.8200856499147, 3448.0, 3512.947305790415, 249456.0, 249796.0, 251314.0, 251405.99999999817, 254725.0, 28037.299067523476, 28591.285217869303, 54575.0, 55399.723001385544, 55422.0, 34084.44366672509, 34183.0, 34191.31617367688, 34209.31581368409, 34265.0, 11394.202405831678, 11499.137564682682, 11625.59310424131, 11650.0, 11655.125865560118, 9248.768780780534, 9295.767605809773, 9384.108509691569, 9410.294227932933, 9422.623095076257, 7813.648385822652, 7867.606619669108, 7916.841663166704, 7938.04743430792, 7946.443748937519, 3089.6292444906753, 3104.6740092289983, 3116.548100525411, 3129.530570414456, 3160.1309639849223, 855.8758979947872, 888.813349196676, 903.9412438191628, 952.1002652493465, 957.8323793336139, 27768.58347124795, 28483.430331393258, 28483.857580711963, 28658.426831463672, 28807.135785926457, 915.5788337364887, 927.9628814847465, 986.7927735175693, 1011.2011510906449, 1035.7669524356959, 14518.782218266735, 15030.849691502945, 15170.0, 15298.0, 15448.304826282843, 416262.0, 418671.0, 420624.0, 425073.0, 428322.0, 49519.0, 49588.50411495839, 49888.251676224885, 49917.0, 50088.0, 1104.364990130662, 1148.982765258505, 1191.3090407563593, 1193.0455635491571, 1193.3675152169365, 26802.0, 28185.577216342183, 28282.71717282801, 28571.42857142887, 28652.42695146044, 41954.790226049896, 42273.365899512144, 42516.787416062725, 42583.787081064394, 42609.573904260564, 265888.0, 266379.0, 267743.0, 268437.0, 330765.0, 25574.488510230065, 25612.743872561037, 26072.739272607032, 26089.869550652125, 26162.73837261603, 42289.365659514515, 42575.787121065434, 42620.78689606532, 42901.14197716091, 43770.0, 36557.90326290215, 36764.44853327149, 37338.8133059333, 37425.81287093547, 37486.6251337494, 36617.45073823948, 36655.434119611375, 36978.0, 37093.43458282024, 37326.25347493089, 36091.458628120075, 36483.635163648025, 36582.26835463329, 37058.6294137066, 37080.25839483249, 31445.685543144275, 32582.511262331558, 32956.50565241571, 33297.167570810925, 33325.16687082745, 25260.494790103727, 25430.364240894127, 25804.483910321313, 25918.35204119912, 26098.86950565235], "value": 16366.002861104935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.85509223856576, 367.75360508459323, 376.13113707336055, 385.80324034742273, 389.5578518381636, 15810.288537015833, 16873.49379518615, 17695.29218831245, 17731.379401720944, 17742.46772596821, 14981.92509037456, 15257.694846103072, 15873.04761714298, 15876.603084922883, 15939.203039847991, 5138.871528211796, 5314.0, 5354.651947623412, 5357.196420536931, 5357.249985002103, 3785.2807966486416, 5240.973795131038, 5920.407959204088, 6259.749610015617, 6263.31103578606, 6205.5345849061505, 6216.689165541728, 6290.056491526262, 6294.653794041325, 6301.212348456443, 6246.937530624681, 6310.5267104967315, 6320.715567799437, 6326.240851097875, 6328.620282783025, 5279.894402111936, 5428.077226871442, 5437.401885792559, 5498.917516237259, 5543.695096769676, 19951.80048199514, 20270.69593956092, 20781.68827467574, 20797.06413211409, 21089.367318980454, 1885.53804317943, 1939.4181745476442, 2017.1326329678232, 2018.760602734261, 2080.001599232377, 13094.47622095115, 13157.407916643773, 13312.134711243834, 13331.533396331179, 13357.198568085945, 1702.5062731807761, 1787.5263055290359, 1806.656735220304, 1846.095413247499, 1847.8706490545667, 67087.3291267086, 69154.0, 69358.0, 69700.6514967432, 69991.65004174998, 9483.383580067273, 9602.279829012712, 9609.0, 9986.300958932805, 10014.24893133018, 13497.865021349857, 13574.25341606221, 13608.93195534016, 13621.523246686318, 13635.659108522168, 6800.489963252677, 6806.149231346082, 6861.4853885958755, 6879.5184337096925, 6939.722411103499, 6322.209723784527, 6323.241211054703, 6389.552731308764, 6530.967345163243, 6544.265769570972, 6187.5149964009215, 6206.782762603287, 6207.81376558704, 6256.749730010749, 6276.202897247191, 1632.959176020609, 1692.2300353339201, 1831.1210618903, 1854.4807453912927, 1856.5637075287298, 764.289211033744, 851.8211175653058, 870.6822009966317, 910.1808372464702, 940.6519587752575, 16748.83251167497, 16992.235349409308, 17239.913800431168, 17323.56691082733, 17470.388536401166, 864.9827003459895, 878.8110556230441, 953.3755390219279, 968.5593055159885, 969.5588507229194, 9856.112949834549, 10007.649732259482, 10042.096211341015, 10060.949695251624, 10109.292349535463, 361937.0, 367334.0, 368626.0, 372525.0, 373946.0, 66919.66540167366, 68480.0, 70904.64547677332, 71156.0, 71470.64264678644, 937.4000639590668, 947.4741518457184, 950.6150009246267, 951.2390087929629, 956.933014688965, 15153.696926061197, 15428.382864685287, 15447.382104716135, 15720.449784257497, 15900.363985440916, 28726.0, 32164.0, 34345.82827085849, 35316.64683353133, 35592.46611300884, 47731.52268477271, 50953.490465094874, 51050.74474627603, 51189.23216151686, 51578.48421515737, 7387.335139837441, 7628.389728821792, 7690.423218258541, 7696.230376962483, 7805.063392392949, 8790.560471976247, 11199.10407167441, 11367.920047595466, 11556.24884382546, 11943.701407464536, 5175.611829112907, 7979.281864631978, 10497.842532362174, 10512.948705129731, 10626.256162068581, 10368.429736364573, 10489.265751397328, 10499.265051446326, 10623.150147988297, 10748.570057197625, 10218.080372766486, 10518.368897866152, 10617.0, 10739.463026848782, 10946.45267736594, 7414.406847452083, 7477.738279160203, 7527.473076884785, 7546.434017448603, 7868.134505204537, 9840.261980351359, 10213.131883789962, 10299.0, 10735.355878647306, 10817.783644326912], "value": 8362.251799288671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.164114069847, 1407.6281465730244, 1465.8900582456317, 1648.0606054548912, 1665.3588368478147, 6850.965745171279, 7536.81157971051, 7556.395488360931, 8065.637046332914, 8124.228198321158, 7708.421868359867, 7860.724874629374, 7875.566843823587, 7898.565578893159, 7957.681692732298, 2167.2306331252416, 2202.031106313225, 2202.130158587357, 2207.4922767763424, 2211.3918672365066, 2191.0906973605934, 2213.9335819925345, 2239.395363251929, 2244.9887750561224, 2248.774417942225, 2192.3861318830754, 2194.4623567226054, 2201.218567408563, 2204.911803527865, 2228.064213030531, 2124.808767210943, 2126.25581046634, 2133.9466513337134, 2144.6782982552663, 2154.859934104286, 2118.480972161815, 2175.3582693105573, 2176.1077958037285, 2177.7822217778253, 2184.3774524260666, 7876.527408355517, 7931.563763992978, 7932.325752311061, 7936.6825326986855, 7939.364850811921, 4193.056562273464, 4332.9566704332865, 4353.586409291112, 4398.956010439887, 4416.624586910117, 2746.5056289867816, 2867.899623513167, 2980.910572682823, 3000.774941879368, 3003.23417528531, 879.0637970561331, 894.5035505294559, 918.3433844801, 919.3564504846634, 920.5075284722708, 10407.895921040768, 10437.478126093665, 10441.947790261, 10466.162706983423, 10509.369437833679, 4103.138340948374, 4191.895202619959, 4276.957230427718, 4294.6993710439965, 4305.956940430556, 9081.409708369067, 9093.81812363749, 9109.544522773967, 9109.90890091104, 9127.22418594427, 4317.546657600969, 4318.071614602813, 4355.324924636687, 4361.17137743834, 4364.454443194601, 3434.5019972103905, 3828.559715632682, 3878.5345758508597, 3955.7626542407547, 3958.4062390641634, 3583.1937813992163, 3594.98202508991, 3689.557253129588, 3713.1459764254373, 3716.851325946932, 1134.0813940708053, 1144.513581727779, 1147.0880649883195, 1151.7063148897146, 1165.4172913543227, 786.7561056072636, 793.1037927142293, 794.9920500794918, 814.9837003259902, 823.0452674897091, 4749.26386410107, 4944.60443164546, 5028.069807085701, 5057.8229761958155, 5097.898042039138, 371.91817800083936, 373.4323827781811, 375.31692319977924, 378.05486284289276, 380.3571963381876, 3264.3144939562485, 3374.9662503375143, 3383.002014405756, 3436.621971583124, 3442.535257740223, 9376.48429336393, 9776.266779991529, 9822.361546499598, 9865.80268394628, 9883.752906177258, 9678.95160524207, 9715.805683886283, 9716.417014979124, 9720.833499979906, 9723.416595004323, 7250.564966102051, 7385.4460915431555, 7405.555666660018, 7412.407007439392, 7469.589172595451, 4705.717656940595, 4807.831725889577, 4945.431275403231, 4950.257461380822, 4959.57843583285, 8799.076097009722, 8981.281497480317, 9021.233195178484, 9031.729048128567, 9163.908360916306, 9066.95466522663, 9105.27157827359, 9160.633574657206, 9208.953955230181, 9318.161365477139, 5882.499987500939, 6315.715792789244, 6329.493640508656, 6357.872842543031, 6560.343965603402, 7475.2151024141685, 7492.288232617892, 7519.43604229674, 7530.736424225126, 7541.4343924207005, 6697.732090716317, 6821.1814582250445, 6913.688884000131, 6983.580985140908, 7023.578585284899, 6652.0, 6746.392824645805, 6775.93224067753, 6820.386165244953, 6835.0, 5964.433378829004, 6056.66688332146, 6080.635161890301, 6149.169862068564, 6175.907361389673, 4381.934270986001, 4434.578715022197, 4437.511873693827, 4462.308342206963, 4476.194285028596, 4491.30384790358, 4509.549045095464, 4530.927989008723, 4577.519360467236, 4590.495045544921], "value": 3993.652271894438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.4017723489612, 292.7482365165957, 294.7406282471425, 295.8772109574527, 300.75788989863156, 5105.897882042357, 5118.6416950813455, 5143.382794064718, 5144.434112247654, 5161.922571161431, 5070.79716811328, 5080.491950804918, 5083.1612783890705, 5101.668391554546, 5136.229565565167, 3779.9055023624355, 3875.6628963007715, 3993.361062230044, 3995.380715989026, 4005.459262999487, 3971.5829837866895, 3975.1652153047894, 3985.7807820569856, 3992.6406623403886, 3999.500062492174, 3945.408188771693, 3962.1877515109477, 3963.326234540135, 3965.781881996489, 3973.3443981742976, 3738.327101121797, 3964.0, 3969.3847453644444, 3987.6411122998925, 3989.2021595680835, 3462.4979377990303, 3468.3410152071024, 3470.7396945228957, 3475.58293004841, 3476.2699833035094, 4996.25056241563, 4997.225430058346, 5000.174971129759, 5014.874628134289, 5018.949810501921, 4297.548757380461, 4519.548045195487, 4520.932186017212, 4532.70537415067, 4534.41052663155, 5284.762185701614, 5306.681599104066, 5335.1730481775, 5383.057964856134, 5391.137418013138, 3833.923321533554, 3834.213986132836, 3843.7117216208894, 3845.3847384418636, 3849.268638958589, 5312.867178320573, 5608.439156084359, 5619.4942455178825, 5632.662040277596, 5651.350094739117, 3706.5173930427504, 3718.9442158367647, 3736.178040831013, 3738.2336620992633, 3751.118487155516, 3772.43413487979, 3772.490713753663, 3778.301014312361, 3778.6221377861993, 3787.16682329887, 4383.145286669069, 4390.672943340035, 4391.978040109779, 4396.208682437192, 4411.09572537629, 5232.9591459330895, 5363.517283444431, 5369.221462887859, 5370.4629537045985, 5383.111786555174, 1364.740699267136, 1375.5487960202083, 1377.937992790327, 1380.5444203412849, 1381.544090450169, 869.2437579306044, 869.4870026684287, 876.1413814461863, 893.1738142218552, 904.624580798961, 4627.236505976476, 4643.767811609406, 4646.651501137429, 4656.511066338054, 4661.5804577587505, 5449.536789372948, 5452.236686863842, 5480.91778623321, 5485.314335708036, 5508.228847961289, 4448.911021779546, 4504.369388285642, 4599.4710608280475, 4622.2835460503675, 4652.348671186037, 2871.899483518109, 2872.8077847692975, 2920.532714765627, 2931.9560206596916, 2935.33954860159, 5040.31955685985, 5052.469490703496, 5053.772580233898, 5065.594752419797, 5079.974600126976, 5395.271638328853, 5568.359638641527, 5606.943930560724, 5763.4812866842185, 5788.160716696056, 5185.885034717478, 5211.166213405837, 5211.817586384458, 5220.190870415092, 5225.738713064332, 5541.085720856014, 5555.500004999408, 5591.182865568625, 5596.0, 5618.494335509824, 5233.869153271199, 5394.595405344693, 5412.161115027177, 5423.864403389789, 5503.743465179257, 5156.56169225605, 5172.818951336685, 5182.637215395037, 5189.273501709839, 5235.3717553893775, 3773.4717139601025, 3796.8291426885303, 3799.886003419902, 3801.790901500444, 3817.6564109229193, 5394.757235924314, 5596.216529685928, 5600.915986260128, 5604.206653870885, 5610.7755689773585, 5389.8113566025, 5395.298611180521, 5403.621746477709, 5420.4850539198715, 5442.945570544244, 5282.4717528246865, 5311.467873863838, 5422.213779002102, 5422.295101636762, 5434.83695489136, 5239.790408383622, 5253.842384728464, 5268.998890211001, 5273.235380869829, 5281.234221037851, 5206.583473322201, 5311.814086506954, 5447.700376479332, 5457.481539253765, 5462.535684466865, 5217.478252174752, 5239.554637855825, 5254.0, 5284.709340986283, 5347.598930080338], "value": 4002.3954944227667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.259556700928, 663.6814329122018, 666.3935818405253, 692.4564217089586, 717.877960746673, 12418.689532761686, 12434.440450179742, 12570.497180112796, 12951.870481295184, 13279.800802987938, 12921.612351629467, 13034.478620855178, 13123.671908202276, 13128.474861005572, 13143.0, 625.1060982794602, 758.7951253161643, 777.3043126401881, 783.6473586885895, 791.3629528229773, 782.6556315221313, 784.6625950841136, 785.9096203936534, 788.0189164490217, 789.2699253190805, 828.9751307460785, 829.1294141151767, 830.3855147191096, 831.5966756123306, 832.138736407818, 807.7899746066036, 813.4143416739968, 816.6243527977138, 818.7830224990323, 819.3363375665671, 597.6563476001317, 599.403593424541, 599.6492052149498, 600.7596961215548, 601.0503404620689, 13208.0, 13282.136661116996, 13349.866501335056, 13383.263920484369, 13385.129966552144, 13355.532556360578, 13504.459821607124, 13522.459101635923, 13767.862321376859, 14238.28808559568, 10261.897381026243, 10397.688069357931, 10444.26890117692, 10533.157347412265, 10708.036276735053, 3224.4034853552166, 3275.96724032759, 3278.541004259406, 3279.2949515853966, 3284.720798732111, 58478.41521584772, 59576.0, 59586.70206648982, 60973.0, 61744.382556174314, 9840.950795245977, 10307.587696492057, 10452.947735261276, 10604.204684648683, 11007.394593297446, 18242.543936401697, 18301.7254741179, 18436.446906592824, 18541.629167416577, 18577.16402761879, 6488.351164883474, 6551.344865513411, 6589.439897608661, 6613.702383392759, 6761.8647627047185, 3666.816659167031, 3677.099110717891, 3764.6235376462137, 3773.4339849022867, 3801.201747632973, 2894.247495651146, 2974.0631701014113, 3000.234940090263, 3012.3824615953677, 3039.5136778115398, 512.718005097195, 522.6237109281311, 524.3157679228643, 528.8413475957275, 537.704262655538, 467.2244074835824, 470.11148928525114, 476.23088711730304, 478.4234996828813, 494.6784590016446, 7236.819079523054, 7254.202037775946, 7358.926410735931, 7374.299441553044, 7591.924080759232, 473.5879784587431, 474.1536357601664, 480.329939734076, 492.6649878082938, 496.53325873678625, 3467.4625433057918, 3473.4616134499192, 3513.0514761014383, 3541.769784963969, 3605.7295702822394, 91136.54431727799, 92775.53612231895, 93142.53428732813, 93530.53234733782, 94075.0, 80789.59605202054, 83090.58454707688, 84138.0, 84392.57803710942, 84902.15097849067, 45679.77160114178, 71048.64475677692, 71364.64317678378, 71973.64013179901, 74585.99999999891, 6681.1314529110905, 6703.966480167568, 6751.426128778912, 6809.387155155861, 6861.348171923659, 37882.81058594689, 42571.3614295792, 43593.56406436022, 43657.78171109251, 45137.77431112823, 40286.79856600698, 45029.54970450253, 51918.740406299235, 53201.73399133134, 58210.4178958205, 10149.441780702133, 10342.896571034193, 10401.63594274227, 10461.424621645578, 10531.05220530156, 11511.884881151416, 12087.637370878887, 12101.515939362327, 12197.51209951592, 12353.444095015926, 10150.390976541432, 10296.639617613348, 10362.740931476472, 10685.786284274427, 10754.247202695737, 11445.599404020819, 11520.654380368602, 11542.711432214262, 11585.131115166228, 11643.476043578228, 10918.399488027917, 11028.28316159447, 11370.431478426211, 11371.0, 11548.884511155116, 8824.735257942271, 8928.10718928102, 8939.508327042075, 9071.183593476619, 9124.0, 9103.635854565744, 9347.532623368668, 9393.389429687048, 9449.338546301693, 9497.192738617296], "value": 6262.259140706368, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 115.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 157.0, 180.0, 137.0, 159.0, 166.0, 136.0, 186.0, 132.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 177.0, 163.0, 165.0, 165.0, 164.0, 163.0, 164.0, 162.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 182.0, 77.0, 75.0, 75.0, 76.0, 158.0, 77.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 149.0, 87.0, 88.0, 86.0, 148.0, 87.0, 86.0, 145.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 117.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 85.0, 85.0, 84.0, 90.0, 109.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 138.0, 129.0, 129.0, 129.0, 134.0, 137.0, 146.0, 145.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 172.0, 171.0, 167.0, 177.0, 168.0, 175.0, 177.0, 172.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 69.0, 67.0, 72.0, 67.0, 66.0, 68.0, 69.0, 66.0], "value": 68.7, "unit": "score"}]}]} 18:21:11 INFO - Return code: 0 18:21:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:21:11 ERROR - # TBPL SUCCESS # 18:21:11 INFO - Running post-action listener: _resource_record_post_action 18:21:11 INFO - ##### 18:21:11 INFO - ##### Finished run-tests step (success) 18:21:11 INFO - ##### 18:21:11 INFO - Running post-run listener: _resource_record_post_run 18:21:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 533127168; Read time: 0; Write time: 356108 18:21:11 INFO - TinderboxPrint: CPU usage
13.4% 18:21:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:21:11 INFO - TinderboxPrint: I/O write bytes / time
533,127,168 / 356,108 18:21:11 INFO - TinderboxPrint: CPU idle
8,272.2 (86.6%) 18:21:11 INFO - TinderboxPrint: CPU user
1,231.0 (12.9%) 18:21:11 INFO - TinderboxPrint: Swap in / out
0 / 0 18:21:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245145600; Read time: 0; Write time: 212864 18:21:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287981568; Read time: 0; Write time: 143244 18:21:11 INFO - Running post-run listener: _upload_blobber_files 18:21:11 INFO - Blob upload gear active. 18:21:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:21:11 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 18:21:11 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:21:11 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:21:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:12 INFO - (blobuploader) - INFO - Done attempting. 18:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:16 INFO - (blobuploader) - INFO - Done attempting. 18:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:21:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:21:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:21:17 INFO - (blobuploader) - INFO - Done attempting. 18:21:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:21:17 INFO - Return code: 0 18:21:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:21:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:21:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68ef662480fce8d5bf2112884ba3db0ad7c15fff0d927bc6dddeb5d0852c2d7e5bd81c21a10c67b5a0397a5cc06b2c1aee03c4be712f01259c12adc46a587691", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f9e7c31b2997a4a4d2cce8483886127a4f4d4dd000c4a649ed7cb47f24e9824ff75845921e3f361632692ff0ec123b9b5a4b3ad1ebe6cf24968900e3fea3b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800554709749b160bde7079836b2f0f6a7e709db34aa59fb70c0cd03da954547dc0d9788632144f7963c34e9aba52fe7fba5b254a5c6b747559e4fe88fc9e484"} 18:21:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:21:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:21:17 INFO - Contents: 18:21:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68ef662480fce8d5bf2112884ba3db0ad7c15fff0d927bc6dddeb5d0852c2d7e5bd81c21a10c67b5a0397a5cc06b2c1aee03c4be712f01259c12adc46a587691", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f9e7c31b2997a4a4d2cce8483886127a4f4d4dd000c4a649ed7cb47f24e9824ff75845921e3f361632692ff0ec123b9b5a4b3ad1ebe6cf24968900e3fea3b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800554709749b160bde7079836b2f0f6a7e709db34aa59fb70c0cd03da954547dc0d9788632144f7963c34e9aba52fe7fba5b254a5c6b747559e4fe88fc9e484"} 18:21:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:21:17 INFO - Copying logs to upload dir... 18:21:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:21:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.715550 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-16 18:21:16.759911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:21:16.763902) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 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-Non-PGO/sha512/68ef662480fce8d5bf2112884ba3db0ad7c15fff0d927bc6dddeb5d0852c2d7e5bd81c21a10c67b5a0397a5cc06b2c1aee03c4be712f01259c12adc46a587691", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f9e7c31b2997a4a4d2cce8483886127a4f4d4dd000c4a649ed7cb47f24e9824ff75845921e3f361632692ff0ec123b9b5a4b3ad1ebe6cf24968900e3fea3b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800554709749b160bde7079836b2f0f6a7e709db34aa59fb70c0cd03da954547dc0d9788632144f7963c34e9aba52fe7fba5b254a5c6b747559e4fe88fc9e484"} build_url:https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/HQ_BYAMIRqaZJG_LEYuNNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68ef662480fce8d5bf2112884ba3db0ad7c15fff0d927bc6dddeb5d0852c2d7e5bd81c21a10c67b5a0397a5cc06b2c1aee03c4be712f01259c12adc46a587691", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f9e7c31b2997a4a4d2cce8483886127a4f4d4dd000c4a649ed7cb47f24e9824ff75845921e3f361632692ff0ec123b9b5a4b3ad1ebe6cf24968900e3fea3b54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800554709749b160bde7079836b2f0f6a7e709db34aa59fb70c0cd03da954547dc0d9788632144f7963c34e9aba52fe7fba5b254a5c6b747559e4fe88fc9e484"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 18:21:16.791298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:21:16.791914) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466109011.405559-1446173726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 18:21:16.879171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:21:16.879913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 18:21:16.880208) ========= ========= Total master_lag: 0.57 =========