builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1466984298.44 results: success (0) buildid: 20160626155524 builduid: 1119895d3cfc4cac8aeeb63fb83d8e2d revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.444751) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.445470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.445739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.489573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.489850) ========= 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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 16:38:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.2K=0.2s 2016-06-26 16:38:19 (57.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.303599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.806954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.807281) ========= 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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016414 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.856644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:18.856960) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 16:38:19,618 truncating revision to first 12 chars 2016-06-26 16:38:19,618 Setting DEBUG logging. 2016-06-26 16:38:19,618 attempt 1/10 2016-06-26 16:38:19,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/110c7ad7d399?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 16:38:19,992 unpacking tar archive at: fx-team-110c7ad7d399/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:19.595302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:19.595602) ========= script_repo_revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:19.595972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:19.596267) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 16:38:19.605397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-26 16:38:19.605666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:38:20 INFO - MultiFileLogger online at 20160626 16:38:20 in /builds/slave/test 16:38:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:38:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:38:20 INFO - {'append_to_log': False, 16:38:20 INFO - 'base_work_dir': '/builds/slave/test', 16:38:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:38:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:38:20 INFO - 'branch': 'Fx-Team-Non-PGO', 16:38:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:20 INFO - 'config_files': ('talos/linux_config.py',), 16:38:20 INFO - 'default_actions': ('clobber', 16:38:20 INFO - 'read-buildbot-config', 16:38:20 INFO - 'download-and-extract', 16:38:20 INFO - 'populate-webroot', 16:38:20 INFO - 'create-virtualenv', 16:38:20 INFO - 'install', 16:38:20 INFO - 'run-tests'), 16:38:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:20 INFO - 'download_minidump_stackwalk': True, 16:38:20 INFO - 'download_symbols': 'ondemand', 16:38:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:20 INFO - 'installer_path': 'installer.exe', 16:38:20 INFO - 'log_level': 'info', 16:38:20 INFO - 'log_name': 'talos', 16:38:20 INFO - 'log_to_console': True, 16:38:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:38:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:38:20 INFO - 'opt_config_files': (), 16:38:20 INFO - 'pip_index': False, 16:38:20 INFO - 'sps_profile': False, 16:38:20 INFO - 'sps_profile_interval': 0, 16:38:20 INFO - 'suite': 'dromaeojs-e10s', 16:38:20 INFO - 'system_bits': '32', 16:38:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:20 INFO - 'title': 'talos-linux64-ix-008', 16:38:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:20 INFO - 'use_talos_json': True, 16:38:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:38:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:20 INFO - 'work_dir': 'build'} 16:38:20 INFO - ##### 16:38:20 INFO - ##### Running clobber step. 16:38:20 INFO - ##### 16:38:20 INFO - Running pre-action listener: _resource_record_pre_action 16:38:20 INFO - Running main action method: clobber 16:38:20 INFO - rmtree: /builds/slave/test/build 16:38:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:20 INFO - Running post-action listener: _resource_record_post_action 16:38:20 INFO - ##### 16:38:20 INFO - ##### Finished clobber step (success) 16:38:20 INFO - ##### 16:38:20 INFO - ##### 16:38:20 INFO - ##### Running read-buildbot-config step. 16:38:20 INFO - ##### 16:38:20 INFO - Running pre-action listener: _resource_record_pre_action 16:38:20 INFO - Running main action method: read_buildbot_config 16:38:20 INFO - Using buildbot properties: 16:38:20 INFO - { 16:38:20 INFO - "project": "", 16:38:20 INFO - "product": "firefox", 16:38:20 INFO - "script_repo_revision": "production", 16:38:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:38:20 INFO - "repository": "", 16:38:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:38:20 INFO - "buildid": "20160626155524", 16:38:20 INFO - "pgo_build": "False", 16:38:20 INFO - "basedir": "/builds/slave/test", 16:38:20 INFO - "buildnumber": 1434, 16:38:20 INFO - "slavename": "talos-linux64-ix-008", 16:38:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:38:20 INFO - "platform": "ubuntu64_hw", 16:38:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:38:20 INFO - "branch": "fx-team", 16:38:20 INFO - "repo_path": "integration/fx-team", 16:38:20 INFO - "revision": "110c7ad7d399d16b9c77940f766a26df5d90f881", 16:38:20 INFO - "stage_platform": "linux64", 16:38:20 INFO - "builduid": "1119895d3cfc4cac8aeeb63fb83d8e2d", 16:38:20 INFO - "slavebuilddir": "test" 16:38:20 INFO - } 16:38:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:38:20 INFO - Running post-action listener: _resource_record_post_action 16:38:20 INFO - ##### 16:38:20 INFO - ##### Finished read-buildbot-config step (success) 16:38:20 INFO - ##### 16:38:20 INFO - ##### 16:38:20 INFO - ##### Running download-and-extract step. 16:38:20 INFO - ##### 16:38:20 INFO - Running pre-action listener: _resource_record_pre_action 16:38:20 INFO - Running main action method: download_and_extract 16:38:20 INFO - mkdir: /builds/slave/test/build/tests 16:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:20 INFO - https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:24 INFO - Downloaded 1361 bytes. 16:38:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:24 INFO - Using the following test package requirements: 16:38:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:38:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:38:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'jsshell-linux-x86_64.zip'], 16:38:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:38:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:38:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:38:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:38:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:38:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:24 INFO - https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:26 INFO - Downloaded 22712973 bytes. 16:38:26 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'] 16:38:26 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 16:38:27 INFO - Return code: 0 16:38:27 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 16:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:27 INFO - https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:29 INFO - Downloaded 22712973 bytes. 16:38:29 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'] 16:38:29 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 16:38:30 INFO - Return code: 0 16:38: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')]} 16:38:30 INFO - https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:31 INFO - Downloaded 14405240 bytes. 16:38:31 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'] 16:38:31 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 16:38:31 INFO - Return code: 0 16:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:31 INFO - https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuufyDISRyqH81DE3Z9R7A/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 16:38:34 INFO - Downloaded 56274802 bytes. 16:38:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:34 INFO - mkdir: /builds/slave/test/properties 16:38:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:34 INFO - Contents: 16:38:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:35 INFO - Running post-action listener: _resource_record_post_action 16:38:35 INFO - Running post-action listener: set_extra_try_arguments 16:38:35 INFO - ##### 16:38:35 INFO - ##### Finished download-and-extract step (success) 16:38:35 INFO - ##### 16:38:35 INFO - ##### 16:38:35 INFO - ##### Running populate-webroot step. 16:38:35 INFO - ##### 16:38:35 INFO - Running pre-action listener: _resource_record_pre_action 16:38:35 INFO - Running main action method: populate_webroot 16:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:35 INFO - '--tppagecycles', 16:38:35 INFO - '7'], 16:38:35 INFO - 'tests': ['tsvgm']}}, 16:38:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['damp', 'tps']}, 16:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'tests': ['damp', 'tps']}, 16:38:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['dromaeo_dom']}, 16:38:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['basic_compositor_video']}, 16:38:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:38:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['a11yr', 16:38:35 INFO - 'ts_paint', 16:38:35 INFO - 'tpaint', 16:38:35 INFO - 'sessionrestore', 16:38:35 INFO - 'sessionrestore_no_auto_restore', 16:38:35 INFO - 'tabpaint']}, 16:38:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['tsvgx', 16:38:35 INFO - 'tsvgr_opacity', 16:38:35 INFO - 'tart', 16:38:35 INFO - 'tscrollx', 16:38:35 INFO - 'cart']}, 16:38:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:35 INFO - 'tsvgr_opacity', 16:38:35 INFO - 'tart', 16:38:35 INFO - 'tscrollx', 16:38:35 INFO - 'cart']}, 16:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'talos_options': ['--disable-e10s'], 16:38:35 INFO - 'tests': ['tp5o']}, 16:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'tests': ['tp5o']}, 16:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'talos_options': ['--disable-e10s', 16:38:35 INFO - '--xperf_path', 16:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:35 INFO - 'tests': ['tp5n']}, 16:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:35 INFO - 'talos_options': ['--xperf_path', 16:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:35 INFO - 'tests': ['tp5n']}}, 16:38:35 INFO - 'talos.zip': {'path': '', 16:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:35 INFO - Running post-action listener: _resource_record_post_action 16:38:35 INFO - ##### 16:38:35 INFO - ##### Finished populate-webroot step (success) 16:38:35 INFO - ##### 16:38:35 INFO - ##### 16:38:35 INFO - ##### Running create-virtualenv step. 16:38:35 INFO - ##### 16:38:35 INFO - Running pre-action listener: _resource_record_pre_action 16:38:35 INFO - Running main action method: create_virtualenv 16:38:35 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:35 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 16:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:35 INFO - Using real prefix '/usr' 16:38:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:36 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:37 INFO - Installing pip.................done. 16:38:37 INFO - Return code: 0 16:38:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:38:38 INFO - Using env: {'DISPLAY': ':0', 16:38:38 INFO - 'HOME': '/home/cltbld', 16:38:38 INFO - 'LANG': 'en_US.UTF-8', 16:38:38 INFO - 'LANGUAGE': 'en_US:en', 16:38:38 INFO - 'LOGNAME': 'cltbld', 16:38:38 INFO - 'MAIL': '/var/mail/cltbld', 16:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:38 INFO - 'MOZ_NO_REMOTE': '1', 16:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:38 INFO - 'NO_EM_RESTART': '1', 16:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:38 INFO - 'PWD': '/builds/slave/test', 16:38:38 INFO - 'SHELL': '/bin/bash', 16:38:38 INFO - 'SHLVL': '1', 16:38:38 INFO - 'TERM': 'linux', 16:38:38 INFO - 'TMOUT': '86400', 16:38:38 INFO - 'USER': 'cltbld', 16:38:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:38 INFO - '_': '/tools/buildbot/bin/python'} 16:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:38 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 16:38:38 INFO - Cleaning up... 16:38:38 INFO - Return code: 0 16:38:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:38:38 INFO - Using env: {'DISPLAY': ':0', 16:38:38 INFO - 'HOME': '/home/cltbld', 16:38:38 INFO - 'LANG': 'en_US.UTF-8', 16:38:38 INFO - 'LANGUAGE': 'en_US:en', 16:38:38 INFO - 'LOGNAME': 'cltbld', 16:38:38 INFO - 'MAIL': '/var/mail/cltbld', 16:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:38 INFO - 'MOZ_NO_REMOTE': '1', 16:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:38 INFO - 'NO_EM_RESTART': '1', 16:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:38 INFO - 'PWD': '/builds/slave/test', 16:38:38 INFO - 'SHELL': '/bin/bash', 16:38:38 INFO - 'SHLVL': '1', 16:38:38 INFO - 'TERM': 'linux', 16:38:38 INFO - 'TMOUT': '86400', 16:38:38 INFO - 'USER': 'cltbld', 16:38:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:38 INFO - '_': '/tools/buildbot/bin/python'} 16:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:38 INFO - Downloading/unpacking psutil>=3.1.1 16:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:40 INFO - Installing collected packages: psutil 16:38:40 INFO - Running setup.py install for psutil 16:38:40 INFO - building 'psutil._psutil_linux' extension 16:38:40 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 16:38:40 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 16:38:40 INFO - building 'psutil._psutil_posix' extension 16:38:40 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 16:38:40 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 16:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:40 INFO - Successfully installed psutil 16:38:40 INFO - Cleaning up... 16:38:40 INFO - Return code: 0 16:38:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:40 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 16:38:40 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 16:38:40 INFO - Using env: {'DISPLAY': ':0', 16:38:40 INFO - 'HOME': '/home/cltbld', 16:38:40 INFO - 'LANG': 'en_US.UTF-8', 16:38:40 INFO - 'LANGUAGE': 'en_US:en', 16:38:40 INFO - 'LOGNAME': 'cltbld', 16:38:40 INFO - 'MAIL': '/var/mail/cltbld', 16:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:40 INFO - 'MOZ_NO_REMOTE': '1', 16:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:40 INFO - 'NO_EM_RESTART': '1', 16:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:40 INFO - 'PWD': '/builds/slave/test', 16:38:40 INFO - 'SHELL': '/bin/bash', 16:38:40 INFO - 'SHLVL': '1', 16:38:40 INFO - 'TERM': 'linux', 16:38:40 INFO - 'TMOUT': '86400', 16:38:40 INFO - 'USER': 'cltbld', 16:38:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:40 INFO - '_': '/tools/buildbot/bin/python'} 16:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:38:43 INFO - Installing collected packages: mozsystemmonitor 16:38:43 INFO - Running setup.py install for mozsystemmonitor 16:38:43 INFO - Successfully installed mozsystemmonitor 16:38:43 INFO - Cleaning up... 16:38:43 INFO - Return code: 0 16:38:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:43 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 16:38:43 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 16:38:43 INFO - Using env: {'DISPLAY': ':0', 16:38:43 INFO - 'HOME': '/home/cltbld', 16:38:43 INFO - 'LANG': 'en_US.UTF-8', 16:38:43 INFO - 'LANGUAGE': 'en_US:en', 16:38:43 INFO - 'LOGNAME': 'cltbld', 16:38:43 INFO - 'MAIL': '/var/mail/cltbld', 16:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:43 INFO - 'MOZ_NO_REMOTE': '1', 16:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:43 INFO - 'NO_EM_RESTART': '1', 16:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:43 INFO - 'PWD': '/builds/slave/test', 16:38:43 INFO - 'SHELL': '/bin/bash', 16:38:43 INFO - 'SHLVL': '1', 16:38:43 INFO - 'TERM': 'linux', 16:38:43 INFO - 'TMOUT': '86400', 16:38:43 INFO - 'USER': 'cltbld', 16:38:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:43 INFO - '_': '/tools/buildbot/bin/python'} 16:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:43 INFO - Downloading/unpacking jsonschema==2.5.1 16:38:43 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 16:38:43 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 16:38:43 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 16:38:43 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 16:38:43 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 16:38:43 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 16:38:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:45 INFO - warning: no files found matching '*.txt' 16:38:45 INFO - no previously-included directories found matching 'build' 16:38:45 INFO - no previously-included directories found matching 'dist' 16:38:45 INFO - no previously-included directories found matching '.git*' 16:38:45 INFO - Installing collected packages: jsonschema, functools32 16:38:45 INFO - Running setup.py install for functools32 16:38:45 INFO - warning: no files found matching '*.txt' 16:38:45 INFO - no previously-included directories found matching 'build' 16:38:45 INFO - no previously-included directories found matching 'dist' 16:38:45 INFO - no previously-included directories found matching '.git*' 16:38:45 INFO - Successfully installed jsonschema functools32 16:38:45 INFO - Cleaning up... 16:38:45 INFO - Return code: 0 16:38:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:45 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:45 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 16:38:45 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 16:38:45 INFO - Using env: {'DISPLAY': ':0', 16:38:45 INFO - 'HOME': '/home/cltbld', 16:38:45 INFO - 'LANG': 'en_US.UTF-8', 16:38:45 INFO - 'LANGUAGE': 'en_US:en', 16:38:45 INFO - 'LOGNAME': 'cltbld', 16:38:45 INFO - 'MAIL': '/var/mail/cltbld', 16:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:45 INFO - 'MOZ_NO_REMOTE': '1', 16:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:45 INFO - 'NO_EM_RESTART': '1', 16:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:45 INFO - 'PWD': '/builds/slave/test', 16:38:45 INFO - 'SHELL': '/bin/bash', 16:38:45 INFO - 'SHLVL': '1', 16:38:45 INFO - 'TERM': 'linux', 16:38:45 INFO - 'TMOUT': '86400', 16:38:45 INFO - 'USER': 'cltbld', 16:38:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:45 INFO - '_': '/tools/buildbot/bin/python'} 16:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:46 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:46 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 16:38:46 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 16:38:46 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 16:38:46 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 16:38:46 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 16:38:46 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 16:38:48 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 INFO - Downloading docopt-0.6.1.tar.gz 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:48 INFO - Running setup.py install for blobuploader 16:38:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:48 INFO - Running setup.py install for requests 16:38:49 INFO - Running setup.py install for docopt 16:38:49 INFO - Successfully installed blobuploader requests docopt 16:38:49 INFO - Cleaning up... 16:38:49 INFO - Return code: 0 16:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:49 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')]} 16:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:49 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')]} 16:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:49 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:49 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 16:38:49 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 16:38:49 INFO - Using env: {'DISPLAY': ':0', 16:38:49 INFO - 'HOME': '/home/cltbld', 16:38:49 INFO - 'LANG': 'en_US.UTF-8', 16:38:49 INFO - 'LANGUAGE': 'en_US:en', 16:38:49 INFO - 'LOGNAME': 'cltbld', 16:38:49 INFO - 'MAIL': '/var/mail/cltbld', 16:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:49 INFO - 'MOZ_NO_REMOTE': '1', 16:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:49 INFO - 'NO_EM_RESTART': '1', 16:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:49 INFO - 'PWD': '/builds/slave/test', 16:38:49 INFO - 'SHELL': '/bin/bash', 16:38:49 INFO - 'SHLVL': '1', 16:38:49 INFO - 'TERM': 'linux', 16:38:49 INFO - 'TMOUT': '86400', 16:38:49 INFO - 'USER': 'cltbld', 16:38:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:49 INFO - '_': '/tools/buildbot/bin/python'} 16:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:49 INFO - Running setup.py (path:/tmp/pip-fm7Tzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:49 INFO - Running setup.py (path:/tmp/pip-bYCls5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:49 INFO - Running setup.py (path:/tmp/pip-MGCmDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:49 INFO - Running setup.py (path:/tmp/pip-vNdLc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:49 INFO - Running setup.py (path:/tmp/pip-zSCfrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:49 INFO - Running setup.py (path:/tmp/pip-v6Hor0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Running setup.py (path:/tmp/pip-E8loa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Running setup.py (path:/tmp/pip-H6m5Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Running setup.py (path:/tmp/pip-bQiK8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Running setup.py (path:/tmp/pip-M_5ulf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Running setup.py (path:/tmp/pip-XaDIKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:50 INFO - Running setup.py (path:/tmp/pip-AOc_3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:50 INFO - Running setup.py (path:/tmp/pip-zisrYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:50 INFO - Running setup.py (path:/tmp/pip-fWHxnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:50 INFO - Running setup.py (path:/tmp/pip-07BqJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:50 INFO - Running setup.py (path:/tmp/pip-bAJ9gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:50 INFO - Running setup.py (path:/tmp/pip-ZWyJSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:50 INFO - Running setup.py install for manifestparser 16:38:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:50 INFO - Running setup.py install for mozcrash 16:38:51 INFO - Running setup.py install for mozdebug 16:38:51 INFO - Running setup.py install for mozdevice 16:38:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozfile 16:38:51 INFO - Running setup.py install for mozhttpd 16:38:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozinfo 16:38:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozInstall 16:38:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozleak 16:38:51 INFO - Running setup.py install for mozlog 16:38:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for moznetwork 16:38:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozprocess 16:38:52 INFO - Running setup.py install for mozprofile 16:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozrunner 16:38:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozscreenshot 16:38:52 INFO - Running setup.py install for moztest 16:38:52 INFO - Running setup.py install for mozversion 16:38:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:52 INFO - Cleaning up... 16:38:52 INFO - Return code: 0 16:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:52 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')]} 16:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:52 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')]} 16:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:52 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:52 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 16:38:52 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 16:38:52 INFO - Using env: {'DISPLAY': ':0', 16:38:52 INFO - 'HOME': '/home/cltbld', 16:38:52 INFO - 'LANG': 'en_US.UTF-8', 16:38:52 INFO - 'LANGUAGE': 'en_US:en', 16:38:52 INFO - 'LOGNAME': 'cltbld', 16:38:52 INFO - 'MAIL': '/var/mail/cltbld', 16:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:52 INFO - 'MOZ_NO_REMOTE': '1', 16:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:52 INFO - 'NO_EM_RESTART': '1', 16:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:52 INFO - 'PWD': '/builds/slave/test', 16:38:52 INFO - 'SHELL': '/bin/bash', 16:38:52 INFO - 'SHLVL': '1', 16:38:52 INFO - 'TERM': 'linux', 16:38:52 INFO - 'TMOUT': '86400', 16:38:52 INFO - 'USER': 'cltbld', 16:38:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:52 INFO - '_': '/tools/buildbot/bin/python'} 16:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:52 INFO - Running setup.py (path:/tmp/pip-xYP9NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:52 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)) 16:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:52 INFO - Running setup.py (path:/tmp/pip-_I8HBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:52 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)) 16:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:52 INFO - Running setup.py (path:/tmp/pip-byuuhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:53 INFO - Running setup.py (path:/tmp/pip-pf3Cub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:53 INFO - Running setup.py (path:/tmp/pip-irz1Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:53 INFO - Running setup.py (path:/tmp/pip-pMTGQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:53 INFO - Running setup.py (path:/tmp/pip-GZLPhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:53 INFO - Running setup.py (path:/tmp/pip-DHGyfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:53 INFO - Running setup.py (path:/tmp/pip-Gg2qwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:53 INFO - Running setup.py (path:/tmp/pip-fXgmHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:53 INFO - Running setup.py (path:/tmp/pip-gmZZEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:53 INFO - Running setup.py (path:/tmp/pip-gEYrbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:53 INFO - Running setup.py (path:/tmp/pip-FEy4rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:53 INFO - Running setup.py (path:/tmp/pip-jYxGB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:53 INFO - Running setup.py (path:/tmp/pip-9VC6nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:53 INFO - Running setup.py (path:/tmp/pip-cGcqbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:54 INFO - Running setup.py (path:/tmp/pip-4k2nTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:54 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 16:38:54 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 16:38:54 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 16:38:54 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 16:38:54 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 16:38:54 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 16:38:55 INFO - Downloading blessings-1.6.tar.gz 16:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:56 INFO - Installing collected packages: blessings 16:38:56 INFO - Running setup.py install for blessings 16:38:56 INFO - Successfully installed blessings 16:38:56 INFO - Cleaning up... 16:38:56 INFO - Return code: 0 16:38:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:56 INFO - Reading from file tmpfile_stdout 16:38:56 INFO - Current package versions: 16:38:56 INFO - argparse == 1.2.1 16:38:56 INFO - blessings == 1.6 16:38:56 INFO - blobuploader == 1.2.4 16:38:56 INFO - docopt == 0.6.1 16:38:56 INFO - functools32 == 3.2.3-2 16:38:56 INFO - jsonschema == 2.5.1 16:38:56 INFO - manifestparser == 1.1 16:38:56 INFO - mozInstall == 1.12 16:38:56 INFO - mozcrash == 0.17 16:38:56 INFO - mozdebug == 0.1 16:38:56 INFO - mozdevice == 0.48 16:38:56 INFO - mozfile == 1.2 16:38:56 INFO - mozhttpd == 0.7 16:38:56 INFO - mozinfo == 0.9 16:38:56 INFO - mozleak == 0.1 16:38:56 INFO - mozlog == 3.2 16:38:56 INFO - moznetwork == 0.27 16:38:56 INFO - mozprocess == 0.22 16:38:56 INFO - mozprofile == 0.28 16:38:56 INFO - mozrunner == 6.11 16:38:56 INFO - mozscreenshot == 0.1 16:38:56 INFO - mozsystemmonitor == 0.3 16:38:56 INFO - moztest == 0.7 16:38:56 INFO - mozversion == 1.4 16:38:56 INFO - psutil == 3.1.1 16:38:56 INFO - requests == 1.2.3 16:38:56 INFO - wsgiref == 0.1.2 16:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:56 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 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38:56 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 16:38:56 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 16:38:56 INFO - Using env: {'DISPLAY': ':0', 16:38:56 INFO - 'HOME': '/home/cltbld', 16:38:56 INFO - 'LANG': 'en_US.UTF-8', 16:38:56 INFO - 'LANGUAGE': 'en_US:en', 16:38:56 INFO - 'LOGNAME': 'cltbld', 16:38:56 INFO - 'MAIL': '/var/mail/cltbld', 16:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:56 INFO - 'MOZ_NO_REMOTE': '1', 16:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:56 INFO - 'NO_EM_RESTART': '1', 16:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:56 INFO - 'PWD': '/builds/slave/test', 16:38:56 INFO - 'SHELL': '/bin/bash', 16:38:56 INFO - 'SHLVL': '1', 16:38:56 INFO - 'TERM': 'linux', 16:38:56 INFO - 'TMOUT': '86400', 16:38:56 INFO - 'USER': 'cltbld', 16:38:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:56 INFO - '_': '/tools/buildbot/bin/python'} 16:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 INFO - Cleaning up... 16:38:56 INFO - Return code: 0 16:38:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38: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'] in /builds/slave/test/build 16:38: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 16:38:56 INFO - Using env: {'DISPLAY': ':0', 16:38:56 INFO - 'HOME': '/home/cltbld', 16:38:56 INFO - 'LANG': 'en_US.UTF-8', 16:38:56 INFO - 'LANGUAGE': 'en_US:en', 16:38:56 INFO - 'LOGNAME': 'cltbld', 16:38:56 INFO - 'MAIL': '/var/mail/cltbld', 16:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:56 INFO - 'MOZ_NO_REMOTE': '1', 16:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:56 INFO - 'NO_EM_RESTART': '1', 16:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:56 INFO - 'PWD': '/builds/slave/test', 16:38:56 INFO - 'SHELL': '/bin/bash', 16:38:56 INFO - 'SHLVL': '1', 16:38:56 INFO - 'TERM': 'linux', 16:38:56 INFO - 'TMOUT': '86400', 16:38:56 INFO - 'USER': 'cltbld', 16:38:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:56 INFO - '_': '/tools/buildbot/bin/python'} 16:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:56 INFO - Cleaning up... 16:38:56 INFO - Return code: 0 16:38:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc832c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, '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': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', '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 16:38: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', 'flake8'] in /builds/slave/test/build 16:38: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 flake8 16:38:56 INFO - Using env: {'DISPLAY': ':0', 16:38:56 INFO - 'HOME': '/home/cltbld', 16:38:56 INFO - 'LANG': 'en_US.UTF-8', 16:38:56 INFO - 'LANGUAGE': 'en_US:en', 16:38:56 INFO - 'LOGNAME': 'cltbld', 16:38:56 INFO - 'MAIL': '/var/mail/cltbld', 16:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:56 INFO - 'MOZ_NO_REMOTE': '1', 16:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:56 INFO - 'NO_EM_RESTART': '1', 16:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:56 INFO - 'PWD': '/builds/slave/test', 16:38:56 INFO - 'SHELL': '/bin/bash', 16:38:56 INFO - 'SHLVL': '1', 16:38:56 INFO - 'TERM': 'linux', 16:38:56 INFO - 'TMOUT': '86400', 16:38:56 INFO - 'USER': 'cltbld', 16:38:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:56 INFO - '_': '/tools/buildbot/bin/python'} 16:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:57 INFO - Downloading/unpacking flake8 16:38:57 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 16:38:57 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 16:38:57 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 16:38:57 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 16:38:57 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 16:38:57 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 16:38:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:38:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:38:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:38:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:59 INFO - no previously-included directories found matching 'docs/_build' 16:38:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:38:59 INFO - Running setup.py install for pep8 16:38:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:59 INFO - no previously-included directories found matching 'docs/_build' 16:38:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:38:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:38:59 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Running post-action listener: _resource_record_post_action 16:38:59 INFO - Running post-action listener: _start_resource_monitoring 16:39:00 INFO - Starting resource monitoring. 16:39:00 INFO - ##### 16:39:00 INFO - ##### Finished create-virtualenv step (success) 16:39:00 INFO - ##### 16:39:00 INFO - ##### 16:39:00 INFO - ##### Running install step. 16:39:00 INFO - ##### 16:39:00 INFO - Running pre-action listener: _resource_record_pre_action 16:39:00 INFO - Running main action method: install 16:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:00 INFO - Reading from file tmpfile_stdout 16:39:00 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:39:00 INFO - Reading from file tmpfile_stdout 16:39:00 INFO - Output received: 16:39:00 INFO - Usage: mozinstall [options] installer 16:39:00 INFO - Options: 16:39:00 INFO - -h, --help show this help message and exit 16:39:00 INFO - -d DEST, --destination=DEST 16:39:00 INFO - Directory to install application into. [default: 16:39:00 INFO - "/builds/slave/test"] 16:39:00 INFO - --app=APP Application being installed. [default: firefox] 16:39:00 INFO - mkdir: /builds/slave/test/build/application 16:39:00 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'] 16:39:00 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 16:39:16 INFO - Reading from file tmpfile_stdout 16:39:16 INFO - Output received: 16:39:16 INFO - /builds/slave/test/build/application/firefox/firefox 16:39:16 INFO - Running post-action listener: _resource_record_post_action 16:39:16 INFO - ##### 16:39:16 INFO - ##### Finished install step (success) 16:39:16 INFO - ##### 16:39:16 INFO - ##### 16:39:16 INFO - ##### Running run-tests step. 16:39:16 INFO - ##### 16:39:16 INFO - Running pre-action listener: _resource_record_pre_action 16:39:16 INFO - Running main action method: run_tests 16:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:16 INFO - Python 2.7.3 16:39:16 INFO - Return code: 0 16:39:16 INFO - grabbing minidump binary from tooltool 16:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:39:16 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 0x24756f0>, '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 0x24765f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2476aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:16 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 16:39:16 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 16:39:16 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 16:39:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:16 INFO - Return code: 0 16:39:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:39:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:39:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:39:17 INFO - Return code: 0 16:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 16:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 16:39:17 INFO - Using env: {'DISPLAY': ':0', 16:39:17 INFO - 'HOME': '/home/cltbld', 16:39:17 INFO - 'LANG': 'en_US.UTF-8', 16:39:17 INFO - 'LANGUAGE': 'en_US:en', 16:39:17 INFO - 'LOGNAME': 'cltbld', 16:39:17 INFO - 'MAIL': '/var/mail/cltbld', 16:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:17 INFO - 'MOZ_NO_REMOTE': '1', 16:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:17 INFO - 'NO_EM_RESTART': '1', 16:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:17 INFO - 'PWD': '/builds/slave/test', 16:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:17 INFO - 'SHELL': '/bin/bash', 16:39:17 INFO - 'SHLVL': '1', 16:39:17 INFO - 'TERM': 'linux', 16:39:17 INFO - 'TMOUT': '86400', 16:39:17 INFO - 'USER': 'cltbld', 16:39:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322', 16:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:17 INFO - '_': '/tools/buildbot/bin/python'} 16:39:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 16:39:17 INFO - mozversion application_buildid: 20160626155524 16:39:17 INFO - mozversion application_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 16:39:17 INFO - mozversion application_display_name: Nightly 16:39:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:17 INFO - mozversion application_name: Firefox 16:39:17 INFO - mozversion application_remotingname: firefox 16:39:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:39:17 INFO - mozversion application_vendor: Mozilla 16:39:17 INFO - mozversion application_version: 50.0a1 16:39:17 INFO - mozversion platform_buildid: 20160626155524 16:39:17 INFO - mozversion platform_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 16:39:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:39:17 INFO - mozversion platform_version: 50.0a1 16:39:17 INFO - using testdate: 1466984357 16:39:17 INFO - actual date: 1466984357 16:39:17 INFO - starting webserver on 'localhost:58438' 16:39:17 INFO - SUITE-START | Running 2 tests 16:39:17 INFO - TEST-START | dromaeo_css 16:39:17 INFO - operating with platform_type : linux_ 16:39:17 INFO - Initialising browser for dromaeo_css test... 16:39:17 INFO - TEST-INFO | started process 19104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XZSs7/profile http://localhost:58438/getInfo.html) 16:39:22 INFO - PROCESS | 19104 | __metrics Screen width/height:1600/1200 16:39:22 INFO - PROCESS | 19104 | colorDepth:24 16:39:22 INFO - PROCESS | 19104 | Browser inner width/height: 1024/697 16:39:22 INFO - PROCESS | 19104 | __metrics 16:39:23 ERROR - PROCESS | 19104 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:39:24 INFO - TEST-INFO | 19104: exit 0 16:39:24 INFO - Browser initialized. 16:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:24 INFO - TEST-INFO | started process 19222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XZSs7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:36 INFO - PROCESS | 19222 | RSS: Main: 185835520 16:39:36 INFO - PROCESS | 19222 | 16:40:26 INFO - PROCESS | 19222 | 1466984426135 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] 16:42:38 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58438/tests/dromaeo/cssquery-ext.html) 16:42:39 INFO - PROCESS | 19222 | RSS: Main: 188260352 16:42:39 INFO - PROCESS | 19222 | 16:45:41 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-ext.html (next: http://localhost:58438/tests/dromaeo/cssquery-jquery.html) 16:45:42 INFO - PROCESS | 19222 | RSS: Main: 187809792 16:45:42 INFO - PROCESS | 19222 | 16:48:44 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58438/tests/dromaeo/cssquery-mootools.html) 16:48:45 INFO - PROCESS | 19222 | RSS: Main: 188661760 16:48:45 INFO - PROCESS | 19222 | 16:51:46 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58438/tests/dromaeo/cssquery-prototype.html) 16:51:47 INFO - PROCESS | 19222 | RSS: Main: 186105856 16:51:47 INFO - PROCESS | 19222 | 16:54:50 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58438/tests/dromaeo/cssquery-yui.html) 16:54:50 INFO - PROCESS | 19222 | RSS: Main: 188268544 16:54:50 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | Cycle 1(1): loaded http://localhost:58438/tests/dromaeo/cssquery-yui.html (next: http://localhost:58438/tests/dromaeo/cssquery-dojo.html) 16:57:53 INFO - PROCESS | 19222 | RSS: Main: 189730816 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | __start_tp_report 16:57:53 INFO - PROCESS | 19222 | _x_x_mozilla_page_load 16:57:53 INFO - PROCESS | 19222 | _x_x_mozilla_page_load_details 16:57:53 INFO - PROCESS | 19222 | |i|pagename|runs| 16:57:53 INFO - PROCESS | 19222 | |0;dojo.html;2580.084070155095;2630.671166104237;2632.9078482253117;2638.6042093685955;2640.155150351888;4675.415573053364;4713.222318317477;4725.338452616632;4792.592629626477;4799.784009719562;4774.689645173062;4794.83218087367;4797.0885531748945;4813.614910807136;4816.349792777983;4376.431063961689;4390.165868484977;4500.639948804088;4521.706089104197;4528.094381123772;4195.538490766014;4591.79336929839;4593.839215627454;4682.391289132425;4695.0140470501065;4366.497852746943;4410.75740834254;4434.268345722952;4474.082813023322;4499.842505512292;4476.060027394251;4477.597016268519;4554.63562914966;4555;4582;4466.59800617946;4497.347884556721;4504.234280172379;4536.72779633223;4546.977265113686;4749.62003039756;4793.18515852306;4837.32277481153;4865.880847405081;4867.026594681078;5123.590112790967;5154.92267615986;5161.793528258865;5164.819231326923;5177.37871455424;5136.0241554104605;5207.453217412193;5208.088584497736;5208.479152084799;5278.10272253714;4910.116179087727;4926.679765815211;4934.1118598651865;4961;4976.42771081323;5420.512153906167;5438.700871452029;5441.59188060897;5441.673499590037;5484.095124304445;4998.500149984972;5144.794208231704;5148.2020286855595;5200.947990520122;5207.6875387476875;5120.078385890575;5138;5274.156135018378;5306.885554033619;5335.253064570963;5114.41184263807;5115.590752739772;5130.050940576006;5160.432352441228;5166.199239117943;5076.289319495274;5077.416097148801;5081.161608334657;5138.511841375063;5194.0650682876685;4415.558444155558;4416.757078360721;4419.889502762457;4422.137683151755;4466.620337271368;3807.4669546263544;3825.7513261637905;3834.7123965702126;3884.8251828667776;3896.902577435587;4387.056782791715;4466.240739074366;4485.551444855489;4507.3689683444345;4526.954730452653;5289.920651190235;5300.787968481295;5303.681779093266;5315.946840531623;5321.973390133025;4516.593506584423;4530.07133537624;4534.682572219913;4540.023894862555;4579.267317229227;4603.079384123122;4608.516105808909;4621.930671039937;4658.67389282747;4674.742889141062;4788.3056956741775;4826.61387089032;4858.514148585184;4869.513048695102;4912.533309335608;5172.922406163986;5215.921761173509;5223.843284701465;5226.764795584132;5264.394594621514;4748.4776674566465;4890.24201248807;4909;4945.950540494549;4957.454679985271;5207.869803254797;5208.114620514598;5211.452797456364;5233.816816411408;5277.525022747971;5052.242163675478;5309.123994541012;5310.9734451327495;5312.814051508179;5321.787128514816;5052.191649336089;5071.644984851025;5084.9745751271;5091.949080509147;5096.592272618108;5059.215821547666;5088.949110508996;5097.847064588068;5108.821191258288;5145.022445735298;4864;4944.728039957837;5001.199808030698;5040.84877453677;5046.823361182341;5090.465501122477;5111.3355263815465;5128.410232823273;5141.408737995029;5182.689038657692;5013.749312534432;5019.648624596243;5022.146235140108;5022.447530771539;5059.494050594911 16:57:53 INFO - PROCESS | 19222 | |1;ext.html;535.405276157703;590.64266118998;591.107427784046;593.5192494079798;609.6646844235671;39755.20489590206;41072.794636026854;41112.17775644489;41133.58866411335;45791;42381;42480.150396992045;42928.785356073255;43044.13911721764;43078.784606077;7962.641681124334;8110.594470276492;8139.918600813975;8146.429749917508;8147.144549822272;7994.9600251998945;8040.035195776486;8046.275835174833;8074.71738489153;8098.35213182944;7998.880016799752;8066.71766488173;8076.313513351372;8077.636506357198;8082.515049097044;7986.081600615946;8037.5981200940305;8056.113827478973;8069.475484093545;8072.152423995454;7924.286814186751;7957.36341092717;7982.720604778805;7985.402919416082;7986.440949133563;39016.80491597524;39277.80361098176;39325.803370983245;39333.40999885004;39351;3148.842557872097;3162.414953233659;3263.8531266092846;3471.548698669182;3755.962440375589;29641.851790741122;29953.700462995308;29956;30011;30913.072607821803;3490.9301813963834;3491.1097670093964;3501.3172431375892;3503.4919936609303;3549.165946002687;259599;259605;259767;260518;260820;29907.551386729217;54420.727896360266;54548.45451545513;54842.51574842484;54848;31355;33285.833570831994;33540.49689254663;33778;33797.49303760446;13163.473461061642;13255.072144949761;13339.93330033363;13353.399097040656;13354.866451335556;10535.525901334458;10596.470176491144;10637.574497020032;10649.9467502662;10678.145748340114;7931.762047138595;7952.284294413531;7992.120866704658;8056.073551541531;8079.676812927417;3109.2226943264186;3117.1895307220284;3138.419392412411;3162.256869635634;3163.604549431321;824.5094168969454;886.782738229138;931.7437704631145;989.391524212604;1044.8589440425446;28618;29419;29430.411391772046;29577.85211073974;29827.701722982925;891.1534042659499;952.4761381240429;971.5288085278635;979.7648564344506;1049.0558497352445;15039.120109986252;15562.653197652737;15600.609984750472;15658.33808252577;15795.21023948798;412211;419824;420343;420385;420890;52378;52506.21240681393;52638.73680631573;52969.735151324;53045.469545304055;1165.3823473559028;1183.2427246562206;1203.5546847666244;1210.3403645013489;1212.5574165429555;27503.31241718973;28623.284417889718;28757.71242287634;28997.855010724812;29373.26566835846;45304;45401.772991134836;45707.54292457033;45787.77106114448;45882.77058614819;338256;339061;339801;340416;342381;25906.481870362863;26188;26472.338191545365;26700.866495668175;26874;43978;44136.117277653626;44393.33409998788;44443;44569.77715111404;36714.26571468609;38495.615043849204;38530.422043668805;38551.362159460135;38680;37056.814715926244;37127.62872371242;37712.43431348477;38158;38307.61692383041;31693.841530792197;33610.15974600557;33757;37071;37477.25045499129;33330.33339333248;33560.83219583886;34436.65563344335;34932;35048.64951350454;26462.206133816017;26498.510843157237;26687.866560667073;26889.327766805985;26999.190024299303 16:57:53 INFO - PROCESS | 19222 | |2;jquery.html;361.8950504353738;361.99095022624437;371.89215127612994;382.55623476766954;387.1675896821833;15710.685786284268;16889.493315200532;17926.73109903349;18012.459626211203;18047.729284060733;15766.369345226205;16575.419860304894;17715.64568708625;17726.64546709065;17738.64522709545;4616.953830461703;4859;4892.094962431944;4907.8773030674165;4928.728919909404;3397.235621985046;4794.568488836004;5256.369235691723;5577.553795696354;5597.748101335429;5654.208410822488;5659.377468478464;5663.640726225697;5663.773449062032;5686.431356864322;5474.206240095204;5563.582731295149;5626.437356264381;5641.548676105902;5651.208830763697;5222.164453687392;5441.347038355383;5448.782048718046;5454.836354909319;5456.536194423479;12701;12744;12841.807372889321;12845.871541284561;12869.485220591165;1702.8126906040325;1802.0629272778083;1884.8115188481179;1954.8045195480481;2297.3682237384687;9192.954035229848;9445.386049906803;9541.379810312308;9648.276379271583;9689.27330450219;1656.859166970809;1742.5033865348441;1745.2757105801077;1756.0956107604593;1825.543614096476;62329;65956;66029.66985165092;66127.66936165336;66574.3342566573;10108.595656173818;10241.539130739135;10427.947860260801;10451.320664156805;10554.788904221872;14117.152970821784;14185.432582696576;14202.218877961812;14226.359813808403;14259.144451332746;6696.5687814071;6970.93029069713;7136.92863071373;7138.393236574845;7187.892181617175;6458;6544.116544266558;6593.967030164915;6668.133142691516;6686.1642294713165;4456.9331460028125;4458.726049714604;4487;4520.547945205519;4521.005378816655;1715.836995485427;1779.670760909236;1811.5923917118544;1889.23485988175;1899.211827091769;830.2320353672828;903.2006674093475;950.50098698184;967.908048735369;971.9805603887883;16745.91627041857;16860.241289142017;16978.915105424392;17320.65358692819;17558.122093895254;853.9658413663384;875.9386842920934;877.7454538183855;887.5429153985702;907.160876189522;9005.234555062762;9470.573824177929;9648.662296819719;9661.758456038655;9803.117719405287;389613;390170;397175;400363;403198;73803.63098184475;76383;77252.61373693096;77712.61143694245;77924;897.0760117079288;931.9161275485238;962.6149540183842;966.5505539923829;975.0980343182528;14946.177960212293;15028.474003410265;15030;15351.462698805488;15434.305456254271;34194.316113678084;34564.30871382609;35505;35505.644943550236;36647.08382290464;48134.27798582954;48813;48816;49026.75486622687;49038.26442603435;7583.5070720403;7728.536287822749;7789.844203116019;7823.765287041398;7838.614422493698;8461.450005749606;10882.510287036945;11657.300561966309;11807.468663909973;11864.406779661154;9778.16885564735;10088.243381746544;10432.217583681102;10524.105451036441;10536.894631053592;10385.532651030873;10511;10560.207984401048;10611.257211995086;10648.414337211529;9949.950250248703;10076.193904487476;10349.689509314732;10413.635522756667;10717.678469645924;7617;7640.312371886557;7724.0731112266885;7841.764747057598;7878.448508604342;9170.541472926461;9490.85763713531;10239.948800256248;10425.635102771366;10477.738056548647 16:57:53 INFO - PROCESS | 19222 | |3;mootools.html;1399.0836002418419;1417.7164567086581;1537.953861384159;1723.5346456456764;1732.4889157698478;6788.796336109912;7498.7750367488925;7536.736214232496;8082.43422960393;8146.674133034679;7853.6858525659045;7939.325157361617;7946.562939038351;7965.482243654158;7979.680812767497;2217.268301460518;2243.1924507177405;2246.359787460574;2252.256755270765;2264.1396269417683;2192.550527141932;2209.712737344143;2227.6435770276757;2247.71903512061;2252.9436764080947;2098.27609474731;2102.3692892132376;2132.9466763330965;2134.551744133726;2203.0526873444414;2142.4322554522987;2150.8385471845186;2151.494398816269;2152.547964927367;2157.029336798439;2159.276642324823;2194.484296190394;2199.4941163532476;2201.1305534314015;2206.6800313954545;7961.283484486424;7975.202479752036;8062.234087761653;8062.798430039237;8070.838583228303;4642.234031384851;4744.5967092797155;4753.762311884392;4768.570828625406;4782.234842425195;3003.3692924485886;3005.9699403005907;3066.892658756955;3118.8752449901976;3140.7487401008093;889.9911000890038;918.5131880103489;933.1275257634134;935.4200395754608;943.3585162089777;10660.307080039773;10710.089642380484;10720.678379648545;10757;10797.136229101652;4143.357779544175;4287.078278170208;4345.130973805189;4381.364702118175;4382.780860957003;9177.403468774508;9268;9307.06929307064;9309.022552632012;9309.30180236485;4728.645351598644;4747.192977193886;4768.666193366431;4772.832950846704;4777.808887644455;3732.0856390184576;4028.7582745035393;4176.812043458051;4246.235677578004;4345.521992580813;3662;3684.907877303035;3711.7216208783907;3768.057985503624;3819.2743378757946;1166.0671462829703;1166.562539047857;1169.3626973299401;1185.0920018769773;1185.1170877696172;732.7325526182905;789.2541548236976;804.8189157439647;814.368864130292;824.8597738384489;4864.73243971585;4975.626827987915;5028.220625803006;5179.45615710345;5196;865.5888452984782;894.2354287084579;895.9104089590988;897.9146981036791;909.349814882349;3382.424987752088;3405.11467018572;3488.686018258318;3536.133647256387;3563.572371315459;9409.623615055458;9592.328537002342;9625.229981601455;9794.902050979541;9807.411555306704;9703.466309352913;9706.514674266258;9712.562934667956;9728.464934428674;9731.464769437749;7339.926600734031;7436.107667079985;7445.851082978418;7536.886946695804;7550.395968322521;5110.821121260738;5134.537891589625;5180.61145414103;5213.661112027858;5235.921461178009;8951.462912225288;9037.864432033657;9179.036201198778;9206.907930920604;9208.217301529445;9122.726318210463;9159.816803664022;9185.448873067637;9382.718518444457;9385.15533601979;5970.791022314198;6432.517561182836;6606.339366063356;6815.148106486689;6835.316468353125;7358.484906056525;7427.665755040928;7428.777136685908;7456.96271518639;7458;6431.807045788634;6615.272320044887;6751.358620931003;6763.695633696397;6853.554518956252;6475.773347932988;6538.8365290868105;6564.803055908139;6574.967125164344;6618.271990080991;6091.604045737013;6123;6128.080787881853;6131.693415329305;6163.19878415803;4370.54109318517;4384.386185934036;4413.808271766541;4522.412086428743;4562.977185114053;4449.110177964485;4463.509014008521;4469.396631454712;4490.57339552742;4551.704139230939 16:57:53 INFO - PROCESS | 19222 | |4;prototype.html;311.34151270063813;311.66496016781963;312.3082372544813;313.15292134775433;315.28745036218146;5070.822521211759;5146.382434107908;5158;5162.767675454599;5166.767495462704;5060.266261392096;5072.365954255718;5076.340075790142;5087.949120508793;5126.436092029874;3801.600831912651;3900.648941595256;3994.1227623017135;3997.860074897379;4038.535568409641;4014.7591144531275;4015.698822588303;4018.537868145157;4022.095028618552;4024.134811015631;4018.7789671568053;4024.5975402459667;4029.1941611677635;4050.3721923101966;4060.1067765091634;3723.808381317979;3953.525576930758;3981.402789581586;4035.757854528723;4054.2499637567;3448.379291727488;3461.7403694723;3466.046837119787;3467.734276988906;3471.94792078119;4993.901341704855;5013.420772456701;5019.498050194988;5020.2720605511995;5021.372328458942;4278.379634952946;4496.662750293741;4538.341940418621;4538.568835960578;4551.4083169188125;5345.305110335631;5346.97326513365;5347.144456886918;5355.0896347621;5357.330333708286;3797.8290976906105;3799;3812.504374431334;3814.256220037094;3820.4269359596005;5289.598256462079;5585.01731885183;5594.720263986785;5612.270404847343;5622.409646987048;3834.789086600208;3850.306944749916;3853.807309634507;3881.941770873439;3891.2412079644764;3908.8241029153755;3914.236723838824;3923.7449565778134;3925.7448265862627;3953.3872249801325;4482.260427029569;4509.391232183679;4526.207913615104;4532.410786597721;4564.794584243717;5102.464241254689;5372.409035006146;5393.460653934653;5402.729863506809;5424.213489044067;1362.1214316765631;1367.1865240182274;1381.675306303018;1386.577093986344;1387.6461502316845;859.5916939453709;866.6533386645392;880.4585180114311;884.6815146547237;890.617034675083;4524.524924882906;4594.563516465931;4639.561735861894;4642.419697537808;4653.557911998355;5388.380336261302;5411.133159060118;5419.972900135474;5421.241026256327;5427.810026649048;4502.932456013163;4567.833017228897;4570.925832429443;4627.768611569408;4678.134545109166;2890.7976441649303;2938.23605862473;2951.719586639266;2954.5863579098946;2963.851807409664;5051.924221136685;5061.645684802103;5072.746362681851;5092.592592592658;5099.413567439718;5350.3312085989255;5560;5580.720963951786;5612.242347283146;5645.350784659817;5071.594272458195;5078.847634570969;5079.136546787129;5087.26234695967;5100.566451851634;5398.784048638167;5410.97294513525;5444.972775136099;5445.754941027584;5449.5640348772795;5150.356205474316;5307.389650190277;5327.360716713864;5405.162199859028;5541.972290138524;5205.349331333583;5216.530512253764;5257.132573125392;5266.60434984737;5273.235380869675;3922.6665733411837;3940.862069827542;3941.2511622791576;3943.5662077170914;3944.921101577895;5497.780088796403;5517.475839795213;5597.720113994365;5598.244237027949;5606.579506536945;5381.73091345439;5389.892202156013;5394.946050539601;5415.025295446857;5452.727363631882;5117.718525481134;5359.196120581944;5382.327209098863;5389.164679474688;5425.294711687456;5262.8947421052135;5275.762590683506;5285.339332583427;5294.682319060868;5327.280817089643;5166.586673066071;5171.224316352577;5349.705766182898;5382.650127741685;5410.83767486976;5233.947660523346;5261.447548007404;5264.789408423773;5270.49930256625;5274.551663108678 16:57:53 INFO - PROCESS | 19222 | |5;yui.html;633.4362417448472;683.1358331710387;692.6917521702844;723.3453724379436;745.690538426553;12396.752064958706;12915.418806153722;13209.405576749044;13249.403776830042;13292.867071329283;12470.937645311784;12969.481220751182;12977.675558111052;13022.60932172034;13060.869391306107;622.5455417545195;774.7830607429901;788.940829437793;802.9718959836407;807.5477732469807;794.8648729715962;809.9392545559077;811.8416908702806;811.9728543392613;812.0215140755375;841.3479553346175;842.09054221441;842.9957850210741;844.1727107434717;845.6870957745642;838.0571856661256;838.4340570115148;839.7396806989852;840.0591337701752;841.0412130171609;613.0926229180837;614.5790133758389;614.9446549810493;617.200725061047;617.2253821454046;13280.136791108547;13371.531996380178;13380.330983450789;13406.731865362639;13459.125156864773;13976.790348144787;14244.430222791076;14327;14397.856021439757;14595.70808583833;10893.183011274106;10896.128309735202;10945.945270273598;11017.283876548;11123.610673626465;3388.423967925459;3391.0844072100394;3404.914877128067;3427.3145370925913;3477.8608855645743;63702.36297637011;63774.36225637731;63845.3615463844;63868;64152.67923660399;9328.300377471716;9336.439813611069;9388.108129727665;9398.765030874283;9684.370515916444;16003.599910002344;16095.275712592727;16150;16231.59421014484;17555.38556150554;6569.671516424255;6625.569337993015;6639.070530125786;6651;6903.551269167488;3482.1120614243714;3601.5678118625933;3673.1551743099235;3753.211825516672;3812.6377994090517;2929.8095623784384;3054.9541756873664;3065.065155127663;3068.7851850370707;3246.6753324667343;566.8497848070265;572.7136431784108;578.8032069096528;580.0342429854245;585.7276366489602;529.9470052994669;571.2145799525653;586.7330364684059;589.628534023571;601.3054921565599;7857.4499785014505;7909.7231596893835;7947.3244774194845;8139.674413023531;8157.1842815717955;468.3045677169401;504.9975798040886;563.2115038945509;592.8162269696321;594.6016169166583;3867.8839634811;3975.5030621172355;3999.140184860269;4006.399040144002;4131.814068366931;105685;106230;108542.45728771306;108546;109174.45412772885;90778;91921;93630;95367;95751;47234.29148562774;48344.79138021648;49678.25482617764;55970.440295597335;78265;7543.547387156788;7666.731664391719;7672.117706463828;7764.805879853049;7800.180980997141;42433.57566424296;43662.781686091366;43970.560294396644;44113.558864412225;44979;63197.68401157965;63677;64346;64354.356456434834;65125;9493.76265593338;9882.950585247028;10592.205584581034;10747.623833165802;11163.72090697739;11776.941115294369;11850.170488066098;11917.76164476723;12047.75904481923;12370.690732731393;11272.844816868293;11416.372099534605;12087.81868271959;12495.875041249472;12590.622281331574;12465.93767031159;12708.872911271139;12745.10784245094;12747.426365813375;13329.133606315558;11776.411179441166;12084.75830483403;12218.38908054576;12304.569340073054;12588.433520491782;10242.180625549789;10321.174306055347;10810.621628243289;11188.608398706006;11229.3262404256;10092.747681308027;10193.643222487177;10229.641962531276;10278.383297002203;10614.460903169153 16:57:53 INFO - PROCESS | 19222 | __end_tp_report 16:57:53 INFO - PROCESS | 19222 | __start_cc_report 16:57:53 INFO - PROCESS | 19222 | _x_x_mozilla_cycle_collect,386 16:57:53 INFO - PROCESS | 19222 | __end_cc_report 16:57:53 INFO - PROCESS | 19222 | __startTimestamp1466985473734__endTimestamp 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | ------- Summary: start ------- 16:57:53 INFO - PROCESS | 19222 | Number of tests: 6 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#0] dojo.html Cycles:165 Average:4813.86 Median:4944.73 stddev:523.37 (10.6%) stddev-sans-first:494.77 16:57:53 INFO - PROCESS | 19222 | Values: 2580.1 2630.7 2632.9 2638.6 2640.2 4675.4 4713.2 4725.3 4792.6 4799.8 4774.7 4794.8 4797.1 4813.6 4816.3 4376.4 4390.2 4500.6 4521.7 4528.1 4195.5 4591.8 4593.8 4682.4 4695.0 4366.5 4410.8 4434.3 4474.1 4499.8 4476.1 4477.6 4554.6 4555.0 4582.0 4466.6 4497.3 4504.2 4536.7 4547.0 4749.6 4793.2 4837.3 4865.9 4867.0 5123.6 5154.9 5161.8 5164.8 5177.4 5136.0 5207.5 5208.1 5208.5 5278.1 4910.1 4926.7 4934.1 4961.0 4976.4 5420.5 5438.7 5441.6 5441.7 5484.1 4998.5 5144.8 5148.2 5200.9 5207.7 5120.1 5138.0 5274.2 5306.9 5335.3 5114.4 5115.6 5130.1 5160.4 5166.2 5076.3 5077.4 5081.2 5138.5 5194.1 4415.6 4416.8 4419.9 4422.1 4466.6 3807.5 3825.8 3834.7 3884.8 3896.9 4387.1 4466.2 4485.6 4507.4 4527.0 5289.9 5300.8 5303.7 5315.9 5322.0 4516.6 4530.1 4534.7 4540.0 4579.3 4603.1 4608.5 4621.9 4658.7 4674.7 4788.3 4826.6 4858.5 4869.5 4912.5 5172.9 5215.9 5223.8 5226.8 5264.4 4748.5 4890.2 4909.0 4946.0 4957.5 5207.9 5208.1 5211.5 5233.8 5277.5 5052.2 5309.1 5311.0 5312.8 5321.8 5052.2 5071.6 5085.0 5091.9 5096.6 5059.2 5088.9 5097.8 5108.8 5145.0 4864.0 4944.7 5001.2 5040.8 5046.8 5090.5 5111.3 5128.4 5141.4 5182.7 5013.7 5019.6 5022.1 5022.4 5059.5 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#1] ext.html Cycles:180 Average:48765.33 Median:20734.20 stddev:91357.34 (440.6%) stddev-sans-first:91541.85 16:57:53 INFO - PROCESS | 19222 | Values: 535.4 590.6 591.1 593.5 609.7 39755.2 41072.8 41112.2 41133.6 45791.0 42381.0 42480.2 42928.8 43044.1 43078.8 7962.6 8110.6 8139.9 8146.4 8147.1 7995.0 8040.0 8046.3 8074.7 8098.4 7998.9 8066.7 8076.3 8077.6 8082.5 7986.1 8037.6 8056.1 8069.5 8072.2 7924.3 7957.4 7982.7 7985.4 7986.4 39016.8 39277.8 39325.8 39333.4 39351.0 3148.8 3162.4 3263.9 3471.5 3756.0 29641.9 29953.7 29956.0 30011.0 30913.1 3490.9 3491.1 3501.3 3503.5 3549.2 259599.0 259605.0 259767.0 260518.0 260820.0 29907.6 54420.7 54548.5 54842.5 54848.0 31355.0 33285.8 33540.5 33778.0 33797.5 13163.5 13255.1 13339.9 13353.4 13354.9 10535.5 10596.5 10637.6 10649.9 10678.1 7931.8 7952.3 7992.1 8056.1 8079.7 3109.2 3117.2 3138.4 3162.3 3163.6 824.5 886.8 931.7 989.4 1044.9 28618.0 29419.0 29430.4 29577.9 29827.7 891.2 952.5 971.5 979.8 1049.1 15039.1 15562.7 15600.6 15658.3 15795.2 412211.0 419824.0 420343.0 420385.0 420890.0 52378.0 52506.2 52638.7 52969.7 53045.5 1165.4 1183.2 1203.6 1210.3 1212.6 27503.3 28623.3 28757.7 28997.9 29373.3 45304.0 45401.8 45707.5 45787.8 45882.8 338256.0 339061.0 339801.0 340416.0 342381.0 25906.5 26188.0 26472.3 26700.9 26874.0 43978.0 44136.1 44393.3 44443.0 44569.8 36714.3 38495.6 38530.4 38551.4 38680.0 37056.8 37127.6 37712.4 38158.0 38307.6 31693.8 33610.2 33757.0 37071.0 37477.3 33330.3 33560.8 34436.7 34932.0 35048.6 26462.2 26498.5 26687.9 26889.3 26999.2 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#2] jquery.html Cycles:180 Average:24052.11 Median:4568.98 stddev:65283.58 (1428.8%) stddev-sans-first:65442.48 16:57:53 INFO - PROCESS | 19222 | Values: 361.9 362.0 371.9 382.6 387.2 15710.7 16889.5 17926.7 18012.5 18047.7 15766.4 16575.4 17715.6 17726.6 17738.6 4617.0 4859.0 4892.1 4907.9 4928.7 3397.2 4794.6 5256.4 5577.6 5597.7 5654.2 5659.4 5663.6 5663.8 5686.4 5474.2 5563.6 5626.4 5641.5 5651.2 5222.2 5441.3 5448.8 5454.8 5456.5 12701.0 12744.0 12841.8 12845.9 12869.5 1702.8 1802.1 1884.8 1954.8 2297.4 9193.0 9445.4 9541.4 9648.3 9689.3 1656.9 1742.5 1745.3 1756.1 1825.5 62329.0 65956.0 66029.7 66127.7 66574.3 10108.6 10241.5 10427.9 10451.3 10554.8 14117.2 14185.4 14202.2 14226.4 14259.1 6696.6 6970.9 7136.9 7138.4 7187.9 6458.0 6544.1 6594.0 6668.1 6686.2 4456.9 4458.7 4487.0 4520.5 4521.0 1715.8 1779.7 1811.6 1889.2 1899.2 830.2 903.2 950.5 967.9 972.0 16745.9 16860.2 16978.9 17320.7 17558.1 854.0 875.9 877.7 887.5 907.2 9005.2 9470.6 9648.7 9661.8 9803.1 389613.0 390170.0 397175.0 400363.0 403198.0 73803.6 76383.0 77252.6 77712.6 77924.0 897.1 931.9 962.6 966.6 975.1 14946.2 15028.5 15030.0 15351.5 15434.3 34194.3 34564.3 35505.0 35505.6 36647.1 48134.3 48813.0 48816.0 49026.8 49038.3 7583.5 7728.5 7789.8 7823.8 7838.6 8461.5 10882.5 11657.3 11807.5 11864.4 9778.2 10088.2 10432.2 10524.1 10536.9 10385.5 10511.0 10560.2 10611.3 10648.4 9950.0 10076.2 10349.7 10413.6 10717.7 7617.0 7640.3 7724.1 7841.8 7878.4 9170.5 9490.9 10239.9 10425.6 10477.7 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#3] mootools.html Cycles:180 Average:5159.04 Median:5180.03 stddev:2903.33 (56.0%) stddev-sans-first:2897.73 16:57:53 INFO - PROCESS | 19222 | Values: 1399.1 1417.7 1538.0 1723.5 1732.5 6788.8 7498.8 7536.7 8082.4 8146.7 7853.7 7939.3 7946.6 7965.5 7979.7 2217.3 2243.2 2246.4 2252.3 2264.1 2192.6 2209.7 2227.6 2247.7 2252.9 2098.3 2102.4 2132.9 2134.6 2203.1 2142.4 2150.8 2151.5 2152.5 2157.0 2159.3 2194.5 2199.5 2201.1 2206.7 7961.3 7975.2 8062.2 8062.8 8070.8 4642.2 4744.6 4753.8 4768.6 4782.2 3003.4 3006.0 3066.9 3118.9 3140.7 890.0 918.5 933.1 935.4 943.4 10660.3 10710.1 10720.7 10757.0 10797.1 4143.4 4287.1 4345.1 4381.4 4382.8 9177.4 9268.0 9307.1 9309.0 9309.3 4728.6 4747.2 4768.7 4772.8 4777.8 3732.1 4028.8 4176.8 4246.2 4345.5 3662.0 3684.9 3711.7 3768.1 3819.3 1166.1 1166.6 1169.4 1185.1 1185.1 732.7 789.3 804.8 814.4 824.9 4864.7 4975.6 5028.2 5179.5 5196.0 865.6 894.2 895.9 897.9 909.3 3382.4 3405.1 3488.7 3536.1 3563.6 9409.6 9592.3 9625.2 9794.9 9807.4 9703.5 9706.5 9712.6 9728.5 9731.5 7339.9 7436.1 7445.9 7536.9 7550.4 5110.8 5134.5 5180.6 5213.7 5235.9 8951.5 9037.9 9179.0 9206.9 9208.2 9122.7 9159.8 9185.4 9382.7 9385.2 5970.8 6432.5 6606.3 6815.1 6835.3 7358.5 7427.7 7428.8 7457.0 7458.0 6431.8 6615.3 6751.4 6763.7 6853.6 6475.8 6538.8 6564.8 6575.0 6618.3 6091.6 6123.0 6128.1 6131.7 6163.2 4370.5 4384.4 4413.8 4522.4 4563.0 4449.1 4463.5 4469.4 4490.6 4551.7 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#4] prototype.html Cycles:180 Average:4428.45 Median:5072.56 stddev:1286.29 (25.4%) stddev-sans-first:1252.23 16:57:53 INFO - PROCESS | 19222 | Values: 311.3 311.7 312.3 313.2 315.3 5070.8 5146.4 5158.0 5162.8 5166.8 5060.3 5072.4 5076.3 5087.9 5126.4 3801.6 3900.6 3994.1 3997.9 4038.5 4014.8 4015.7 4018.5 4022.1 4024.1 4018.8 4024.6 4029.2 4050.4 4060.1 3723.8 3953.5 3981.4 4035.8 4054.2 3448.4 3461.7 3466.0 3467.7 3471.9 4993.9 5013.4 5019.5 5020.3 5021.4 4278.4 4496.7 4538.3 4538.6 4551.4 5345.3 5347.0 5347.1 5355.1 5357.3 3797.8 3799.0 3812.5 3814.3 3820.4 5289.6 5585.0 5594.7 5612.3 5622.4 3834.8 3850.3 3853.8 3881.9 3891.2 3908.8 3914.2 3923.7 3925.7 3953.4 4482.3 4509.4 4526.2 4532.4 4564.8 5102.5 5372.4 5393.5 5402.7 5424.2 1362.1 1367.2 1381.7 1386.6 1387.6 859.6 866.7 880.5 884.7 890.6 4524.5 4594.6 4639.6 4642.4 4653.6 5388.4 5411.1 5420.0 5421.2 5427.8 4502.9 4567.8 4570.9 4627.8 4678.1 2890.8 2938.2 2951.7 2954.6 2963.9 5051.9 5061.6 5072.7 5092.6 5099.4 5350.3 5560.0 5580.7 5612.2 5645.4 5071.6 5078.8 5079.1 5087.3 5100.6 5398.8 5411.0 5445.0 5445.8 5449.6 5150.4 5307.4 5327.4 5405.2 5542.0 5205.3 5216.5 5257.1 5266.6 5273.2 3922.7 3940.9 3941.3 3943.6 3944.9 5497.8 5517.5 5597.7 5598.2 5606.6 5381.7 5389.9 5394.9 5415.0 5452.7 5117.7 5359.2 5382.3 5389.2 5425.3 5262.9 5275.8 5285.3 5294.7 5327.3 5166.6 5171.2 5349.7 5382.7 5410.8 5233.9 5261.4 5264.8 5270.5 5274.6 16:57:53 INFO - PROCESS | 19222 | 16:57:53 INFO - PROCESS | 19222 | [#5] yui.html Cycles:180 Average:17845.27 Median:44042.06 stddev:26209.65 (59.5%) stddev-sans-first:26251.31 16:57:53 INFO - PROCESS | 19222 | Values: 633.4 683.1 692.7 723.3 745.7 12396.8 12915.4 13209.4 13249.4 13292.9 12470.9 12969.5 12977.7 13022.6 13060.9 622.5 774.8 788.9 803.0 807.5 794.9 809.9 811.8 812.0 812.0 841.3 842.1 843.0 844.2 845.7 838.1 838.4 839.7 840.1 841.0 613.1 614.6 614.9 617.2 617.2 13280.1 13371.5 13380.3 13406.7 13459.1 13976.8 14244.4 14327.0 14397.9 14595.7 10893.2 10896.1 10945.9 11017.3 11123.6 3388.4 3391.1 3404.9 3427.3 3477.9 63702.4 63774.4 63845.4 63868.0 64152.7 9328.3 9336.4 9388.1 9398.8 9684.4 16003.6 16095.3 16150.0 16231.6 17555.4 6569.7 6625.6 6639.1 6651.0 6903.6 3482.1 3601.6 3673.2 3753.2 3812.6 2929.8 3055.0 3065.1 3068.8 3246.7 566.8 572.7 578.8 580.0 585.7 529.9 571.2 586.7 589.6 601.3 7857.4 7909.7 7947.3 8139.7 8157.2 468.3 505.0 563.2 592.8 594.6 3867.9 3975.5 3999.1 4006.4 4131.8 105685.0 106230.0 108542.5 108546.0 109174.5 90778.0 91921.0 93630.0 95367.0 95751.0 47234.3 48344.8 49678.3 55970.4 78265.0 7543.5 7666.7 7672.1 7764.8 7800.2 42433.6 43662.8 43970.6 44113.6 44979.0 63197.7 63677.0 64346.0 64354.4 65125.0 9493.8 9883.0 10592.2 10747.6 11163.7 11776.9 11850.2 11917.8 12047.8 12370.7 11272.8 11416.4 12087.8 12495.9 12590.6 12465.9 12708.9 12745.1 12747.4 13329.1 11776.4 12084.8 12218.4 12304.6 12588.4 10242.2 10321.2 10810.6 11188.6 11229.3 10092.7 10193.6 10229.6 10278.4 10614.5 16:57:53 INFO - PROCESS | 19222 | -------- Summary: end -------- 16:57:53 INFO - PROCESS | 19222 | 16:57:54 INFO - TEST-INFO | 19222: exit 0 16:57:54 INFO - TEST-OK | dromaeo_css | took 1116894ms 16:57:54 INFO - TEST-START | kraken 16:57:54 INFO - operating with platform_type : linux_ 16:57:54 INFO - Initialising browser for kraken test... 16:57:54 INFO - TEST-INFO | started process 19460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx3aem_/profile http://localhost:58438/getInfo.html) 16:57:59 INFO - PROCESS | 19460 | __metrics Screen width/height:1600/1200 16:57:59 INFO - PROCESS | 19460 | colorDepth:24 16:57:59 INFO - PROCESS | 19460 | Browser inner width/height: 1024/697 16:57:59 INFO - PROCESS | 19460 | __metrics 16:58:00 ERROR - PROCESS | 19460 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:58:01 INFO - TEST-INFO | 19460: exit 0 16:58:01 INFO - Browser initialized. 16:58:01 INFO - Running cycle 1/1 for kraken test... 16:58:01 INFO - TEST-INFO | started process 19579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx3aem_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:13 INFO - PROCESS | 19579 | RSS: Main: 185970688 16:58:13 INFO - PROCESS | 19579 | 16:58:15 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58438/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:16 INFO - PROCESS | 19579 | RSS: Main: 190459904 16:58:16 INFO - PROCESS | 19579 | 16:58:19 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58438/tests/kraken/driver.html?testName=audio-dft) 16:58:20 INFO - PROCESS | 19579 | RSS: Main: 189898752 16:58:20 INFO - PROCESS | 19579 | 16:58:23 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58438/tests/kraken/driver.html?testName=audio-fft) 16:58:23 INFO - PROCESS | 19579 | RSS: Main: 185827328 16:58:23 INFO - PROCESS | 19579 | 16:58:26 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58438/tests/kraken/driver.html?testName=audio-oscillator) 16:58:26 INFO - PROCESS | 19579 | RSS: Main: 186068992 16:58:26 INFO - PROCESS | 19579 | 16:58:28 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:29 INFO - PROCESS | 19579 | RSS: Main: 186732544 16:58:29 INFO - PROCESS | 19579 | 16:58:32 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58438/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:33 INFO - PROCESS | 19579 | RSS: Main: 187514880 16:58:33 INFO - PROCESS | 19579 | 16:58:36 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58438/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:37 INFO - PROCESS | 19579 | RSS: Main: 184504320 16:58:37 INFO - PROCESS | 19579 | 16:58:40 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58438/tests/kraken/driver.html?testName=json-parse-financial) 16:58:41 INFO - PROCESS | 19579 | RSS: Main: 185905152 16:58:41 INFO - PROCESS | 19579 | 16:58:42 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:43 INFO - PROCESS | 19579 | RSS: Main: 186339328 16:58:43 INFO - PROCESS | 19579 | 16:58:45 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:46 INFO - PROCESS | 19579 | RSS: Main: 186384384 16:58:46 INFO - PROCESS | 19579 | 16:58:48 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:48 INFO - PROCESS | 19579 | RSS: Main: 186433536 16:58:48 INFO - PROCESS | 19579 | 16:58:51 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:52 INFO - PROCESS | 19579 | RSS: Main: 186957824 16:58:52 INFO - PROCESS | 19579 | 16:58:55 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:55 INFO - PROCESS | 19579 | RSS: Main: 186662912 16:58:55 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | Cycle 1(1): loaded http://localhost:58438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58438/tests/kraken/driver.html?testName=ai-astar) 16:58:57 INFO - PROCESS | 19579 | RSS: Main: 187629568 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | __start_tp_report 16:58:57 INFO - PROCESS | 19579 | _x_x_mozilla_page_load 16:58:57 INFO - PROCESS | 19579 | _x_x_mozilla_page_load_details 16:58:57 INFO - PROCESS | 19579 | |i|pagename|runs| 16:58:57 INFO - PROCESS | 19579 | |0;ai-astar;105;114;109;115;112;114;115;113;112;112 16:58:57 INFO - PROCESS | 19579 | |1;audio-beat-detection;166;131;156;192;132;166;158;133;193;140 16:58:57 INFO - PROCESS | 19579 | |2;audio-dft;161;166;167;167;164;164;160;168;163;161 16:58:57 INFO - PROCESS | 19579 | |3;audio-fft;76;76;76;175;76;76;75;74;166;86 16:58:57 INFO - PROCESS | 19579 | |4;audio-oscillator;89;87;146;86;86;86;139;85;86;134 16:58:57 INFO - PROCESS | 19579 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;118;118;118 16:58:57 INFO - PROCESS | 19579 | |6;imaging-darkroom;148;149;148;149;150;147;148;148;147;148 16:58:57 INFO - PROCESS | 19579 | |7;imaging-desaturate;95;95;95;95;97;96;96;96;96;99 16:58:57 INFO - PROCESS | 19579 | |8;json-parse-financial;65;65;63;63;63;64;63;64;64;64 16:58:57 INFO - PROCESS | 19579 | |9;json-stringify-tinderbox;65;65;64;66;66;65;65;65;65;66 16:58:57 INFO - PROCESS | 19579 | |10;stanford-crypto-aes;82;82;83;83;82;84;83;84;83;85 16:58:57 INFO - PROCESS | 19579 | |11;stanford-crypto-ccm;131;131;139;131;127;128;134;132;143;130 16:58:57 INFO - PROCESS | 19579 | |12;stanford-crypto-pbkdf2;166;176;170;167;169;173;169;167;170;169 16:58:57 INFO - PROCESS | 19579 | |13;stanford-crypto-sha256-iterative;67;66;69;66;66;71;66;66;68;68 16:58:57 INFO - PROCESS | 19579 | __end_tp_report 16:58:57 INFO - PROCESS | 19579 | __start_cc_report 16:58:57 INFO - PROCESS | 19579 | _x_x_mozilla_cycle_collect,1014 16:58:57 INFO - PROCESS | 19579 | __end_cc_report 16:58:57 INFO - PROCESS | 19579 | __startTimestamp1466985537803__endTimestamp 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | ------- Summary: start ------- 16:58:57 INFO - PROCESS | 19579 | Number of tests: 14 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.07 (2.7%) stddev-sans-first:1.90 16:58:57 INFO - PROCESS | 19579 | Values: 105.0 114.0 109.0 115.0 112.0 114.0 115.0 113.0 112.0 112.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:162.00 stddev:23.21 (14.3%) stddev-sans-first:24.38 16:58:57 INFO - PROCESS | 19579 | Values: 166.0 131.0 156.0 192.0 132.0 166.0 158.0 133.0 193.0 140.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#2] audio-dft Cycles:10 Average:164.10 Median:165.00 stddev:2.85 (1.7%) stddev-sans-first:2.79 16:58:57 INFO - PROCESS | 19579 | Values: 161.0 166.0 167.0 167.0 164.0 164.0 160.0 168.0 163.0 161.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:39.67 (52.2%) stddev-sans-first:41.44 16:58:57 INFO - PROCESS | 19579 | Values: 76.0 76.0 76.0 175.0 76.0 76.0 75.0 74.0 166.0 86.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.00 stddev:25.89 (30.1%) stddev-sans-first:27.01 16:58:57 INFO - PROCESS | 19579 | Values: 89.0 87.0 146.0 86.0 86.0 86.0 139.0 85.0 86.0 134.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:58:57 INFO - PROCESS | 19579 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 16:58:57 INFO - PROCESS | 19579 | Values: 148.0 149.0 148.0 149.0 150.0 147.0 148.0 148.0 147.0 148.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.27 16:58:57 INFO - PROCESS | 19579 | Values: 95.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 96.0 99.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 16:58:57 INFO - PROCESS | 19579 | Values: 65.0 65.0 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:58:57 INFO - PROCESS | 19579 | Values: 65.0 65.0 64.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 16:58:57 INFO - PROCESS | 19579 | Values: 82.0 82.0 83.0 83.0 82.0 84.0 83.0 84.0 83.0 85.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:131.50 stddev:4.93 (3.7%) stddev-sans-first:5.19 16:58:57 INFO - PROCESS | 19579 | Values: 131.0 131.0 139.0 131.0 127.0 128.0 134.0 132.0 143.0 130.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:2.99 (1.8%) stddev-sans-first:2.87 16:58:57 INFO - PROCESS | 19579 | Values: 166.0 176.0 170.0 167.0 169.0 173.0 169.0 167.0 170.0 169.0 16:58:57 INFO - PROCESS | 19579 | 16:58:57 INFO - PROCESS | 19579 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 16:58:57 INFO - PROCESS | 19579 | Values: 67.0 66.0 69.0 66.0 66.0 71.0 66.0 66.0 68.0 68.0 16:58:57 INFO - PROCESS | 19579 | -------- Summary: end -------- 16:58:57 INFO - PROCESS | 19579 | 16:58:58 INFO - TEST-INFO | 19579: exit 0 16:58:58 INFO - TEST-OK | kraken | took 64320ms 16:58:58 INFO - SUITE-END | took 1181s 16:58:58 INFO - Completed test suite (00:19:41) 16:58:58 INFO - javascript benchmark 16:58:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6454.256108163582, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.084070155095, 2630.671166104237, 2632.9078482253117, 2638.6042093685955, 2640.155150351888, 4675.415573053364, 4713.222318317477, 4725.338452616632, 4792.592629626477, 4799.784009719562, 4774.689645173062, 4794.83218087367, 4797.0885531748945, 4813.614910807136, 4816.349792777983, 4376.431063961689, 4390.165868484977, 4500.639948804088, 4521.706089104197, 4528.094381123772, 4195.538490766014, 4591.79336929839, 4593.839215627454, 4682.391289132425, 4695.0140470501065, 4366.497852746943, 4410.75740834254, 4434.268345722952, 4474.082813023322, 4499.842505512292, 4476.060027394251, 4477.597016268519, 4554.63562914966, 4555.0, 4582.0, 4466.59800617946, 4497.347884556721, 4504.234280172379, 4536.72779633223, 4546.977265113686, 4749.62003039756, 4793.18515852306, 4837.32277481153, 4865.880847405081, 4867.026594681078, 5123.590112790967, 5154.92267615986, 5161.793528258865, 5164.819231326923, 5177.37871455424, 5136.0241554104605, 5207.453217412193, 5208.088584497736, 5208.479152084799, 5278.10272253714, 4910.116179087727, 4926.679765815211, 4934.1118598651865, 4961.0, 4976.42771081323, 5420.512153906167, 5438.700871452029, 5441.59188060897, 5441.673499590037, 5484.095124304445, 4998.500149984972, 5144.794208231704, 5148.2020286855595, 5200.947990520122, 5207.6875387476875, 5120.078385890575, 5138.0, 5274.156135018378, 5306.885554033619, 5335.253064570963, 5114.41184263807, 5115.590752739772, 5130.050940576006, 5160.432352441228, 5166.199239117943, 5076.289319495274, 5077.416097148801, 5081.161608334657, 5138.511841375063, 5194.0650682876685, 4415.558444155558, 4416.757078360721, 4419.889502762457, 4422.137683151755, 4466.620337271368, 3807.4669546263544, 3825.7513261637905, 3834.7123965702126, 3884.8251828667776, 3896.902577435587, 4387.056782791715, 4466.240739074366, 4485.551444855489, 4507.3689683444345, 4526.954730452653, 5289.920651190235, 5300.787968481295, 5303.681779093266, 5315.946840531623, 5321.973390133025, 4516.593506584423, 4530.07133537624, 4534.682572219913, 4540.023894862555, 4579.267317229227, 4603.079384123122, 4608.516105808909, 4621.930671039937, 4658.67389282747, 4674.742889141062, 4788.3056956741775, 4826.61387089032, 4858.514148585184, 4869.513048695102, 4912.533309335608, 5172.922406163986, 5215.921761173509, 5223.843284701465, 5226.764795584132, 5264.394594621514, 4748.4776674566465, 4890.24201248807, 4909.0, 4945.950540494549, 4957.454679985271, 5207.869803254797, 5208.114620514598, 5211.452797456364, 5233.816816411408, 5277.525022747971, 5052.242163675478, 5309.123994541012, 5310.9734451327495, 5312.814051508179, 5321.787128514816, 5052.191649336089, 5071.644984851025, 5084.9745751271, 5091.949080509147, 5096.592272618108, 5059.215821547666, 5088.949110508996, 5097.847064588068, 5108.821191258288, 5145.022445735298, 4864.0, 4944.728039957837, 5001.199808030698, 5040.84877453677, 5046.823361182341, 5090.465501122477, 5111.3355263815465, 5128.410232823273, 5141.408737995029, 5182.689038657692, 5013.749312534432, 5019.648624596243, 5022.146235140108, 5022.447530771539, 5059.494050594911], "value": 4778.7764198295345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.405276157703, 590.64266118998, 591.107427784046, 593.5192494079798, 609.6646844235671, 39755.20489590206, 41072.794636026854, 41112.17775644489, 41133.58866411335, 45791.0, 42381.0, 42480.150396992045, 42928.785356073255, 43044.13911721764, 43078.784606077, 7962.641681124334, 8110.594470276492, 8139.918600813975, 8146.429749917508, 8147.144549822272, 7994.9600251998945, 8040.035195776486, 8046.275835174833, 8074.71738489153, 8098.35213182944, 7998.880016799752, 8066.71766488173, 8076.313513351372, 8077.636506357198, 8082.515049097044, 7986.081600615946, 8037.5981200940305, 8056.113827478973, 8069.475484093545, 8072.152423995454, 7924.286814186751, 7957.36341092717, 7982.720604778805, 7985.402919416082, 7986.440949133563, 39016.80491597524, 39277.80361098176, 39325.803370983245, 39333.40999885004, 39351.0, 3148.842557872097, 3162.414953233659, 3263.8531266092846, 3471.548698669182, 3755.962440375589, 29641.851790741122, 29953.700462995308, 29956.0, 30011.0, 30913.072607821803, 3490.9301813963834, 3491.1097670093964, 3501.3172431375892, 3503.4919936609303, 3549.165946002687, 259599.0, 259605.0, 259767.0, 260518.0, 260820.0, 29907.551386729217, 54420.727896360266, 54548.45451545513, 54842.51574842484, 54848.0, 31355.0, 33285.833570831994, 33540.49689254663, 33778.0, 33797.49303760446, 13163.473461061642, 13255.072144949761, 13339.93330033363, 13353.399097040656, 13354.866451335556, 10535.525901334458, 10596.470176491144, 10637.574497020032, 10649.9467502662, 10678.145748340114, 7931.762047138595, 7952.284294413531, 7992.120866704658, 8056.073551541531, 8079.676812927417, 3109.2226943264186, 3117.1895307220284, 3138.419392412411, 3162.256869635634, 3163.604549431321, 824.5094168969454, 886.782738229138, 931.7437704631145, 989.391524212604, 1044.8589440425446, 28618.0, 29419.0, 29430.411391772046, 29577.85211073974, 29827.701722982925, 891.1534042659499, 952.4761381240429, 971.5288085278635, 979.7648564344506, 1049.0558497352445, 15039.120109986252, 15562.653197652737, 15600.609984750472, 15658.33808252577, 15795.21023948798, 412211.0, 419824.0, 420343.0, 420385.0, 420890.0, 52378.0, 52506.21240681393, 52638.73680631573, 52969.735151324, 53045.469545304055, 1165.3823473559028, 1183.2427246562206, 1203.5546847666244, 1210.3403645013489, 1212.5574165429555, 27503.31241718973, 28623.284417889718, 28757.71242287634, 28997.855010724812, 29373.26566835846, 45304.0, 45401.772991134836, 45707.54292457033, 45787.77106114448, 45882.77058614819, 338256.0, 339061.0, 339801.0, 340416.0, 342381.0, 25906.481870362863, 26188.0, 26472.338191545365, 26700.866495668175, 26874.0, 43978.0, 44136.117277653626, 44393.33409998788, 44443.0, 44569.77715111404, 36714.26571468609, 38495.615043849204, 38530.422043668805, 38551.362159460135, 38680.0, 37056.814715926244, 37127.62872371242, 37712.43431348477, 38158.0, 38307.61692383041, 31693.841530792197, 33610.15974600557, 33757.0, 37071.0, 37477.25045499129, 33330.33339333248, 33560.83219583886, 34436.65563344335, 34932.0, 35048.64951350454, 26462.206133816017, 26498.510843157237, 26687.866560667073, 26889.327766805985, 26999.190024299303], "value": 16990.833996335547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8950504353738, 361.99095022624437, 371.89215127612994, 382.55623476766954, 387.1675896821833, 15710.685786284268, 16889.493315200532, 17926.73109903349, 18012.459626211203, 18047.729284060733, 15766.369345226205, 16575.419860304894, 17715.64568708625, 17726.64546709065, 17738.64522709545, 4616.953830461703, 4859.0, 4892.094962431944, 4907.8773030674165, 4928.728919909404, 3397.235621985046, 4794.568488836004, 5256.369235691723, 5577.553795696354, 5597.748101335429, 5654.208410822488, 5659.377468478464, 5663.640726225697, 5663.773449062032, 5686.431356864322, 5474.206240095204, 5563.582731295149, 5626.437356264381, 5641.548676105902, 5651.208830763697, 5222.164453687392, 5441.347038355383, 5448.782048718046, 5454.836354909319, 5456.536194423479, 12701.0, 12744.0, 12841.807372889321, 12845.871541284561, 12869.485220591165, 1702.8126906040325, 1802.0629272778083, 1884.8115188481179, 1954.8045195480481, 2297.3682237384687, 9192.954035229848, 9445.386049906803, 9541.379810312308, 9648.276379271583, 9689.27330450219, 1656.859166970809, 1742.5033865348441, 1745.2757105801077, 1756.0956107604593, 1825.543614096476, 62329.0, 65956.0, 66029.66985165092, 66127.66936165336, 66574.3342566573, 10108.595656173818, 10241.539130739135, 10427.947860260801, 10451.320664156805, 10554.788904221872, 14117.152970821784, 14185.432582696576, 14202.218877961812, 14226.359813808403, 14259.144451332746, 6696.5687814071, 6970.93029069713, 7136.92863071373, 7138.393236574845, 7187.892181617175, 6458.0, 6544.116544266558, 6593.967030164915, 6668.133142691516, 6686.1642294713165, 4456.9331460028125, 4458.726049714604, 4487.0, 4520.547945205519, 4521.005378816655, 1715.836995485427, 1779.670760909236, 1811.5923917118544, 1889.23485988175, 1899.211827091769, 830.2320353672828, 903.2006674093475, 950.50098698184, 967.908048735369, 971.9805603887883, 16745.91627041857, 16860.241289142017, 16978.915105424392, 17320.65358692819, 17558.122093895254, 853.9658413663384, 875.9386842920934, 877.7454538183855, 887.5429153985702, 907.160876189522, 9005.234555062762, 9470.573824177929, 9648.662296819719, 9661.758456038655, 9803.117719405287, 389613.0, 390170.0, 397175.0, 400363.0, 403198.0, 73803.63098184475, 76383.0, 77252.61373693096, 77712.61143694245, 77924.0, 897.0760117079288, 931.9161275485238, 962.6149540183842, 966.5505539923829, 975.0980343182528, 14946.177960212293, 15028.474003410265, 15030.0, 15351.462698805488, 15434.305456254271, 34194.316113678084, 34564.30871382609, 35505.0, 35505.644943550236, 36647.08382290464, 48134.27798582954, 48813.0, 48816.0, 49026.75486622687, 49038.26442603435, 7583.5070720403, 7728.536287822749, 7789.844203116019, 7823.765287041398, 7838.614422493698, 8461.450005749606, 10882.510287036945, 11657.300561966309, 11807.468663909973, 11864.406779661154, 9778.16885564735, 10088.243381746544, 10432.217583681102, 10524.105451036441, 10536.894631053592, 10385.532651030873, 10511.0, 10560.207984401048, 10611.257211995086, 10648.414337211529, 9949.950250248703, 10076.193904487476, 10349.689509314732, 10413.635522756667, 10717.678469645924, 7617.0, 7640.312371886557, 7724.0731112266885, 7841.764747057598, 7878.448508604342, 9170.541472926461, 9490.85763713531, 10239.948800256248, 10425.635102771366, 10477.738056548647], "value": 8091.6428224001365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.0836002418419, 1417.7164567086581, 1537.953861384159, 1723.5346456456764, 1732.4889157698478, 6788.796336109912, 7498.7750367488925, 7536.736214232496, 8082.43422960393, 8146.674133034679, 7853.6858525659045, 7939.325157361617, 7946.562939038351, 7965.482243654158, 7979.680812767497, 2217.268301460518, 2243.1924507177405, 2246.359787460574, 2252.256755270765, 2264.1396269417683, 2192.550527141932, 2209.712737344143, 2227.6435770276757, 2247.71903512061, 2252.9436764080947, 2098.27609474731, 2102.3692892132376, 2132.9466763330965, 2134.551744133726, 2203.0526873444414, 2142.4322554522987, 2150.8385471845186, 2151.494398816269, 2152.547964927367, 2157.029336798439, 2159.276642324823, 2194.484296190394, 2199.4941163532476, 2201.1305534314015, 2206.6800313954545, 7961.283484486424, 7975.202479752036, 8062.234087761653, 8062.798430039237, 8070.838583228303, 4642.234031384851, 4744.5967092797155, 4753.762311884392, 4768.570828625406, 4782.234842425195, 3003.3692924485886, 3005.9699403005907, 3066.892658756955, 3118.8752449901976, 3140.7487401008093, 889.9911000890038, 918.5131880103489, 933.1275257634134, 935.4200395754608, 943.3585162089777, 10660.307080039773, 10710.089642380484, 10720.678379648545, 10757.0, 10797.136229101652, 4143.357779544175, 4287.078278170208, 4345.130973805189, 4381.364702118175, 4382.780860957003, 9177.403468774508, 9268.0, 9307.06929307064, 9309.022552632012, 9309.30180236485, 4728.645351598644, 4747.192977193886, 4768.666193366431, 4772.832950846704, 4777.808887644455, 3732.0856390184576, 4028.7582745035393, 4176.812043458051, 4246.235677578004, 4345.521992580813, 3662.0, 3684.907877303035, 3711.7216208783907, 3768.057985503624, 3819.2743378757946, 1166.0671462829703, 1166.562539047857, 1169.3626973299401, 1185.0920018769773, 1185.1170877696172, 732.7325526182905, 789.2541548236976, 804.8189157439647, 814.368864130292, 824.8597738384489, 4864.73243971585, 4975.626827987915, 5028.220625803006, 5179.45615710345, 5196.0, 865.5888452984782, 894.2354287084579, 895.9104089590988, 897.9146981036791, 909.349814882349, 3382.424987752088, 3405.11467018572, 3488.686018258318, 3536.133647256387, 3563.572371315459, 9409.623615055458, 9592.328537002342, 9625.229981601455, 9794.902050979541, 9807.411555306704, 9703.466309352913, 9706.514674266258, 9712.562934667956, 9728.464934428674, 9731.464769437749, 7339.926600734031, 7436.107667079985, 7445.851082978418, 7536.886946695804, 7550.395968322521, 5110.821121260738, 5134.537891589625, 5180.61145414103, 5213.661112027858, 5235.921461178009, 8951.462912225288, 9037.864432033657, 9179.036201198778, 9206.907930920604, 9208.217301529445, 9122.726318210463, 9159.816803664022, 9185.448873067637, 9382.718518444457, 9385.15533601979, 5970.791022314198, 6432.517561182836, 6606.339366063356, 6815.148106486689, 6835.316468353125, 7358.484906056525, 7427.665755040928, 7428.777136685908, 7456.96271518639, 7458.0, 6431.807045788634, 6615.272320044887, 6751.358620931003, 6763.695633696397, 6853.554518956252, 6475.773347932988, 6538.8365290868105, 6564.803055908139, 6574.967125164344, 6618.271990080991, 6091.604045737013, 6123.0, 6128.080787881853, 6131.693415329305, 6163.19878415803, 4370.54109318517, 4384.386185934036, 4413.808271766541, 4522.412086428743, 4562.977185114053, 4449.110177964485, 4463.509014008521, 4469.396631454712, 4490.57339552742, 4551.704139230939], "value": 4154.882982478143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.34151270063813, 311.66496016781963, 312.3082372544813, 313.15292134775433, 315.28745036218146, 5070.822521211759, 5146.382434107908, 5158.0, 5162.767675454599, 5166.767495462704, 5060.266261392096, 5072.365954255718, 5076.340075790142, 5087.949120508793, 5126.436092029874, 3801.600831912651, 3900.648941595256, 3994.1227623017135, 3997.860074897379, 4038.535568409641, 4014.7591144531275, 4015.698822588303, 4018.537868145157, 4022.095028618552, 4024.134811015631, 4018.7789671568053, 4024.5975402459667, 4029.1941611677635, 4050.3721923101966, 4060.1067765091634, 3723.808381317979, 3953.525576930758, 3981.402789581586, 4035.757854528723, 4054.2499637567, 3448.379291727488, 3461.7403694723, 3466.046837119787, 3467.734276988906, 3471.94792078119, 4993.901341704855, 5013.420772456701, 5019.498050194988, 5020.2720605511995, 5021.372328458942, 4278.379634952946, 4496.662750293741, 4538.341940418621, 4538.568835960578, 4551.4083169188125, 5345.305110335631, 5346.97326513365, 5347.144456886918, 5355.0896347621, 5357.330333708286, 3797.8290976906105, 3799.0, 3812.504374431334, 3814.256220037094, 3820.4269359596005, 5289.598256462079, 5585.01731885183, 5594.720263986785, 5612.270404847343, 5622.409646987048, 3834.789086600208, 3850.306944749916, 3853.807309634507, 3881.941770873439, 3891.2412079644764, 3908.8241029153755, 3914.236723838824, 3923.7449565778134, 3925.7448265862627, 3953.3872249801325, 4482.260427029569, 4509.391232183679, 4526.207913615104, 4532.410786597721, 4564.794584243717, 5102.464241254689, 5372.409035006146, 5393.460653934653, 5402.729863506809, 5424.213489044067, 1362.1214316765631, 1367.1865240182274, 1381.675306303018, 1386.577093986344, 1387.6461502316845, 859.5916939453709, 866.6533386645392, 880.4585180114311, 884.6815146547237, 890.617034675083, 4524.524924882906, 4594.563516465931, 4639.561735861894, 4642.419697537808, 4653.557911998355, 5388.380336261302, 5411.133159060118, 5419.972900135474, 5421.241026256327, 5427.810026649048, 4502.932456013163, 4567.833017228897, 4570.925832429443, 4627.768611569408, 4678.134545109166, 2890.7976441649303, 2938.23605862473, 2951.719586639266, 2954.5863579098946, 2963.851807409664, 5051.924221136685, 5061.645684802103, 5072.746362681851, 5092.592592592658, 5099.413567439718, 5350.3312085989255, 5560.0, 5580.720963951786, 5612.242347283146, 5645.350784659817, 5071.594272458195, 5078.847634570969, 5079.136546787129, 5087.26234695967, 5100.566451851634, 5398.784048638167, 5410.97294513525, 5444.972775136099, 5445.754941027584, 5449.5640348772795, 5150.356205474316, 5307.389650190277, 5327.360716713864, 5405.162199859028, 5541.972290138524, 5205.349331333583, 5216.530512253764, 5257.132573125392, 5266.60434984737, 5273.235380869675, 3922.6665733411837, 3940.862069827542, 3941.2511622791576, 3943.5662077170914, 3944.921101577895, 5497.780088796403, 5517.475839795213, 5597.720113994365, 5598.244237027949, 5606.579506536945, 5381.73091345439, 5389.892202156013, 5394.946050539601, 5415.025295446857, 5452.727363631882, 5117.718525481134, 5359.196120581944, 5382.327209098863, 5389.164679474688, 5425.294711687456, 5262.8947421052135, 5275.762590683506, 5285.339332583427, 5294.682319060868, 5327.280817089643, 5166.586673066071, 5171.224316352577, 5349.705766182898, 5382.650127741685, 5410.83767486976, 5233.947660523346, 5261.447548007404, 5264.789408423773, 5270.49930256625, 5274.551663108678], "value": 4017.087822949594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.4362417448472, 683.1358331710387, 692.6917521702844, 723.3453724379436, 745.690538426553, 12396.752064958706, 12915.418806153722, 13209.405576749044, 13249.403776830042, 13292.867071329283, 12470.937645311784, 12969.481220751182, 12977.675558111052, 13022.60932172034, 13060.869391306107, 622.5455417545195, 774.7830607429901, 788.940829437793, 802.9718959836407, 807.5477732469807, 794.8648729715962, 809.9392545559077, 811.8416908702806, 811.9728543392613, 812.0215140755375, 841.3479553346175, 842.09054221441, 842.9957850210741, 844.1727107434717, 845.6870957745642, 838.0571856661256, 838.4340570115148, 839.7396806989852, 840.0591337701752, 841.0412130171609, 613.0926229180837, 614.5790133758389, 614.9446549810493, 617.200725061047, 617.2253821454046, 13280.136791108547, 13371.531996380178, 13380.330983450789, 13406.731865362639, 13459.125156864773, 13976.790348144787, 14244.430222791076, 14327.0, 14397.856021439757, 14595.70808583833, 10893.183011274106, 10896.128309735202, 10945.945270273598, 11017.283876548, 11123.610673626465, 3388.423967925459, 3391.0844072100394, 3404.914877128067, 3427.3145370925913, 3477.8608855645743, 63702.36297637011, 63774.36225637731, 63845.3615463844, 63868.0, 64152.67923660399, 9328.300377471716, 9336.439813611069, 9388.108129727665, 9398.765030874283, 9684.370515916444, 16003.599910002344, 16095.275712592727, 16150.0, 16231.59421014484, 17555.38556150554, 6569.671516424255, 6625.569337993015, 6639.070530125786, 6651.0, 6903.551269167488, 3482.1120614243714, 3601.5678118625933, 3673.1551743099235, 3753.211825516672, 3812.6377994090517, 2929.8095623784384, 3054.9541756873664, 3065.065155127663, 3068.7851850370707, 3246.6753324667343, 566.8497848070265, 572.7136431784108, 578.8032069096528, 580.0342429854245, 585.7276366489602, 529.9470052994669, 571.2145799525653, 586.7330364684059, 589.628534023571, 601.3054921565599, 7857.4499785014505, 7909.7231596893835, 7947.3244774194845, 8139.674413023531, 8157.1842815717955, 468.3045677169401, 504.9975798040886, 563.2115038945509, 592.8162269696321, 594.6016169166583, 3867.8839634811, 3975.5030621172355, 3999.140184860269, 4006.399040144002, 4131.814068366931, 105685.0, 106230.0, 108542.45728771306, 108546.0, 109174.45412772885, 90778.0, 91921.0, 93630.0, 95367.0, 95751.0, 47234.29148562774, 48344.79138021648, 49678.25482617764, 55970.440295597335, 78265.0, 7543.547387156788, 7666.731664391719, 7672.117706463828, 7764.805879853049, 7800.180980997141, 42433.57566424296, 43662.781686091366, 43970.560294396644, 44113.558864412225, 44979.0, 63197.68401157965, 63677.0, 64346.0, 64354.356456434834, 65125.0, 9493.76265593338, 9882.950585247028, 10592.205584581034, 10747.623833165802, 11163.72090697739, 11776.941115294369, 11850.170488066098, 11917.76164476723, 12047.75904481923, 12370.690732731393, 11272.844816868293, 11416.372099534605, 12087.81868271959, 12495.875041249472, 12590.622281331574, 12465.93767031159, 12708.872911271139, 12745.10784245094, 12747.426365813375, 13329.133606315558, 11776.411179441166, 12084.75830483403, 12218.38908054576, 12304.569340073054, 12588.433520491782, 10242.180625549789, 10321.174306055347, 10810.621628243289, 11188.608398706006, 11229.3262404256, 10092.747681308027, 10193.643222487177, 10229.641962531276, 10278.383297002203, 10614.460903169153], "value": 6591.648432740503, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 109.0, 115.0, 112.0, 114.0, 115.0, 113.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 131.0, 156.0, 192.0, 132.0, 166.0, 158.0, 133.0, 193.0, 140.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 167.0, 167.0, 164.0, 164.0, 160.0, 168.0, 163.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 76.0, 76.0, 75.0, 74.0, 166.0, 86.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 146.0, 86.0, 86.0, 86.0, 139.0, 85.0, 86.0, 134.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 150.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 99.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 82.0, 84.0, 83.0, 84.0, 83.0, 85.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 139.0, 131.0, 127.0, 128.0, 134.0, 132.0, 143.0, 130.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 176.0, 170.0, 167.0, 169.0, 173.0, 169.0, 167.0, 170.0, 169.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 66.0, 66.0, 71.0, 66.0, 66.0, 68.0, 68.0], "value": 67.3, "unit": "score"}]}]} 16:58:59 INFO - Return code: 0 16:58:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:59 ERROR - # TBPL SUCCESS # 16:58:59 INFO - Running post-action listener: _resource_record_post_action 16:58:59 INFO - ##### 16:58:59 INFO - ##### Finished run-tests step (success) 16:58:59 INFO - ##### 16:58:59 INFO - Running post-run listener: _resource_record_post_run 16:58:59 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531521536; Read time: 8; Write time: 408688 16:58:59 INFO - TinderboxPrint: CPU usage
13.4% 16:58:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:58:59 INFO - TinderboxPrint: I/O write bytes / time
531,521,536 / 408,688 16:58:59 INFO - TinderboxPrint: CPU idle
8,280.1 (86.6%) 16:58:59 INFO - TinderboxPrint: CPU user
1,228.9 (12.8%) 16:58:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:58:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232005632; Read time: 0; Write time: 227692 16:58:59 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299515904; Read time: 8; Write time: 180996 16:58:59 INFO - Running post-run listener: _upload_blobber_files 16:58:59 INFO - Blob upload gear active. 16:58:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:59 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 16:58:59 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:58:59 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:59:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:59:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:59:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:04 INFO - (blobuploader) - INFO - Done attempting. 16:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:05 INFO - (blobuploader) - INFO - Done attempting. 16:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:06 INFO - (blobuploader) - INFO - Done attempting. 16:59:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:59:06 INFO - Return code: 0 16:59:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:59:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:59:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa2e96fa901681009dff6b85b34c00a2a26382fc2b4b30aee5dbed2a9ec4bff22efe75856ee46759944b173e4ab45b774c98be0d9ca6921e222a904fadaad6c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fafcebcdbcf88a711029e5744101eb7fcebdbd4a89f6dd5c6b5a05fce3919b50da45273d0892e0675c825a734d06a95d08fe95b6515eb1d1818aec4640cebcff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2fbabfcfaca09dfdc84ad9f42cee69d024b0bce6d5b693ee0aef19ce361c491ecee10732f5739940164dd033971000cb101db93e8e95df9a078515130ee8ab8"} 16:59:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:59:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:59:06 INFO - Contents: 16:59:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa2e96fa901681009dff6b85b34c00a2a26382fc2b4b30aee5dbed2a9ec4bff22efe75856ee46759944b173e4ab45b774c98be0d9ca6921e222a904fadaad6c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fafcebcdbcf88a711029e5744101eb7fcebdbd4a89f6dd5c6b5a05fce3919b50da45273d0892e0675c825a734d06a95d08fe95b6515eb1d1818aec4640cebcff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2fbabfcfaca09dfdc84ad9f42cee69d024b0bce6d5b693ee0aef19ce361c491ecee10732f5739940164dd033971000cb101db93e8e95df9a078515130ee8ab8"} 16:59:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:59:06 INFO - Copying logs to upload dir... 16:59:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:59:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.916325 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-26 16:59:05.535499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 16:59:05.538670) ========= 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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 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/Fx-Team-Non-PGO/sha512/aa2e96fa901681009dff6b85b34c00a2a26382fc2b4b30aee5dbed2a9ec4bff22efe75856ee46759944b173e4ab45b774c98be0d9ca6921e222a904fadaad6c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fafcebcdbcf88a711029e5744101eb7fcebdbd4a89f6dd5c6b5a05fce3919b50da45273d0892e0675c825a734d06a95d08fe95b6515eb1d1818aec4640cebcff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2fbabfcfaca09dfdc84ad9f42cee69d024b0bce6d5b693ee0aef19ce361c491ecee10732f5739940164dd033971000cb101db93e8e95df9a078515130ee8ab8"} build_url:https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/ZuufyDISRyqH81DE3Z9R7A/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/Fx-Team-Non-PGO/sha512/aa2e96fa901681009dff6b85b34c00a2a26382fc2b4b30aee5dbed2a9ec4bff22efe75856ee46759944b173e4ab45b774c98be0d9ca6921e222a904fadaad6c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fafcebcdbcf88a711029e5744101eb7fcebdbd4a89f6dd5c6b5a05fce3919b50da45273d0892e0675c825a734d06a95d08fe95b6515eb1d1818aec4640cebcff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2fbabfcfaca09dfdc84ad9f42cee69d024b0bce6d5b693ee0aef19ce361c491ecee10732f5739940164dd033971000cb101db93e8e95df9a078515130ee8ab8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 16:59:05.563933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:59:05.564283) ========= 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=32c5991c409366f7fec8a718000001d2-1466983664.436376-1999250322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 16:59:05.649059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 16:59:05.649391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 16:59:05.649687) ========= ========= Total master_lag: 0.17 =========