builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1465577425.55 results: success (0) buildid: 20160610092130 builduid: 55c19aa3fecb45cdaa041b6cad126cf3 revision: c2ffbe22285487d5443d840e4c5feaa391f66c8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.554292) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.555000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.555467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.598202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.598472) ========= 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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 09:50:25-- 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% 223M=0s 2016-06-10 09:50:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.721245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.721554) ========= 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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.771066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.771388) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2ffbe22285487d5443d840e4c5feaa391f66c8d --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 c2ffbe22285487d5443d840e4c5feaa391f66c8d --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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 09:50:26,027 truncating revision to first 12 chars 2016-06-10 09:50:26,027 Setting DEBUG logging. 2016-06-10 09:50:26,028 attempt 1/10 2016-06-10 09:50:26,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2ffbe222854?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 09:50:26,329 unpacking tar archive at: fx-team-c2ffbe222854/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.421841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.422278) ========= script_repo_revision: c2ffbe22285487d5443d840e4c5feaa391f66c8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.423095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.423574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.433708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-10 09:50:26.434130) ========= /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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:26 INFO - MultiFileLogger online at 20160610 09:50:26 in /builds/slave/test 09:50:26 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 09:50:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:26 INFO - {'append_to_log': False, 09:50:26 INFO - 'base_work_dir': '/builds/slave/test', 09:50:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:26 INFO - 'branch': 'Fx-Team-Non-PGO', 09:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:26 INFO - 'config_files': ('talos/linux_config.py',), 09:50:26 INFO - 'default_actions': ('clobber', 09:50:26 INFO - 'read-buildbot-config', 09:50:26 INFO - 'download-and-extract', 09:50:26 INFO - 'populate-webroot', 09:50:26 INFO - 'create-virtualenv', 09:50:26 INFO - 'install', 09:50:26 INFO - 'run-tests'), 09:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:26 INFO - 'download_minidump_stackwalk': True, 09:50:26 INFO - 'download_symbols': 'ondemand', 09:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:26 INFO - 'installer_path': 'installer.exe', 09:50:26 INFO - 'log_level': 'info', 09:50:26 INFO - 'log_name': 'talos', 09:50:26 INFO - 'log_to_console': True, 09:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:26 INFO - 'opt_config_files': (), 09:50:26 INFO - 'pip_index': False, 09:50:26 INFO - 'sps_profile': False, 09:50:26 INFO - 'sps_profile_interval': 0, 09:50:26 INFO - 'suite': 'dromaeojs-e10s', 09:50:26 INFO - 'system_bits': '32', 09:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:26 INFO - 'title': 'talos-linux64-ix-035', 09:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:26 INFO - 'use_talos_json': True, 09:50:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:26 INFO - 'work_dir': 'build'} 09:50:26 INFO - ##### 09:50:26 INFO - ##### Running clobber step. 09:50:26 INFO - ##### 09:50:26 INFO - Running pre-action listener: _resource_record_pre_action 09:50:26 INFO - Running main action method: clobber 09:50:26 INFO - rmtree: /builds/slave/test/build 09:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:27 INFO - Running post-action listener: _resource_record_post_action 09:50:27 INFO - ##### 09:50:27 INFO - ##### Finished clobber step (success) 09:50:27 INFO - ##### 09:50:27 INFO - ##### 09:50:27 INFO - ##### Running read-buildbot-config step. 09:50:27 INFO - ##### 09:50:27 INFO - Running pre-action listener: _resource_record_pre_action 09:50:27 INFO - Running main action method: read_buildbot_config 09:50:27 INFO - Using buildbot properties: 09:50:27 INFO - { 09:50:27 INFO - "project": "", 09:50:27 INFO - "product": "firefox", 09:50:27 INFO - "script_repo_revision": "production", 09:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:50:27 INFO - "repository": "", 09:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:50:27 INFO - "buildid": "20160610092130", 09:50:27 INFO - "pgo_build": "False", 09:50:27 INFO - "basedir": "/builds/slave/test", 09:50:27 INFO - "buildnumber": 1362, 09:50:27 INFO - "slavename": "talos-linux64-ix-035", 09:50:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:50:27 INFO - "platform": "ubuntu64_hw", 09:50:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:50:27 INFO - "branch": "fx-team", 09:50:27 INFO - "repo_path": "integration/fx-team", 09:50:27 INFO - "revision": "c2ffbe22285487d5443d840e4c5feaa391f66c8d", 09:50:27 INFO - "stage_platform": "linux64", 09:50:27 INFO - "builduid": "55c19aa3fecb45cdaa041b6cad126cf3", 09:50:27 INFO - "slavebuilddir": "test" 09:50:27 INFO - } 09:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:50:27 INFO - Running post-action listener: _resource_record_post_action 09:50:27 INFO - ##### 09:50:27 INFO - ##### Finished read-buildbot-config step (success) 09:50:27 INFO - ##### 09:50:27 INFO - ##### 09:50:27 INFO - ##### Running download-and-extract step. 09:50:27 INFO - ##### 09:50:27 INFO - Running pre-action listener: _resource_record_pre_action 09:50:27 INFO - Running main action method: download_and_extract 09:50:27 INFO - mkdir: /builds/slave/test/build/tests 09:50: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')]} 09:50:27 INFO - https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:33 INFO - Downloaded 1361 bytes. 09:50:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:50:33 INFO - Using the following test package requirements: 09:50:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:50:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'jsshell-linux-x86_64.zip'], 09:50:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:50:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:50:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:50:33 INFO - https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:50:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:50:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:39 INFO - Downloaded 22891347 bytes. 09:50:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:50:40 INFO - Return code: 0 09:50:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:50: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')]} 09:50:40 INFO - https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:41 INFO - Downloaded 22891347 bytes. 09:50:41 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'] 09:50:41 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 09:50:43 INFO - Return code: 0 09:50: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')]} 09:50:43 INFO - https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:44 INFO - Downloaded 10833377 bytes. 09:50:44 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'] 09:50:44 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 09:50:44 INFO - Return code: 0 09:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:44 INFO - https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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 09:50:48 INFO - Downloaded 55398373 bytes. 09:50:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:50:48 INFO - mkdir: /builds/slave/test/properties 09:50:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:48 INFO - Contents: 09:50:48 INFO - build_url:https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:50:49 INFO - Running post-action listener: _resource_record_post_action 09:50:49 INFO - Running post-action listener: set_extra_try_arguments 09:50:49 INFO - ##### 09:50:49 INFO - ##### Finished download-and-extract step (success) 09:50:49 INFO - ##### 09:50:49 INFO - ##### 09:50:49 INFO - ##### Running populate-webroot step. 09:50:49 INFO - ##### 09:50:49 INFO - Running pre-action listener: _resource_record_pre_action 09:50:49 INFO - Running main action method: populate_webroot 09:50:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:49 INFO - '--tppagecycles', 09:50:49 INFO - '7'], 09:50:49 INFO - 'tests': ['tsvgm']}}, 09:50:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['damp', 'tps']}, 09:50:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'tests': ['damp', 'tps']}, 09:50:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['dromaeo_dom']}, 09:50:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['a11yr', 09:50:49 INFO - 'ts_paint', 09:50:49 INFO - 'tpaint', 09:50:49 INFO - 'sessionrestore', 09:50:49 INFO - 'sessionrestore_no_auto_restore', 09:50:49 INFO - 'tabpaint']}, 09:50:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['tsvgx', 09:50:49 INFO - 'tsvgr_opacity', 09:50:49 INFO - 'tart', 09:50:49 INFO - 'tscrollx', 09:50:49 INFO - 'cart']}, 09:50:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:49 INFO - 'tsvgr_opacity', 09:50:49 INFO - 'tart', 09:50:49 INFO - 'tscrollx', 09:50:49 INFO - 'cart']}, 09:50:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'talos_options': ['--disable-e10s'], 09:50:49 INFO - 'tests': ['tp5o']}, 09:50:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'tests': ['tp5o']}, 09:50:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'talos_options': ['--disable-e10s', 09:50:49 INFO - '--xperf_path', 09:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:49 INFO - 'tests': ['tp5n']}, 09:50:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:49 INFO - 'talos_options': ['--xperf_path', 09:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:49 INFO - 'tests': ['tp5n']}}, 09:50:49 INFO - 'talos.zip': {'path': '', 09:50:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:49 INFO - Running post-action listener: _resource_record_post_action 09:50:49 INFO - ##### 09:50:49 INFO - ##### Finished populate-webroot step (success) 09:50:49 INFO - ##### 09:50:49 INFO - ##### 09:50:49 INFO - ##### Running create-virtualenv step. 09:50:49 INFO - ##### 09:50:49 INFO - Running pre-action listener: _resource_record_pre_action 09:50:49 INFO - Running main action method: create_virtualenv 09:50:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:50:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:49 INFO - Using real prefix '/usr' 09:50:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:51 INFO - Installing pip.................done. 09:50:51 INFO - Return code: 0 09:50:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:51 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')]} 09:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:51 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')]} 09:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:51 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:50:51 INFO - Using env: {'DISPLAY': ':0', 09:50:51 INFO - 'HOME': '/home/cltbld', 09:50:51 INFO - 'LANG': 'en_US.UTF-8', 09:50:51 INFO - 'LANGUAGE': 'en_US:en', 09:50:51 INFO - 'LOGNAME': 'cltbld', 09:50:51 INFO - 'MAIL': '/var/mail/cltbld', 09:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:51 INFO - 'MOZ_NO_REMOTE': '1', 09:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:51 INFO - 'NO_EM_RESTART': '1', 09:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:51 INFO - 'PWD': '/builds/slave/test', 09:50:51 INFO - 'SHELL': '/bin/bash', 09:50:51 INFO - 'SHLVL': '1', 09:50:51 INFO - 'TERM': 'linux', 09:50:51 INFO - 'TMOUT': '86400', 09:50:51 INFO - 'USER': 'cltbld', 09:50:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:51 INFO - '_': '/tools/buildbot/bin/python'} 09:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:50:51 INFO - Cleaning up... 09:50:51 INFO - Return code: 0 09:50:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:51 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')]} 09:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:52 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:50:52 INFO - Using env: {'DISPLAY': ':0', 09:50:52 INFO - 'HOME': '/home/cltbld', 09:50:52 INFO - 'LANG': 'en_US.UTF-8', 09:50:52 INFO - 'LANGUAGE': 'en_US:en', 09:50:52 INFO - 'LOGNAME': 'cltbld', 09:50:52 INFO - 'MAIL': '/var/mail/cltbld', 09:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:52 INFO - 'MOZ_NO_REMOTE': '1', 09:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:52 INFO - 'NO_EM_RESTART': '1', 09:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:52 INFO - 'PWD': '/builds/slave/test', 09:50:52 INFO - 'SHELL': '/bin/bash', 09:50:52 INFO - 'SHLVL': '1', 09:50:52 INFO - 'TERM': 'linux', 09:50:52 INFO - 'TMOUT': '86400', 09:50:52 INFO - 'USER': 'cltbld', 09:50:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:52 INFO - '_': '/tools/buildbot/bin/python'} 09:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:52 INFO - Downloading/unpacking psutil>=3.1.1 09:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:54 INFO - Installing collected packages: psutil 09:50:54 INFO - Running setup.py install for psutil 09:50:54 INFO - building 'psutil._psutil_linux' extension 09:50:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:50:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:50:54 INFO - building 'psutil._psutil_posix' extension 09:50:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:50:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:50:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:54 INFO - Successfully installed psutil 09:50:54 INFO - Cleaning up... 09:50:54 INFO - Return code: 0 09:50:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:50:54 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')]} 09:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:54 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')]} 09:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:54 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:50:54 INFO - Using env: {'DISPLAY': ':0', 09:50:54 INFO - 'HOME': '/home/cltbld', 09:50:54 INFO - 'LANG': 'en_US.UTF-8', 09:50:54 INFO - 'LANGUAGE': 'en_US:en', 09:50:54 INFO - 'LOGNAME': 'cltbld', 09:50:54 INFO - 'MAIL': '/var/mail/cltbld', 09:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:54 INFO - 'MOZ_NO_REMOTE': '1', 09:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:54 INFO - 'NO_EM_RESTART': '1', 09:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:54 INFO - 'PWD': '/builds/slave/test', 09:50:54 INFO - 'SHELL': '/bin/bash', 09:50:54 INFO - 'SHLVL': '1', 09:50:54 INFO - 'TERM': 'linux', 09:50:54 INFO - 'TMOUT': '86400', 09:50:54 INFO - 'USER': 'cltbld', 09:50:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:54 INFO - '_': '/tools/buildbot/bin/python'} 09:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:50:56 INFO - Installing collected packages: mozsystemmonitor 09:50:56 INFO - Running setup.py install for mozsystemmonitor 09:50:56 INFO - Successfully installed mozsystemmonitor 09:50:56 INFO - Cleaning up... 09:50:57 INFO - Return code: 0 09:50:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:50:57 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')]} 09:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 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')]} 09:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:57 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:50:57 INFO - Using env: {'DISPLAY': ':0', 09:50:57 INFO - 'HOME': '/home/cltbld', 09:50:57 INFO - 'LANG': 'en_US.UTF-8', 09:50:57 INFO - 'LANGUAGE': 'en_US:en', 09:50:57 INFO - 'LOGNAME': 'cltbld', 09:50:57 INFO - 'MAIL': '/var/mail/cltbld', 09:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:57 INFO - 'MOZ_NO_REMOTE': '1', 09:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:57 INFO - 'NO_EM_RESTART': '1', 09:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:57 INFO - 'PWD': '/builds/slave/test', 09:50:57 INFO - 'SHELL': '/bin/bash', 09:50:57 INFO - 'SHLVL': '1', 09:50:57 INFO - 'TERM': 'linux', 09:50:57 INFO - 'TMOUT': '86400', 09:50:57 INFO - 'USER': 'cltbld', 09:50:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:57 INFO - '_': '/tools/buildbot/bin/python'} 09:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:59 INFO - warning: no files found matching '*.txt' 09:50:59 INFO - no previously-included directories found matching 'build' 09:50:59 INFO - no previously-included directories found matching 'dist' 09:50:59 INFO - no previously-included directories found matching '.git*' 09:50:59 INFO - Installing collected packages: jsonschema, functools32 09:50:59 INFO - Running setup.py install for functools32 09:50:59 INFO - warning: no files found matching '*.txt' 09:50:59 INFO - no previously-included directories found matching 'build' 09:50:59 INFO - no previously-included directories found matching 'dist' 09:50:59 INFO - no previously-included directories found matching '.git*' 09:50:59 INFO - Successfully installed jsonschema functools32 09:50:59 INFO - Cleaning up... 09:50:59 INFO - Return code: 0 09:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:50:59 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')]} 09:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:59 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')]} 09:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:59 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:50:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:50:59 INFO - Using env: {'DISPLAY': ':0', 09:50:59 INFO - 'HOME': '/home/cltbld', 09:50:59 INFO - 'LANG': 'en_US.UTF-8', 09:50:59 INFO - 'LANGUAGE': 'en_US:en', 09:50:59 INFO - 'LOGNAME': 'cltbld', 09:50:59 INFO - 'MAIL': '/var/mail/cltbld', 09:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:59 INFO - 'MOZ_NO_REMOTE': '1', 09:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:59 INFO - 'NO_EM_RESTART': '1', 09:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:59 INFO - 'PWD': '/builds/slave/test', 09:50:59 INFO - 'SHELL': '/bin/bash', 09:50:59 INFO - 'SHLVL': '1', 09:50:59 INFO - 'TERM': 'linux', 09:50:59 INFO - 'TMOUT': '86400', 09:50:59 INFO - 'USER': 'cltbld', 09:50:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:59 INFO - '_': '/tools/buildbot/bin/python'} 09:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:02 INFO - Downloading docopt-0.6.1.tar.gz 09:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:02 INFO - Running setup.py install for blobuploader 09:51:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:02 INFO - Running setup.py install for requests 09:51:02 INFO - Running setup.py install for docopt 09:51:02 INFO - Successfully installed blobuploader requests docopt 09:51:02 INFO - Cleaning up... 09:51:03 INFO - Return code: 0 09:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:03 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')]} 09:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:03 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')]} 09:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:03 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:03 INFO - Using env: {'DISPLAY': ':0', 09:51:03 INFO - 'HOME': '/home/cltbld', 09:51:03 INFO - 'LANG': 'en_US.UTF-8', 09:51:03 INFO - 'LANGUAGE': 'en_US:en', 09:51:03 INFO - 'LOGNAME': 'cltbld', 09:51:03 INFO - 'MAIL': '/var/mail/cltbld', 09:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:03 INFO - 'MOZ_NO_REMOTE': '1', 09:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:03 INFO - 'NO_EM_RESTART': '1', 09:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:03 INFO - 'PWD': '/builds/slave/test', 09:51:03 INFO - 'SHELL': '/bin/bash', 09:51:03 INFO - 'SHLVL': '1', 09:51:03 INFO - 'TERM': 'linux', 09:51:03 INFO - 'TMOUT': '86400', 09:51:03 INFO - 'USER': 'cltbld', 09:51:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:03 INFO - '_': '/tools/buildbot/bin/python'} 09:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:03 INFO - Running setup.py (path:/tmp/pip-oEYSAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:03 INFO - Running setup.py (path:/tmp/pip-f5xIkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:03 INFO - Running setup.py (path:/tmp/pip-iKtktn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:03 INFO - Running setup.py (path:/tmp/pip-vWHZOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:03 INFO - Running setup.py (path:/tmp/pip-Y1lOVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:03 INFO - Running setup.py (path:/tmp/pip-OFPuxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:03 INFO - Running setup.py (path:/tmp/pip-LhVUeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:03 INFO - Running setup.py (path:/tmp/pip-VwO1dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:03 INFO - Running setup.py (path:/tmp/pip-bLwsyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:03 INFO - Running setup.py (path:/tmp/pip-FPEjz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:03 INFO - Running setup.py (path:/tmp/pip-_tTzbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:04 INFO - Running setup.py (path:/tmp/pip-yK8JCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:04 INFO - Running setup.py (path:/tmp/pip-QpjSjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:04 INFO - Running setup.py (path:/tmp/pip-zUW41O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:04 INFO - Running setup.py (path:/tmp/pip-I8VI0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:04 INFO - Running setup.py (path:/tmp/pip-nnbMuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:04 INFO - Running setup.py (path:/tmp/pip-PEckMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:04 INFO - Running setup.py install for manifestparser 09:51:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:04 INFO - Running setup.py install for mozcrash 09:51:04 INFO - Running setup.py install for mozdebug 09:51:04 INFO - Running setup.py install for mozdevice 09:51:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:04 INFO - Running setup.py install for mozfile 09:51:04 INFO - Running setup.py install for mozhttpd 09:51:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozinfo 09:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozInstall 09:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozleak 09:51:05 INFO - Running setup.py install for mozlog 09:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for moznetwork 09:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozprocess 09:51:05 INFO - Running setup.py install for mozprofile 09:51:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozrunner 09:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:05 INFO - Running setup.py install for mozscreenshot 09:51:06 INFO - Running setup.py install for moztest 09:51:06 INFO - Running setup.py install for mozversion 09:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:06 INFO - Using env: {'DISPLAY': ':0', 09:51:06 INFO - 'HOME': '/home/cltbld', 09:51:06 INFO - 'LANG': 'en_US.UTF-8', 09:51:06 INFO - 'LANGUAGE': 'en_US:en', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MAIL': '/var/mail/cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SHLVL': '1', 09:51:06 INFO - 'TERM': 'linux', 09:51:06 INFO - 'TMOUT': '86400', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - '_': '/tools/buildbot/bin/python'} 09:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:06 INFO - Running setup.py (path:/tmp/pip-y9gpyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Running setup.py (path:/tmp/pip-TLChN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Running setup.py (path:/tmp/pip-gwRPws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Running setup.py (path:/tmp/pip-kBND60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Running setup.py (path:/tmp/pip-4MXBeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Running setup.py (path:/tmp/pip-l9R3aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Running setup.py (path:/tmp/pip-XWSTRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:07 INFO - Running setup.py (path:/tmp/pip-mlIjek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:07 INFO - Running setup.py (path:/tmp/pip-0fgpep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:07 INFO - Running setup.py (path:/tmp/pip-0VltVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:07 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)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Running setup.py (path:/tmp/pip-MQMCy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 INFO - Running setup.py (path:/tmp/pip-tKaSxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 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)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Running setup.py (path:/tmp/pip-2sg36e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 INFO - Running setup.py (path:/tmp/pip-14HWPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 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)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Running setup.py (path:/tmp/pip-3Bnv3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Running setup.py (path:/tmp/pip-yOnVjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Running setup.py (path:/tmp/pip-kR_URH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:09 INFO - Downloading blessings-1.6.tar.gz 09:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:09 INFO - Installing collected packages: blessings 09:51:09 INFO - Running setup.py install for blessings 09:51:09 INFO - Successfully installed blessings 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:10 INFO - Reading from file tmpfile_stdout 09:51:10 INFO - Current package versions: 09:51:10 INFO - argparse == 1.2.1 09:51:10 INFO - blessings == 1.6 09:51:10 INFO - blobuploader == 1.2.4 09:51:10 INFO - docopt == 0.6.1 09:51:10 INFO - functools32 == 3.2.3-2 09:51:10 INFO - jsonschema == 2.5.1 09:51:10 INFO - manifestparser == 1.1 09:51:10 INFO - mozInstall == 1.12 09:51:10 INFO - mozcrash == 0.17 09:51:10 INFO - mozdebug == 0.1 09:51:10 INFO - mozdevice == 0.48 09:51:10 INFO - mozfile == 1.2 09:51:10 INFO - mozhttpd == 0.7 09:51:10 INFO - mozinfo == 0.9 09:51:10 INFO - mozleak == 0.1 09:51:10 INFO - mozlog == 3.2 09:51:10 INFO - moznetwork == 0.27 09:51:10 INFO - mozprocess == 0.22 09:51:10 INFO - mozprofile == 0.28 09:51:10 INFO - mozrunner == 6.11 09:51:10 INFO - mozscreenshot == 0.1 09:51:10 INFO - mozsystemmonitor == 0.3 09:51:10 INFO - moztest == 0.7 09:51:10 INFO - mozversion == 1.4 09:51:10 INFO - psutil == 3.1.1 09:51:10 INFO - requests == 1.2.3 09:51:10 INFO - wsgiref == 0.1.2 09:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:10 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')]} 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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')]} 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:10 INFO - Using env: {'DISPLAY': ':0', 09:51:10 INFO - 'HOME': '/home/cltbld', 09:51:10 INFO - 'LANG': 'en_US.UTF-8', 09:51:10 INFO - 'LANGUAGE': 'en_US:en', 09:51:10 INFO - 'LOGNAME': 'cltbld', 09:51:10 INFO - 'MAIL': '/var/mail/cltbld', 09:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:10 INFO - 'MOZ_NO_REMOTE': '1', 09:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:10 INFO - 'NO_EM_RESTART': '1', 09:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:10 INFO - 'PWD': '/builds/slave/test', 09:51:10 INFO - 'SHELL': '/bin/bash', 09:51:10 INFO - 'SHLVL': '1', 09:51:10 INFO - 'TERM': 'linux', 09:51:10 INFO - 'TMOUT': '86400', 09:51:10 INFO - 'USER': 'cltbld', 09:51:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:10 INFO - '_': '/tools/buildbot/bin/python'} 09:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:51:10 INFO - Cleaning up... 09:51:10 INFO - Return code: 0 09:51:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:10 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')]} 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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')]} 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:10 INFO - Using env: {'DISPLAY': ':0', 09:51:10 INFO - 'HOME': '/home/cltbld', 09:51:10 INFO - 'LANG': 'en_US.UTF-8', 09:51:10 INFO - 'LANGUAGE': 'en_US:en', 09:51:10 INFO - 'LOGNAME': 'cltbld', 09:51:10 INFO - 'MAIL': '/var/mail/cltbld', 09:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:10 INFO - 'MOZ_NO_REMOTE': '1', 09:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:10 INFO - 'NO_EM_RESTART': '1', 09:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:10 INFO - 'PWD': '/builds/slave/test', 09:51:10 INFO - 'SHELL': '/bin/bash', 09:51:10 INFO - 'SHLVL': '1', 09:51:10 INFO - 'TERM': 'linux', 09:51:10 INFO - 'TMOUT': '86400', 09:51:10 INFO - 'USER': 'cltbld', 09:51:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:10 INFO - '_': '/tools/buildbot/bin/python'} 09:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:10 INFO - Cleaning up... 09:51:10 INFO - Return code: 0 09:51:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:51:10 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')]} 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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')]} 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:10 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 0x7fc711bbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:10 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 09:51:10 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 09:51:10 INFO - Using env: {'DISPLAY': ':0', 09:51:10 INFO - 'HOME': '/home/cltbld', 09:51:10 INFO - 'LANG': 'en_US.UTF-8', 09:51:10 INFO - 'LANGUAGE': 'en_US:en', 09:51:10 INFO - 'LOGNAME': 'cltbld', 09:51:10 INFO - 'MAIL': '/var/mail/cltbld', 09:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:10 INFO - 'MOZ_NO_REMOTE': '1', 09:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:10 INFO - 'NO_EM_RESTART': '1', 09:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:10 INFO - 'PWD': '/builds/slave/test', 09:51:10 INFO - 'SHELL': '/bin/bash', 09:51:10 INFO - 'SHLVL': '1', 09:51:10 INFO - 'TERM': 'linux', 09:51:10 INFO - 'TMOUT': '86400', 09:51:10 INFO - 'USER': 'cltbld', 09:51:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:10 INFO - '_': '/tools/buildbot/bin/python'} 09:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:10 INFO - Downloading/unpacking flake8 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:51:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:51:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:13 INFO - no previously-included directories found matching 'docs/_build' 09:51:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:51:13 INFO - Running setup.py install for pep8 09:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:13 INFO - no previously-included directories found matching 'docs/_build' 09:51:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:51:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Running post-action listener: _resource_record_post_action 09:51:13 INFO - Running post-action listener: _start_resource_monitoring 09:51:13 INFO - Starting resource monitoring. 09:51:13 INFO - ##### 09:51:13 INFO - ##### Finished create-virtualenv step (success) 09:51:13 INFO - ##### 09:51:13 INFO - ##### 09:51:13 INFO - ##### Running install step. 09:51:13 INFO - ##### 09:51:13 INFO - Running pre-action listener: _resource_record_pre_action 09:51:13 INFO - Running main action method: install 09:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Output received: 09:51:13 INFO - Usage: mozinstall [options] installer 09:51:13 INFO - Options: 09:51:13 INFO - -h, --help show this help message and exit 09:51:13 INFO - -d DEST, --destination=DEST 09:51:13 INFO - Directory to install application into. [default: 09:51:13 INFO - "/builds/slave/test"] 09:51:13 INFO - --app=APP Application being installed. [default: firefox] 09:51:13 INFO - mkdir: /builds/slave/test/build/application 09:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:51:29 INFO - Reading from file tmpfile_stdout 09:51:29 INFO - Output received: 09:51:29 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:29 INFO - Running post-action listener: _resource_record_post_action 09:51:29 INFO - ##### 09:51:29 INFO - ##### Finished install step (success) 09:51:29 INFO - ##### 09:51:29 INFO - ##### 09:51:29 INFO - ##### Running run-tests step. 09:51:29 INFO - ##### 09:51:29 INFO - Running pre-action listener: _resource_record_pre_action 09:51:29 INFO - Running main action method: run_tests 09:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:29 INFO - Python 2.7.3 09:51:29 INFO - Return code: 0 09:51:29 INFO - grabbing minidump binary from tooltool 09:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226a2e0>, '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 0x21d6140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d65d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:51:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:51:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:51:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:29 INFO - Return code: 0 09:51:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:51:30 INFO - Return code: 0 09:51:30 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/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 09:51:30 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/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 09:51:30 INFO - Using env: {'DISPLAY': ':0', 09:51:30 INFO - 'HOME': '/home/cltbld', 09:51:30 INFO - 'LANG': 'en_US.UTF-8', 09:51:30 INFO - 'LANGUAGE': 'en_US:en', 09:51:30 INFO - 'LOGNAME': 'cltbld', 09:51:30 INFO - 'MAIL': '/var/mail/cltbld', 09:51:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:30 INFO - 'MOZ_NO_REMOTE': '1', 09:51:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:30 INFO - 'NO_EM_RESTART': '1', 09:51:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:30 INFO - 'PWD': '/builds/slave/test', 09:51:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:30 INFO - 'SHELL': '/bin/bash', 09:51:30 INFO - 'SHLVL': '1', 09:51:30 INFO - 'TERM': 'linux', 09:51:30 INFO - 'TMOUT': '86400', 09:51:30 INFO - 'USER': 'cltbld', 09:51:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159', 09:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:30 INFO - '_': '/tools/buildbot/bin/python'} 09:51:30 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/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 09:51:31 INFO - mozversion application_buildid: 20160610092130 09:51:31 INFO - mozversion application_changeset: c2ffbe22285487d5443d840e4c5feaa391f66c8d 09:51:31 INFO - mozversion application_display_name: Nightly 09:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:31 INFO - mozversion application_name: Firefox 09:51:31 INFO - mozversion application_remotingname: firefox 09:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:51:31 INFO - mozversion application_vendor: Mozilla 09:51:31 INFO - mozversion application_version: 50.0a1 09:51:31 INFO - mozversion platform_buildid: 20160610092130 09:51:31 INFO - mozversion platform_changeset: c2ffbe22285487d5443d840e4c5feaa391f66c8d 09:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:51:31 INFO - mozversion platform_version: 50.0a1 09:51:31 INFO - using testdate: 1465577491 09:51:31 INFO - actual date: 1465577491 09:51:31 INFO - starting webserver on 'localhost:37883' 09:51:31 INFO - SUITE-START | Running 2 tests 09:51:31 INFO - TEST-START | dromaeo_css 09:51:31 INFO - operating with platform_type : linux_ 09:51:31 INFO - Initialising browser for dromaeo_css test... 09:51:31 INFO - TEST-INFO | started process 25192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5KJiI9/profile http://localhost:37883/getInfo.html) 09:51:35 INFO - PROCESS | 25192 | __metrics Screen width/height:1600/1200 09:51:35 INFO - PROCESS | 25192 | colorDepth:24 09:51:35 INFO - PROCESS | 25192 | Browser inner width/height: 1024/697 09:51:35 INFO - PROCESS | 25192 | __metrics 09:51:36 ERROR - PROCESS | 25192 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:51:37 INFO - TEST-INFO | 25192: exit 0 09:51:37 INFO - Browser initialized. 09:51:37 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:37 INFO - TEST-INFO | started process 25310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5KJiI9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:49 INFO - PROCESS | 25310 | RSS: Main: 186159104 09:51:49 INFO - PROCESS | 25310 | 09:52:38 INFO - PROCESS | 25310 | 1465577558939 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:54:51 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37883/tests/dromaeo/cssquery-ext.html) 09:54:52 INFO - PROCESS | 25310 | RSS: Main: 188723200 09:54:52 INFO - PROCESS | 25310 | 09:57:54 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-ext.html (next: http://localhost:37883/tests/dromaeo/cssquery-jquery.html) 09:57:54 INFO - PROCESS | 25310 | RSS: Main: 187838464 09:57:54 INFO - PROCESS | 25310 | 10:00:56 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37883/tests/dromaeo/cssquery-mootools.html) 10:00:57 INFO - PROCESS | 25310 | RSS: Main: 189685760 10:00:57 INFO - PROCESS | 25310 | 10:03:59 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37883/tests/dromaeo/cssquery-prototype.html) 10:03:59 INFO - PROCESS | 25310 | RSS: Main: 187179008 10:03:59 INFO - PROCESS | 25310 | 10:07:02 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37883/tests/dromaeo/cssquery-yui.html) 10:07:03 INFO - PROCESS | 25310 | RSS: Main: 188899328 10:07:03 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | Cycle 1(1): loaded http://localhost:37883/tests/dromaeo/cssquery-yui.html (next: http://localhost:37883/tests/dromaeo/cssquery-dojo.html) 10:10:05 INFO - PROCESS | 25310 | RSS: Main: 190078976 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | __start_tp_report 10:10:05 INFO - PROCESS | 25310 | _x_x_mozilla_page_load 10:10:05 INFO - PROCESS | 25310 | _x_x_mozilla_page_load_details 10:10:05 INFO - PROCESS | 25310 | |i|pagename|runs| 10:10:05 INFO - PROCESS | 25310 | |0;dojo.html;2582.870856457177;2657.986710066449;2673.4786716590274;2681.2492502099417;2681.6245725598405;4712.505186955372;4761.619070474362;4791.832285869995;4878.0731660984475;4901.68139070961;4665.440147182343;4747.6676632635645;4754.595859351959;4811.951880481194;4833.371661683985;4332.913341733163;4412.75729834859;4460.1525710114975;4483.103379324149;4492.820287188509;620.5553223813718;4309.159713855799;4381.561843815625;4400.44994375703;4432.867013989569;4355.041890784022;4376.168527979689;4388.868333949987;4392.165488557164;4422.778861056934;4297.462817147856;4393.406890069831;4395.780210989437;4428.778561071934;4429.645628349725;4295.763732994684;4321.675874309408;4327.0913108247305;4328.956710432918;4336.501302350207;4726.149293127236;4768.0463907218345;4794.904101917942;4804.975975120137;4824.758762061918;5022.196448568248;5057.317262169597;5137.51193636604;5159.871003224912;5185.299984502081;5182.585393168538;5206.609504287194;5210.869728256824;5226.608004399647;5237.083510385705;4837.637177211724;4839.080574690797;4840.128776820171;4856.368672072678;4857.417109946829;5204.115300398941;5227.085260079471;5246.108161612458;5246.868828279324;5320.414754377015;5036.219385995177;5036.219385995177;5063.8987220255385;5064.924026139611;5102.795888164432;5050.949490505048;5120.385553733576;5131.897362052813;5139.820106296262;5149.304843846107;5059.848204553869;5073.822416215488;5105.668131571436;5107.795688172506;5108.208227724708;5001.624878134155;5049.394072711299;5086.338775959176;5108.055009823194;5127.41034781005;4201.306784380543;4284.121755040209;4315.633171180422;4330.58859408362;4372.868813935524;3731.8320675569666;3756.4740936268945;3773.716971227169;3779.829907654162;3805.429185622179;4516.932246016312;4519.661025423106;4532.161550113174;4534.093181363741;4579.22153233951;5164.2770012198325;5182.455842136596;5188.0661480933795;5201.349831271091;5246.97376513115;4546.158960592301;4561.042181141997;4573.108243892409;4580.1068791585985;4594.1271158479785;4599.6090332321455;4650.6046986005895;4652.418447694038;4660.137874493162;4700.388949436551;4791.832285870048;4849.442314133778;4881.609471242221;4896.608271338356;4926.433460152129;5139.691618502902;5167.9922415128685;5185.066687996197;5194.97402512985;5204.947950520446;4895.534924182197;4899.216125419915;4901.068796928572;4903.436104847988;4940.654154209171;4984.37695288089;5006.349174607278;5013.724245166405;5017.62367822422;5025.874353141201;5067.87330316745;5103.642745007814;5105.285260063668;5117.616178786531;5152.742362881916;4965.875853103701;4968.627352948615;4970.676906001098;4991.101601711727;5032.295478632921;4892.633052521004;5014.84955451337;5038.84883453497;5048.949510504995;5071.721055341844;4879.878003049952;4883.340748998982;4906.975465122651;4946.678465899705;4947.1589829729755;4958.082754690394;4994.850154495371;5024.196128619404;5039.420466646383;5088.542031217208;4955.752212389438;4956.876078097932;4958.082754690394;4963.404391473046;4997.425296090996 10:10:05 INFO - PROCESS | 25310 | |1;ext.html;549.4725063938619;579.1457600039939;588.2676068294973;606.3421188011008;617.6849806598633;33196.33607327855;37300.25399492009;37322.626773732285;37452.625473745255;37558.812205939;39036;39320.80339598305;39600.40599391004;39637;39667.20665586694;7728.111267204274;7796.532208067534;7800.882986755203;7802.960985195066;7873.173316801739;7674.884876726854;7745.264199901;7804.960975195116;7816.687332506693;7825.647845846951;7850.175731548191;7862.724804631839;7863;7863.803404914895;7895.210478952116;7804.687812487494;7810.336121429686;7817.413693972918;7859.410544209179;7865.056193256789;7771.7279895203965;7836.6081695915545;7843.686252549891;7843.960780196119;7847;30142.24644383886;36658.45012324791;36980.260394792225;36996.26007479835;37098.25803483915;2824.1988619347194;3002.1293824790782;3027.3793872256356;3079.461094308487;3106.4718997770433;27752.583711244348;30084.8495757522;30149;30605.846970765226;30792.8460357699;3535.116220944764;3651.47053677218;3656.4880916671686;3660.5058317127114;3714.4985426967282;253153;253944;255678;257309;257942;57242.71378643163;57975.420245797;58370;58578;58663.70668146717;34898.651013490045;35687;35697;60681.69659151676;60803.39196608066;15038.699226015637;15113.54659360221;15182.316795744218;15249.847501524842;15265.465708700141;10500.212484063726;10608.787824243473;10631;10742.516586753614;10801.189910756724;19278.13248403825;19295.51761205953;19317.80682193188;19346.80653193478;19365.80634193668;7341.596212208273;7491.887621685679;7553.0739661386;7642.5032372895585;7689.50018248812;837.2757564706485;887.4143065576817;901.3400718286474;927.4249965021729;990.5691024404407;28356.574651380244;28379.290517737223;28658.856705716757;28951.7104828949;29284.560731589045;954.2747511890874;989.4805227255605;1010.3988127064385;1011.8684571005722;1048.5334026358198;14526.927365363106;14779.313753388496;14944.327505262288;15026.774598381033;15034.69930601382;199597;199613;200885;200932;201077;49938;50244.24633630498;50257.24614130791;50478.95210478923;50481.747591262545;1160.3907948327028;1169.0997931592797;1200.7178313096415;1206.6741979665617;1208.8065909454444;26992.865035674695;27404;28194.718052819208;28350.858245709464;28553;44373.55626443694;44660;44844.55155448404;45160.77419612881;45412.31881521846;361213;361850;363219;363869;364179;25643.102491412712;25925.481490370465;26085.478290434465;26170;26801.329966750985;38660.420093698056;39441.60558394379;39492;41982;43755.56244437515;35306.293874122886;36626.63373366339;36910.26179476342;36939;37322.44016339811;35315.29369412546;35648.10879728028;35949.46075808813;36264;36449.817750911076;35534.822325888206;35643.46534801928;36478.4528232082;37635;37759.81120094382;31225.68774312228;33653.15867103244;33692.83153584216;33695.663043369255;34124.488132678525;25594.232173034838;25825.483490330465;26066.86966565155;26181.214563563124;26457.60313595259 10:10:05 INFO - PROCESS | 25310 | |2;jquery.html;371.92189640175565;376.8831662184722;380.3287198095362;387.146342315195;389.8888816687245;15351.616209594766;16447.588810279733;17210.91394543027;17433.30266789327;17437.21532531036;15407.845921540782;15810.367585296573;16457.588560286;16460.83539164608;16472.505824825275;4997.550220480156;5138.768755405997;5141;5198.0383629028565;5203.843884683447;3702.1114932416294;5065.632279284591;5752.7986520471795;6076.878462430749;6085.817425477243;6114.144019837227;6154.753809847623;6157.7229024694;6166.167567378414;6167.105769663419;4947.6289278304275;5229.503197196279;5237.6071794615555;5297.073012222845;5324.201369794523;4959.6528243023;5111.667741596784;5248.8425347239645;5309.654872433318;5313.149896016619;12546.68633284166;12553.246805191719;15986.840131598768;19441.31955381569;19549.609007819763;1850.463365623981;1859.237712537853;1859.3120545398153;1946.143696773415;1976;8842.5136617486;8883.822323553493;9284;9319.720408387759;9365.625374984993;1717.9828201717949;1755.3943889358152;1770.2299499717665;1771.495123889698;1792.1576858876308;65971.340286597;67631.66184169048;67652.3234767651;67895.66052169708;69180;9653.22774178064;9710.126088652056;9761.609535618496;10392.116670082976;10686;13572.592822215349;13604.523841665494;13622.523211687543;13637.454501820015;13656.658583535293;7235.2764723527225;7294.744683936036;7332.0834895638045;7397.593132377663;7489.325960663567;6977.476689248327;6990.580565166107;7020.7893763187185;7079;7127.643617819192;4175.874723758292;4245.8513952011535;4251;4274.123804620045;4315.856298081011;1682.4532027091;1797.478731167973;3076.215565030903;3105.503119500869;3254.397936381777;844.7761343244046;860.1441565642226;885.8095509465496;902.1835239108617;919.6505327975326;15697.68604627901;16223;16527.91736041312;16576.83423165753;16818.747718784227;845.2055068235838;855.9700410485727;877.7761670773912;882.8940527136784;901.1304091551553;8919.464832110094;9127.726168214964;9135.223506002065;9391.34260601765;9454;375671;381251;387594;405943;420269;75052.62473687597;75176;77855.61072194602;78938.6053069731;81006.5949670248;428.8670512141246;438.41909469951804;440.6871121503704;444.2470013327379;444.50215758350856;9379.343445958717;9971.700848974542;10041.297109202285;10260.230482713678;10422.114120299859;35792.74725384599;36765;37108;38695.226095478494;38780.6121938777;51977;52566.737166315455;52906;52968.73515632397;53368;4753.168195565693;5353.892922141457;6292.748290068346;7353.522021068614;7743.186965368781;10545;10857.457127143769;10920.453977300944;11598.71003224926;11682.182247242952;10055.89944100579;10120.392776433144;10299;10362.171026317727;10535.947320263349;9569;9643.855342169732;9645.517724113626;9698.418094914328;9725.6596019139;10191.592336306465;10270.794584108127;10306.484675766033;10630.946845265724;10718.624848130277;7540.1328847181085;7671.53970761756;7703.807404814925;7715.074191097105;7759.961200193963;8679.739607811776;10189.796204075728;10259.742856571542;10272.126869216201;10425.478726063819 10:10:05 INFO - PROCESS | 25310 | |3;mootools.html;1376.394386469953;1411.1674112273759;1473.9631509212268;1656.320908427545;1665.2839279109985;6835.28229535899;7444.8883266751045;7561.357284630806;8063.758087257392;8064.395170362224;7670.501417407864;7874.330681892032;7920.762377128681;7934.047914250284;7949.24482174194;2229.4314949687846;2258.6499092640665;2264.682944387787;2264.852784569006;2265.229821860567;2173.7826217378215;2185.0495034659893;2214.6345852934246;2219.600471915063;2219.966700499494;2186.147402513021;2195.967060494094;2214.867107973527;2220.888955552224;2221.2891874600136;2102.075086961732;2104.9579008419823;2108.082983902;2108.1251280718484;2114.0803750368486;2112.588045331161;2139.689744986968;2144.571085782834;2170.4790850195996;2179.3788770200576;7897.842043159105;7923.920760792376;7943.086545047278;7950.204979502061;8003.439759216857;4488.124815660947;4628.09752098341;4640.141573808856;4641.141388843075;4647.95352046482;2858.3140046388717;2913.6212292402065;3009.217603423104;3009.5636132760847;3022.07826612883;867.6052396159732;869.8390797702382;891.7057371067597;906.9727908162765;911.22090612526;10680.35917844924;10684.946575267073;10737.892621073768;10737.946310268399;10739.087177589914;4133.46264985556;4246.023414614656;4285.292926667127;4368.868933931987;4402.449693788277;9178.265738740885;9209.953950230207;9217.400868943498;9232.769180770534;9237.07629237071;4612.238980568169;4659.5573420525;4659.673822832369;4673.929891051637;4686.133065382915;3844.115853353744;4101.610347017088;4187.455630768041;4199.727017743837;4230.365445183185;3745.9438108428394;3787.981060094682;3809.7142714296538;3831.3103641344824;3890.0663840678035;1244.6017274472263;1246.3145270101409;1263.2357423758679;1267.1320145700224;1268.042627815993;718.8059224009488;856.7858035491128;857.2970164465079;858.6512600856585;864.9654013839375;5160.354955630546;5215.7913683453;5248.580113590903;5445.918311225335;5484.396716361197;798.6206551887923;861.2851333393269;885.4642941020719;896.2516298890499;914.9496777677292;3722.813859307024;3809.4476300936763;3850.7689538627774;3870.2259548089933;3901.49280593521;9265.907340926638;9559.522023898777;9632.373895696757;9715.417074975525;9758.170555502862;9518.714438566854;9544.952275238718;9598.95200524007;9612.615495380107;9659.855102173473;6945.027696122547;7169.641517924188;7225.855482890418;7429.8142546436775;7433.293837085468;5238.580913526833;5318.361796584435;5486.506214440719;5488.094464413327;5591.4688104629995;8694.956525217334;8775.561221939006;9041.954790226007;9060.592273347584;9063.954680226556;8869.246114080375;8911.910880891108;8978;9048.728538143867;9071.682491112779;6012.909806352821;6564.081028656087;6673.833154171185;6795.38841504267;6894.689738961659;7491.438142139253;7538.3215510604305;7576.886346704694;7641.694332226649;7642.08295004603;6618.371254730793;6851.2806155354965;6875.037494750839;6986.6855991481525;7013.158420989514;6823.89764153548;6861.039454476278;6895.75864844728;6938.479614028867;7000.7549735759;5887.970560147171;6077.20996270482;6276.592021518587;6278.874422511432;6335.3981371769605;4441.51143374235;4442.244818380947;4466.731996080245;4504.166729155117;4594.21898277287;4339.717918335298;4419.779011049499;4435.622972047412;4446.755428451466;4493.618042466427 10:10:05 INFO - PROCESS | 25310 | |4;prototype.html;300.3962036307023;305.6469777407094;309.1991741389801;311.1784887895955;313.5766714934837;4998.975005124974;5003.474635163306;5020.849374518762;5044.84865454036;5048.697078175312;4943.528235882059;4946.936408672134;4957.355543779313;4973.602111831054;4974.154393753061;3675.724320675953;3800.885973420788;3927.743122200897;3949.2891279569667;3954.742941708794;3923.705722070842;3939.9015024624327;3951.466552015484;3955.4462375267485;3960.465337179487;3900.7074469414765;3913.8238779255003;3922.686185105185;3936.5866584008695;3969.8412063517426;3830.6209764484765;3904.824282907276;3919.412088186766;3921.941170882439;3953.2884080865433;3460.7750496217664;3485.146139195888;3489.8080605566684;3498;3498.1079824644808;4842.878928026792;4867.099586576494;4882.316475693406;4884.267359896008;4903.362562866804;4314.71954322968;4516;4524.6606504511965;4539.931901021488;4543.273076307808;5197.740112994373;5218.799676074486;5226.007058658843;5233.712145831978;5245.659032162897;3821.0638393593467;3827.3876179811095;3835.6356146166067;3840.6735427488697;3853.0367408147963;5322.866928326823;5355.919661205085;5419.729013549346;5450.236966824647;5487.6981766002855;3897.4215442745735;3906.257811015898;3914.823832927525;3917.6865850731874;3924.8626298080003;3954.54522729884;3966.5636779954184;3977.8806635800393;3983.7609743415487;4014.136960553495;4487.753173575419;4498.865034048984;4508.887277818015;4523.7964291606295;4530.682852200314;5087.796488140507;5183.222516622462;5201.219817027476;5265.1049321614655;5269.314989051399;1370.8286464191976;1387.424218949145;1388.9860401906665;1390.65928847431;1399.7332414165196;850.5152063323969;874.2306770042322;892.7634176943116;896.3053633434141;900.8513595256841;4491.797869095899;4615.423072115986;4664.86005419838;4671.458418721813;4711.363965864564;5333.120035194227;5443.7822487100075;5455.481729235717;5460.208269800856;5477.780888764405;4451.933221001687;4561.589456948891;4565.908681826345;4626.306054091913;4632.444106707149;2849;2877.8992735254583;2883.7692984561604;2898.347871728844;2901.7678585713093;5050.242463630485;5051.873703157377;5063.974680126576;5086.821961231413;5152.587792976553;5257.369115706139;5491.615586908878;5497.422770609109;5533.474319939599;5584.385717571064;5132.589392848563;5135.15269980449;5136.5377116059735;5138.357705286764;5156.484351564814;5472.2065300531995;5500.917486237629;5501.257330260363;5510.91733624004;5516.393196748435;5107.197320814627;5352.357717073976;5360.115580929103;5372.838814835562;5387.865303367447;5162.6386152970435;5171.6896986179445;5182.144946084005;5194.584433245407;5202.479752024768;3858.4405261237525;3862.594427585063;3882.864099756495;3889.7277190596387;3907.824147913294;5307.389650190277;5350.224217488365;5376.946230537801;5473.452654734495;5557.555395568425;5162.8967420652125;5217.81737639196;5233.633645644768;5254.448282930237;5286.233496143114;5253.395859476209;5297.54970827484;5313.973430132824;5316.867078322918;5350.357957045024;5069.898602027865;5189.377274727057;5211.872876274205;5213.374395072616;5218.478152184751;5067.493250674903;5129;5284.630075894651;5314.62797604164;5328.440513746001;5193.091209038327;5206.0997735825395;5214.739263036909;5217.947820521898;5242.2922905408805 10:10:05 INFO - PROCESS | 25310 | |5;yui.html;607.790312342242;673.8854394752891;684.2241156726055;742.8737114690502;751.8345963887942;12748.553800616968;13017;13099.54151604694;13102.475900963975;13230.338483075831;12711.491540338375;12809.935950320236;12877.484900603964;12891.419886105125;12897;611.6819253987924;752.8945947567345;756.0662581711596;769.638270013093;770.4144849914078;773.0568706178482;774.508187301065;778.8948491953598;779.7582749347692;780.6409051836163;825.9628316725762;833.8999320081599;835.6364981233153;835.8453686068096;837.0875745437472;823.7075838077457;824.9711260105897;830.6926437218208;830.8296799156159;833.9499630022218;604.8276241271261;606.5178183344252;607.6263098194622;607.9969600152015;608.3399511529951;12536.122471427003;12565.74868502634;12568.30874301913;12592.622221333375;12624.936875315656;13311.069894865288;13542.661433464144;13655.38550765208;13909;13978.510752123728;10434.634787782392;10502.159827213805;10528.157747380192;10572.866921362673;10638.734031649194;3372.291818718072;3393.9490907636405;3400.4559270516847;3413.300273443963;3495.0912762681633;56317.71841140768;56645;56966.43033569694;57652.711736441466;58111;10390.48047597617;10553.155747540332;10559.947200264103;10630.415327156927;10804.729881753019;19424;19708.605827883363;19767.23258743777;19901.20889119957;20287.594248114954;7114.750983715545;7119.822004449827;7302.05073340473;7337.74317898871;7352.96323518379;3871.1676989447406;3885.669718073995;3891;3894.123822139996;3899.2396482685604;2933.2960089578773;2993.027266138514;3005.443992861328;3009.5786589877434;3015.321552650636;504.36953807740326;529.8251576979587;549.7636016512938;551.8179000929683;554.3264933106295;577.8324285957025;594.7710131599365;617.9258488981351;625.7371903800415;635.2948227467507;7563.205863384375;7988.760337189894;8090.4336696431865;8106.878396824052;8197.385196110316;474.74126601002536;569.9772009119672;601.7562887030759;603.538293205698;612.8253447767365;3988;4043.4541336919137;4076.144009757984;4098.159877225162;4099.815508302134;56020.15969760457;56976.43023569794;97838;98430.50784746173;99610.5019474898;50619.49380506148;73553.89669154967;81072;84748;86442;48564;48947;49422.752886236056;61331;81239.5938020318;8115.878261825959;8212.301954333949;8661.61022753965;8700.564971751513;8748.91251087481;42407.3638895423;43646.56353436425;43685.56314436815;44099.55900441083;44560.331595025455;62268.68865655643;62543.374566253755;62595;62676;62973.68513157405;10411.47942602882;10647.467626618483;10699.358038517714;10735.46322683847;10805.621803236849;12166.939165304117;12483.812742809047;12698.936505317415;12826;12890.935545322214;11147.498362573542;11196.229223517737;11474.94262528682;11937.46281417321;12039.699007524881;11312.434378281218;11541.36522491271;11644.126690498417;11777.705557361134;11908.345041022827;9943.403395796275;10056;10329.12202462769;11428.485718142538;11608.30350178992;9125.361224714206;9609.375390599589;9660.044767767196;9999.600015999278;10591.417472038804;9591.42451452915;9858.162056225301;9909.405435673883;9917.15704165154;9954.850677239703 10:10:05 INFO - PROCESS | 25310 | __end_tp_report 10:10:05 INFO - PROCESS | 25310 | __start_cc_report 10:10:05 INFO - PROCESS | 25310 | _x_x_mozilla_cycle_collect,403 10:10:05 INFO - PROCESS | 25310 | __end_cc_report 10:10:05 INFO - PROCESS | 25310 | __startTimestamp1465578605942__endTimestamp 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | ------- Summary: start ------- 10:10:05 INFO - PROCESS | 25310 | Number of tests: 6 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#0] dojo.html Cycles:165 Average:4725.46 Median:4901.07 stddev:596.76 (12.2%) stddev-sans-first:574.43 10:10:05 INFO - PROCESS | 25310 | Values: 2582.9 2658.0 2673.5 2681.2 2681.6 4712.5 4761.6 4791.8 4878.1 4901.7 4665.4 4747.7 4754.6 4812.0 4833.4 4332.9 4412.8 4460.2 4483.1 4492.8 620.6 4309.2 4381.6 4400.4 4432.9 4355.0 4376.2 4388.9 4392.2 4422.8 4297.5 4393.4 4395.8 4428.8 4429.6 4295.8 4321.7 4327.1 4329.0 4336.5 4726.1 4768.0 4794.9 4805.0 4824.8 5022.2 5057.3 5137.5 5159.9 5185.3 5182.6 5206.6 5210.9 5226.6 5237.1 4837.6 4839.1 4840.1 4856.4 4857.4 5204.1 5227.1 5246.1 5246.9 5320.4 5036.2 5036.2 5063.9 5064.9 5102.8 5050.9 5120.4 5131.9 5139.8 5149.3 5059.8 5073.8 5105.7 5107.8 5108.2 5001.6 5049.4 5086.3 5108.1 5127.4 4201.3 4284.1 4315.6 4330.6 4372.9 3731.8 3756.5 3773.7 3779.8 3805.4 4516.9 4519.7 4532.2 4534.1 4579.2 5164.3 5182.5 5188.1 5201.3 5247.0 4546.2 4561.0 4573.1 4580.1 4594.1 4599.6 4650.6 4652.4 4660.1 4700.4 4791.8 4849.4 4881.6 4896.6 4926.4 5139.7 5168.0 5185.1 5195.0 5204.9 4895.5 4899.2 4901.1 4903.4 4940.7 4984.4 5006.3 5013.7 5017.6 5025.9 5067.9 5103.6 5105.3 5117.6 5152.7 4965.9 4968.6 4970.7 4991.1 5032.3 4892.6 5014.8 5038.8 5048.9 5071.7 4879.9 4883.3 4907.0 4946.7 4947.2 4958.1 4994.9 5024.2 5039.4 5088.5 4955.8 4956.9 4958.1 4963.4 4997.4 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#1] ext.html Cycles:180 Average:43559.00 Median:200314.41 stddev:73826.57 (36.9%) stddev-sans-first:73963.04 10:10:05 INFO - PROCESS | 25310 | Values: 549.5 579.1 588.3 606.3 617.7 33196.3 37300.3 37322.6 37452.6 37558.8 39036.0 39320.8 39600.4 39637.0 39667.2 7728.1 7796.5 7800.9 7803.0 7873.2 7674.9 7745.3 7805.0 7816.7 7825.6 7850.2 7862.7 7863.0 7863.8 7895.2 7804.7 7810.3 7817.4 7859.4 7865.1 7771.7 7836.6 7843.7 7844.0 7847.0 30142.2 36658.5 36980.3 36996.3 37098.3 2824.2 3002.1 3027.4 3079.5 3106.5 27752.6 30084.8 30149.0 30605.8 30792.8 3535.1 3651.5 3656.5 3660.5 3714.5 253153.0 253944.0 255678.0 257309.0 257942.0 57242.7 57975.4 58370.0 58578.0 58663.7 34898.7 35687.0 35697.0 60681.7 60803.4 15038.7 15113.5 15182.3 15249.8 15265.5 10500.2 10608.8 10631.0 10742.5 10801.2 19278.1 19295.5 19317.8 19346.8 19365.8 7341.6 7491.9 7553.1 7642.5 7689.5 837.3 887.4 901.3 927.4 990.6 28356.6 28379.3 28658.9 28951.7 29284.6 954.3 989.5 1010.4 1011.9 1048.5 14526.9 14779.3 14944.3 15026.8 15034.7 199597.0 199613.0 200885.0 200932.0 201077.0 49938.0 50244.2 50257.2 50479.0 50481.7 1160.4 1169.1 1200.7 1206.7 1208.8 26992.9 27404.0 28194.7 28350.9 28553.0 44373.6 44660.0 44844.6 45160.8 45412.3 361213.0 361850.0 363219.0 363869.0 364179.0 25643.1 25925.5 26085.5 26170.0 26801.3 38660.4 39441.6 39492.0 41982.0 43755.6 35306.3 36626.6 36910.3 36939.0 37322.4 35315.3 35648.1 35949.5 36264.0 36449.8 35534.8 35643.5 36478.5 37635.0 37759.8 31225.7 33653.2 33692.8 33695.7 34124.5 25594.2 25825.5 26066.9 26181.2 26457.6 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#2] jquery.html Cycles:180 Average:24077.87 Median:4850.40 stddev:65180.34 (1343.8%) stddev-sans-first:65338.89 10:10:05 INFO - PROCESS | 25310 | Values: 371.9 376.9 380.3 387.1 389.9 15351.6 16447.6 17210.9 17433.3 17437.2 15407.8 15810.4 16457.6 16460.8 16472.5 4997.6 5138.8 5141.0 5198.0 5203.8 3702.1 5065.6 5752.8 6076.9 6085.8 6114.1 6154.8 6157.7 6166.2 6167.1 4947.6 5229.5 5237.6 5297.1 5324.2 4959.7 5111.7 5248.8 5309.7 5313.1 12546.7 12553.2 15986.8 19441.3 19549.6 1850.5 1859.2 1859.3 1946.1 1976.0 8842.5 8883.8 9284.0 9319.7 9365.6 1718.0 1755.4 1770.2 1771.5 1792.2 65971.3 67631.7 67652.3 67895.7 69180.0 9653.2 9710.1 9761.6 10392.1 10686.0 13572.6 13604.5 13622.5 13637.5 13656.7 7235.3 7294.7 7332.1 7397.6 7489.3 6977.5 6990.6 7020.8 7079.0 7127.6 4175.9 4245.9 4251.0 4274.1 4315.9 1682.5 1797.5 3076.2 3105.5 3254.4 844.8 860.1 885.8 902.2 919.7 15697.7 16223.0 16527.9 16576.8 16818.7 845.2 856.0 877.8 882.9 901.1 8919.5 9127.7 9135.2 9391.3 9454.0 375671.0 381251.0 387594.0 405943.0 420269.0 75052.6 75176.0 77855.6 78938.6 81006.6 428.9 438.4 440.7 444.2 444.5 9379.3 9971.7 10041.3 10260.2 10422.1 35792.7 36765.0 37108.0 38695.2 38780.6 51977.0 52566.7 52906.0 52968.7 53368.0 4753.2 5353.9 6292.7 7353.5 7743.2 10545.0 10857.5 10920.5 11598.7 11682.2 10055.9 10120.4 10299.0 10362.2 10535.9 9569.0 9643.9 9645.5 9698.4 9725.7 10191.6 10270.8 10306.5 10630.9 10718.6 7540.1 7671.5 7703.8 7715.1 7760.0 8679.7 10189.8 10259.7 10272.1 10425.5 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#3] mootools.html Cycles:180 Average:5166.19 Median:5465.16 stddev:2875.88 (52.6%) stddev-sans-first:2869.84 10:10:05 INFO - PROCESS | 25310 | Values: 1376.4 1411.2 1474.0 1656.3 1665.3 6835.3 7444.9 7561.4 8063.8 8064.4 7670.5 7874.3 7920.8 7934.0 7949.2 2229.4 2258.6 2264.7 2264.9 2265.2 2173.8 2185.0 2214.6 2219.6 2220.0 2186.1 2196.0 2214.9 2220.9 2221.3 2102.1 2105.0 2108.1 2108.1 2114.1 2112.6 2139.7 2144.6 2170.5 2179.4 7897.8 7923.9 7943.1 7950.2 8003.4 4488.1 4628.1 4640.1 4641.1 4648.0 2858.3 2913.6 3009.2 3009.6 3022.1 867.6 869.8 891.7 907.0 911.2 10680.4 10684.9 10737.9 10737.9 10739.1 4133.5 4246.0 4285.3 4368.9 4402.4 9178.3 9210.0 9217.4 9232.8 9237.1 4612.2 4659.6 4659.7 4673.9 4686.1 3844.1 4101.6 4187.5 4199.7 4230.4 3745.9 3788.0 3809.7 3831.3 3890.1 1244.6 1246.3 1263.2 1267.1 1268.0 718.8 856.8 857.3 858.7 865.0 5160.4 5215.8 5248.6 5445.9 5484.4 798.6 861.3 885.5 896.3 914.9 3722.8 3809.4 3850.8 3870.2 3901.5 9265.9 9559.5 9632.4 9715.4 9758.2 9518.7 9545.0 9599.0 9612.6 9659.9 6945.0 7169.6 7225.9 7429.8 7433.3 5238.6 5318.4 5486.5 5488.1 5591.5 8695.0 8775.6 9042.0 9060.6 9064.0 8869.2 8911.9 8978.0 9048.7 9071.7 6012.9 6564.1 6673.8 6795.4 6894.7 7491.4 7538.3 7576.9 7641.7 7642.1 6618.4 6851.3 6875.0 6986.7 7013.2 6823.9 6861.0 6895.8 6938.5 7000.8 5888.0 6077.2 6276.6 6278.9 6335.4 4441.5 4442.2 4466.7 4504.2 4594.2 4339.7 4419.8 4435.6 4446.8 4493.6 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#4] prototype.html Cycles:180 Average:4382.85 Median:5001.22 stddev:1263.27 (25.3%) stddev-sans-first:1229.09 10:10:05 INFO - PROCESS | 25310 | Values: 300.4 305.6 309.2 311.2 313.6 4999.0 5003.5 5020.8 5044.8 5048.7 4943.5 4946.9 4957.4 4973.6 4974.2 3675.7 3800.9 3927.7 3949.3 3954.7 3923.7 3939.9 3951.5 3955.4 3960.5 3900.7 3913.8 3922.7 3936.6 3969.8 3830.6 3904.8 3919.4 3921.9 3953.3 3460.8 3485.1 3489.8 3498.0 3498.1 4842.9 4867.1 4882.3 4884.3 4903.4 4314.7 4516.0 4524.7 4539.9 4543.3 5197.7 5218.8 5226.0 5233.7 5245.7 3821.1 3827.4 3835.6 3840.7 3853.0 5322.9 5355.9 5419.7 5450.2 5487.7 3897.4 3906.3 3914.8 3917.7 3924.9 3954.5 3966.6 3977.9 3983.8 4014.1 4487.8 4498.9 4508.9 4523.8 4530.7 5087.8 5183.2 5201.2 5265.1 5269.3 1370.8 1387.4 1389.0 1390.7 1399.7 850.5 874.2 892.8 896.3 900.9 4491.8 4615.4 4664.9 4671.5 4711.4 5333.1 5443.8 5455.5 5460.2 5477.8 4451.9 4561.6 4565.9 4626.3 4632.4 2849.0 2877.9 2883.8 2898.3 2901.8 5050.2 5051.9 5064.0 5086.8 5152.6 5257.4 5491.6 5497.4 5533.5 5584.4 5132.6 5135.2 5136.5 5138.4 5156.5 5472.2 5500.9 5501.3 5510.9 5516.4 5107.2 5352.4 5360.1 5372.8 5387.9 5162.6 5171.7 5182.1 5194.6 5202.5 3858.4 3862.6 3882.9 3889.7 3907.8 5307.4 5350.2 5376.9 5473.5 5557.6 5162.9 5217.8 5233.6 5254.4 5286.2 5253.4 5297.5 5314.0 5316.9 5350.4 5069.9 5189.4 5211.9 5213.4 5218.5 5067.5 5129.0 5284.6 5314.6 5328.4 5193.1 5206.1 5214.7 5217.9 5242.3 10:10:05 INFO - PROCESS | 25310 | 10:10:05 INFO - PROCESS | 25310 | [#5] yui.html Cycles:180 Average:16458.99 Median:25574.66 stddev:22545.79 (88.2%) stddev-sans-first:22577.61 10:10:05 INFO - PROCESS | 25310 | Values: 607.8 673.9 684.2 742.9 751.8 12748.6 13017.0 13099.5 13102.5 13230.3 12711.5 12809.9 12877.5 12891.4 12897.0 611.7 752.9 756.1 769.6 770.4 773.1 774.5 778.9 779.8 780.6 826.0 833.9 835.6 835.8 837.1 823.7 825.0 830.7 830.8 833.9 604.8 606.5 607.6 608.0 608.3 12536.1 12565.7 12568.3 12592.6 12624.9 13311.1 13542.7 13655.4 13909.0 13978.5 10434.6 10502.2 10528.2 10572.9 10638.7 3372.3 3393.9 3400.5 3413.3 3495.1 56317.7 56645.0 56966.4 57652.7 58111.0 10390.5 10553.2 10559.9 10630.4 10804.7 19424.0 19708.6 19767.2 19901.2 20287.6 7114.8 7119.8 7302.1 7337.7 7353.0 3871.2 3885.7 3891.0 3894.1 3899.2 2933.3 2993.0 3005.4 3009.6 3015.3 504.4 529.8 549.8 551.8 554.3 577.8 594.8 617.9 625.7 635.3 7563.2 7988.8 8090.4 8106.9 8197.4 474.7 570.0 601.8 603.5 612.8 3988.0 4043.5 4076.1 4098.2 4099.8 56020.2 56976.4 97838.0 98430.5 99610.5 50619.5 73553.9 81072.0 84748.0 86442.0 48564.0 48947.0 49422.8 61331.0 81239.6 8115.9 8212.3 8661.6 8700.6 8748.9 42407.4 43646.6 43685.6 44099.6 44560.3 62268.7 62543.4 62595.0 62676.0 62973.7 10411.5 10647.5 10699.4 10735.5 10805.6 12166.9 12483.8 12698.9 12826.0 12890.9 11147.5 11196.2 11474.9 11937.5 12039.7 11312.4 11541.4 11644.1 11777.7 11908.3 9943.4 10056.0 10329.1 11428.5 11608.3 9125.4 9609.4 9660.0 9999.6 10591.4 9591.4 9858.2 9909.4 9917.2 9954.9 10:10:05 INFO - PROCESS | 25310 | -------- Summary: end -------- 10:10:05 INFO - PROCESS | 25310 | 10:10:06 INFO - TEST-INFO | 25310: exit 0 10:10:06 INFO - TEST-OK | dromaeo_css | took 1115679ms 10:10:06 INFO - TEST-START | kraken 10:10:06 INFO - operating with platform_type : linux_ 10:10:06 INFO - Initialising browser for kraken test... 10:10:06 INFO - TEST-INFO | started process 25548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUKVwO/profile http://localhost:37883/getInfo.html) 10:10:11 INFO - PROCESS | 25548 | __metrics Screen width/height:1600/1200 10:10:11 INFO - PROCESS | 25548 | colorDepth:24 10:10:11 INFO - PROCESS | 25548 | Browser inner width/height: 1024/697 10:10:11 INFO - PROCESS | 25548 | __metrics 10:10:12 ERROR - PROCESS | 25548 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:10:13 INFO - TEST-INFO | 25548: exit 0 10:10:13 INFO - Browser initialized. 10:10:13 INFO - Running cycle 1/1 for kraken test... 10:10:13 INFO - TEST-INFO | started process 25666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIUKVwO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:25 INFO - PROCESS | 25666 | RSS: Main: 186150912 10:10:25 INFO - PROCESS | 25666 | 10:10:27 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37883/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:28 INFO - PROCESS | 25666 | RSS: Main: 190513152 10:10:28 INFO - PROCESS | 25666 | 10:10:31 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37883/tests/kraken/driver.html?testName=audio-dft) 10:10:32 INFO - PROCESS | 25666 | RSS: Main: 190283776 10:10:32 INFO - PROCESS | 25666 | 10:10:35 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37883/tests/kraken/driver.html?testName=audio-fft) 10:10:36 INFO - PROCESS | 25666 | RSS: Main: 186126336 10:10:36 INFO - PROCESS | 25666 | 10:10:38 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37883/tests/kraken/driver.html?testName=audio-oscillator) 10:10:38 INFO - PROCESS | 25666 | RSS: Main: 186515456 10:10:38 INFO - PROCESS | 25666 | 10:10:41 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37883/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:41 INFO - PROCESS | 25666 | RSS: Main: 187125760 10:10:41 INFO - PROCESS | 25666 | 10:10:44 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37883/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:45 INFO - PROCESS | 25666 | RSS: Main: 187174912 10:10:45 INFO - PROCESS | 25666 | 10:10:49 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37883/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:49 INFO - PROCESS | 25666 | RSS: Main: 184995840 10:10:49 INFO - PROCESS | 25666 | 10:10:52 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37883/tests/kraken/driver.html?testName=json-parse-financial) 10:10:53 INFO - PROCESS | 25666 | RSS: Main: 185880576 10:10:53 INFO - PROCESS | 25666 | 10:10:55 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37883/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:55 INFO - PROCESS | 25666 | RSS: Main: 186494976 10:10:55 INFO - PROCESS | 25666 | 10:10:57 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:58 INFO - PROCESS | 25666 | RSS: Main: 186171392 10:10:58 INFO - PROCESS | 25666 | 10:11:00 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:01 INFO - PROCESS | 25666 | RSS: Main: 186425344 10:11:01 INFO - PROCESS | 25666 | 10:11:03 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:04 INFO - PROCESS | 25666 | RSS: Main: 186904576 10:11:04 INFO - PROCESS | 25666 | 10:11:07 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:08 INFO - PROCESS | 25666 | RSS: Main: 186785792 10:11:08 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | Cycle 1(1): loaded http://localhost:37883/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37883/tests/kraken/driver.html?testName=ai-astar) 10:11:10 INFO - PROCESS | 25666 | RSS: Main: 188006400 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | __start_tp_report 10:11:10 INFO - PROCESS | 25666 | _x_x_mozilla_page_load 10:11:10 INFO - PROCESS | 25666 | _x_x_mozilla_page_load_details 10:11:10 INFO - PROCESS | 25666 | |i|pagename|runs| 10:11:10 INFO - PROCESS | 25666 | |0;ai-astar;114;109;114;113;115;115;116;118;114;114 10:11:10 INFO - PROCESS | 25666 | |1;audio-beat-detection;166;144;157;184;134;171;153;134;203;134 10:11:10 INFO - PROCESS | 25666 | |2;audio-dft;163;168;171;163;164;161;164;163;162;161 10:11:10 INFO - PROCESS | 25666 | |3;audio-fft;76;77;76;163;76;75;76;75;159;75 10:11:10 INFO - PROCESS | 25666 | |4;audio-oscillator;88;87;142;86;87;87;143;88;88;131 10:11:10 INFO - PROCESS | 25666 | |5;imaging-gaussian-blur;117;120;118;118;118;117;117;117;118;118 10:11:10 INFO - PROCESS | 25666 | |6;imaging-darkroom;149;150;148;148;148;148;147;147;148;148 10:11:10 INFO - PROCESS | 25666 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;96;96 10:11:10 INFO - PROCESS | 25666 | |8;json-parse-financial;65;65;65;63;64;63;64;63;64;64 10:11:10 INFO - PROCESS | 25666 | |9;json-stringify-tinderbox;66;66;66;66;65;66;65;65;74;66 10:11:10 INFO - PROCESS | 25666 | |10;stanford-crypto-aes;87;85;85;85;87;91;85;86;121;84 10:11:10 INFO - PROCESS | 25666 | |11;stanford-crypto-ccm;131;134;129;129;141;130;140;149;147;133 10:11:10 INFO - PROCESS | 25666 | |12;stanford-crypto-pbkdf2;183;178;175;180;174;172;172;171;166;168 10:11:10 INFO - PROCESS | 25666 | |13;stanford-crypto-sha256-iterative;67;66;68;69;70;67;71;67;67;67 10:11:10 INFO - PROCESS | 25666 | __end_tp_report 10:11:10 INFO - PROCESS | 25666 | __start_cc_report 10:11:10 INFO - PROCESS | 25666 | _x_x_mozilla_cycle_collect,1010 10:11:10 INFO - PROCESS | 25666 | __end_cc_report 10:11:10 INFO - PROCESS | 25666 | __startTimestamp1465578670254__endTimestamp 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | ------- Summary: start ------- 10:11:10 INFO - PROCESS | 25666 | Number of tests: 14 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:2.30 (2.0%) stddev-sans-first:2.44 10:11:10 INFO - PROCESS | 25666 | Values: 114.0 109.0 114.0 113.0 115.0 115.0 116.0 118.0 114.0 114.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#1] audio-beat-detection Cycles:10 Average:158.00 Median:161.50 stddev:23.30 (14.4%) stddev-sans-first:24.53 10:11:10 INFO - PROCESS | 25666 | Values: 166.0 144.0 157.0 184.0 134.0 171.0 153.0 134.0 203.0 134.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.16 (1.9%) stddev-sans-first:3.33 10:11:10 INFO - PROCESS | 25666 | Values: 163.0 168.0 171.0 163.0 164.0 161.0 164.0 163.0 162.0 161.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.96 (47.3%) stddev-sans-first:37.63 10:11:10 INFO - PROCESS | 25666 | Values: 76.0 77.0 76.0 163.0 76.0 75.0 76.0 75.0 159.0 75.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:87.00 stddev:25.02 (28.8%) stddev-sans-first:25.97 10:11:10 INFO - PROCESS | 25666 | Values: 88.0 87.0 142.0 86.0 87.0 87.0 143.0 88.0 88.0 131.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 10:11:10 INFO - PROCESS | 25666 | Values: 117.0 120.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 10:11:10 INFO - PROCESS | 25666 | Values: 149.0 150.0 148.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:11:10 INFO - PROCESS | 25666 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 10:11:10 INFO - PROCESS | 25666 | Values: 65.0 65.0 65.0 63.0 64.0 63.0 64.0 63.0 64.0 64.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:2.68 (4.1%) stddev-sans-first:2.83 10:11:10 INFO - PROCESS | 25666 | Values: 66.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 74.0 66.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:85.50 stddev:11.21 (13.1%) stddev-sans-first:11.85 10:11:10 INFO - PROCESS | 25666 | Values: 87.0 85.0 85.0 85.0 87.0 91.0 85.0 86.0 121.0 84.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:137.00 stddev:7.47 (5.5%) stddev-sans-first:7.67 10:11:10 INFO - PROCESS | 25666 | Values: 131.0 134.0 129.0 129.0 141.0 130.0 140.0 149.0 147.0 133.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.50 stddev:5.28 (3.0%) stddev-sans-first:4.46 10:11:10 INFO - PROCESS | 25666 | Values: 183.0 178.0 175.0 180.0 174.0 172.0 172.0 171.0 166.0 168.0 10:11:10 INFO - PROCESS | 25666 | 10:11:10 INFO - PROCESS | 25666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.60 (2.4%) stddev-sans-first:1.66 10:11:10 INFO - PROCESS | 25666 | Values: 67.0 66.0 68.0 69.0 70.0 67.0 71.0 67.0 67.0 67.0 10:11:10 INFO - PROCESS | 25666 | -------- Summary: end -------- 10:11:10 INFO - PROCESS | 25666 | 10:11:11 INFO - TEST-INFO | 25666: exit 0 10:11:11 INFO - TEST-OK | kraken | took 64588ms 10:11:11 INFO - SUITE-END | took 1180s 10:11:11 INFO - Completed test suite (00:19:40) 10:11:11 INFO - javascript benchmark 10:11:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6407.771253595782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.870856457177, 2657.986710066449, 2673.4786716590274, 2681.2492502099417, 2681.6245725598405, 4712.505186955372, 4761.619070474362, 4791.832285869995, 4878.0731660984475, 4901.68139070961, 4665.440147182343, 4747.6676632635645, 4754.595859351959, 4811.951880481194, 4833.371661683985, 4332.913341733163, 4412.75729834859, 4460.1525710114975, 4483.103379324149, 4492.820287188509, 620.5553223813718, 4309.159713855799, 4381.561843815625, 4400.44994375703, 4432.867013989569, 4355.041890784022, 4376.168527979689, 4388.868333949987, 4392.165488557164, 4422.778861056934, 4297.462817147856, 4393.406890069831, 4395.780210989437, 4428.778561071934, 4429.645628349725, 4295.763732994684, 4321.675874309408, 4327.0913108247305, 4328.956710432918, 4336.501302350207, 4726.149293127236, 4768.0463907218345, 4794.904101917942, 4804.975975120137, 4824.758762061918, 5022.196448568248, 5057.317262169597, 5137.51193636604, 5159.871003224912, 5185.299984502081, 5182.585393168538, 5206.609504287194, 5210.869728256824, 5226.608004399647, 5237.083510385705, 4837.637177211724, 4839.080574690797, 4840.128776820171, 4856.368672072678, 4857.417109946829, 5204.115300398941, 5227.085260079471, 5246.108161612458, 5246.868828279324, 5320.414754377015, 5036.219385995177, 5036.219385995177, 5063.8987220255385, 5064.924026139611, 5102.795888164432, 5050.949490505048, 5120.385553733576, 5131.897362052813, 5139.820106296262, 5149.304843846107, 5059.848204553869, 5073.822416215488, 5105.668131571436, 5107.795688172506, 5108.208227724708, 5001.624878134155, 5049.394072711299, 5086.338775959176, 5108.055009823194, 5127.41034781005, 4201.306784380543, 4284.121755040209, 4315.633171180422, 4330.58859408362, 4372.868813935524, 3731.8320675569666, 3756.4740936268945, 3773.716971227169, 3779.829907654162, 3805.429185622179, 4516.932246016312, 4519.661025423106, 4532.161550113174, 4534.093181363741, 4579.22153233951, 5164.2770012198325, 5182.455842136596, 5188.0661480933795, 5201.349831271091, 5246.97376513115, 4546.158960592301, 4561.042181141997, 4573.108243892409, 4580.1068791585985, 4594.1271158479785, 4599.6090332321455, 4650.6046986005895, 4652.418447694038, 4660.137874493162, 4700.388949436551, 4791.832285870048, 4849.442314133778, 4881.609471242221, 4896.608271338356, 4926.433460152129, 5139.691618502902, 5167.9922415128685, 5185.066687996197, 5194.97402512985, 5204.947950520446, 4895.534924182197, 4899.216125419915, 4901.068796928572, 4903.436104847988, 4940.654154209171, 4984.37695288089, 5006.349174607278, 5013.724245166405, 5017.62367822422, 5025.874353141201, 5067.87330316745, 5103.642745007814, 5105.285260063668, 5117.616178786531, 5152.742362881916, 4965.875853103701, 4968.627352948615, 4970.676906001098, 4991.101601711727, 5032.295478632921, 4892.633052521004, 5014.84955451337, 5038.84883453497, 5048.949510504995, 5071.721055341844, 4879.878003049952, 4883.340748998982, 4906.975465122651, 4946.678465899705, 4947.1589829729755, 4958.082754690394, 4994.850154495371, 5024.196128619404, 5039.420466646383, 5088.542031217208, 4955.752212389438, 4956.876078097932, 4958.082754690394, 4963.404391473046, 4997.425296090996], "value": 4688.568791472201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4725063938619, 579.1457600039939, 588.2676068294973, 606.3421188011008, 617.6849806598633, 33196.33607327855, 37300.25399492009, 37322.626773732285, 37452.625473745255, 37558.812205939, 39036.0, 39320.80339598305, 39600.40599391004, 39637.0, 39667.20665586694, 7728.111267204274, 7796.532208067534, 7800.882986755203, 7802.960985195066, 7873.173316801739, 7674.884876726854, 7745.264199901, 7804.960975195116, 7816.687332506693, 7825.647845846951, 7850.175731548191, 7862.724804631839, 7863.0, 7863.803404914895, 7895.210478952116, 7804.687812487494, 7810.336121429686, 7817.413693972918, 7859.410544209179, 7865.056193256789, 7771.7279895203965, 7836.6081695915545, 7843.686252549891, 7843.960780196119, 7847.0, 30142.24644383886, 36658.45012324791, 36980.260394792225, 36996.26007479835, 37098.25803483915, 2824.1988619347194, 3002.1293824790782, 3027.3793872256356, 3079.461094308487, 3106.4718997770433, 27752.583711244348, 30084.8495757522, 30149.0, 30605.846970765226, 30792.8460357699, 3535.116220944764, 3651.47053677218, 3656.4880916671686, 3660.5058317127114, 3714.4985426967282, 253153.0, 253944.0, 255678.0, 257309.0, 257942.0, 57242.71378643163, 57975.420245797, 58370.0, 58578.0, 58663.70668146717, 34898.651013490045, 35687.0, 35697.0, 60681.69659151676, 60803.39196608066, 15038.699226015637, 15113.54659360221, 15182.316795744218, 15249.847501524842, 15265.465708700141, 10500.212484063726, 10608.787824243473, 10631.0, 10742.516586753614, 10801.189910756724, 19278.13248403825, 19295.51761205953, 19317.80682193188, 19346.80653193478, 19365.80634193668, 7341.596212208273, 7491.887621685679, 7553.0739661386, 7642.5032372895585, 7689.50018248812, 837.2757564706485, 887.4143065576817, 901.3400718286474, 927.4249965021729, 990.5691024404407, 28356.574651380244, 28379.290517737223, 28658.856705716757, 28951.7104828949, 29284.560731589045, 954.2747511890874, 989.4805227255605, 1010.3988127064385, 1011.8684571005722, 1048.5334026358198, 14526.927365363106, 14779.313753388496, 14944.327505262288, 15026.774598381033, 15034.69930601382, 199597.0, 199613.0, 200885.0, 200932.0, 201077.0, 49938.0, 50244.24633630498, 50257.24614130791, 50478.95210478923, 50481.747591262545, 1160.3907948327028, 1169.0997931592797, 1200.7178313096415, 1206.6741979665617, 1208.8065909454444, 26992.865035674695, 27404.0, 28194.718052819208, 28350.858245709464, 28553.0, 44373.55626443694, 44660.0, 44844.55155448404, 45160.77419612881, 45412.31881521846, 361213.0, 361850.0, 363219.0, 363869.0, 364179.0, 25643.102491412712, 25925.481490370465, 26085.478290434465, 26170.0, 26801.329966750985, 38660.420093698056, 39441.60558394379, 39492.0, 41982.0, 43755.56244437515, 35306.293874122886, 36626.63373366339, 36910.26179476342, 36939.0, 37322.44016339811, 35315.29369412546, 35648.10879728028, 35949.46075808813, 36264.0, 36449.817750911076, 35534.822325888206, 35643.46534801928, 36478.4528232082, 37635.0, 37759.81120094382, 31225.68774312228, 33653.15867103244, 33692.83153584216, 33695.663043369255, 34124.488132678525, 25594.232173034838, 25825.483490330465, 26066.86966565155, 26181.214563563124, 26457.60313595259], "value": 17376.64483024669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.92189640175565, 376.8831662184722, 380.3287198095362, 387.146342315195, 389.8888816687245, 15351.616209594766, 16447.588810279733, 17210.91394543027, 17433.30266789327, 17437.21532531036, 15407.845921540782, 15810.367585296573, 16457.588560286, 16460.83539164608, 16472.505824825275, 4997.550220480156, 5138.768755405997, 5141.0, 5198.0383629028565, 5203.843884683447, 3702.1114932416294, 5065.632279284591, 5752.7986520471795, 6076.878462430749, 6085.817425477243, 6114.144019837227, 6154.753809847623, 6157.7229024694, 6166.167567378414, 6167.105769663419, 4947.6289278304275, 5229.503197196279, 5237.6071794615555, 5297.073012222845, 5324.201369794523, 4959.6528243023, 5111.667741596784, 5248.8425347239645, 5309.654872433318, 5313.149896016619, 12546.68633284166, 12553.246805191719, 15986.840131598768, 19441.31955381569, 19549.609007819763, 1850.463365623981, 1859.237712537853, 1859.3120545398153, 1946.143696773415, 1976.0, 8842.5136617486, 8883.822323553493, 9284.0, 9319.720408387759, 9365.625374984993, 1717.9828201717949, 1755.3943889358152, 1770.2299499717665, 1771.495123889698, 1792.1576858876308, 65971.340286597, 67631.66184169048, 67652.3234767651, 67895.66052169708, 69180.0, 9653.22774178064, 9710.126088652056, 9761.609535618496, 10392.116670082976, 10686.0, 13572.592822215349, 13604.523841665494, 13622.523211687543, 13637.454501820015, 13656.658583535293, 7235.2764723527225, 7294.744683936036, 7332.0834895638045, 7397.593132377663, 7489.325960663567, 6977.476689248327, 6990.580565166107, 7020.7893763187185, 7079.0, 7127.643617819192, 4175.874723758292, 4245.8513952011535, 4251.0, 4274.123804620045, 4315.856298081011, 1682.4532027091, 1797.478731167973, 3076.215565030903, 3105.503119500869, 3254.397936381777, 844.7761343244046, 860.1441565642226, 885.8095509465496, 902.1835239108617, 919.6505327975326, 15697.68604627901, 16223.0, 16527.91736041312, 16576.83423165753, 16818.747718784227, 845.2055068235838, 855.9700410485727, 877.7761670773912, 882.8940527136784, 901.1304091551553, 8919.464832110094, 9127.726168214964, 9135.223506002065, 9391.34260601765, 9454.0, 375671.0, 381251.0, 387594.0, 405943.0, 420269.0, 75052.62473687597, 75176.0, 77855.61072194602, 78938.6053069731, 81006.5949670248, 428.8670512141246, 438.41909469951804, 440.6871121503704, 444.2470013327379, 444.50215758350856, 9379.343445958717, 9971.700848974542, 10041.297109202285, 10260.230482713678, 10422.114120299859, 35792.74725384599, 36765.0, 37108.0, 38695.226095478494, 38780.6121938777, 51977.0, 52566.737166315455, 52906.0, 52968.73515632397, 53368.0, 4753.168195565693, 5353.892922141457, 6292.748290068346, 7353.522021068614, 7743.186965368781, 10545.0, 10857.457127143769, 10920.453977300944, 11598.71003224926, 11682.182247242952, 10055.89944100579, 10120.392776433144, 10299.0, 10362.171026317727, 10535.947320263349, 9569.0, 9643.855342169732, 9645.517724113626, 9698.418094914328, 9725.6596019139, 10191.592336306465, 10270.794584108127, 10306.484675766033, 10630.946845265724, 10718.624848130277, 7540.1328847181085, 7671.53970761756, 7703.807404814925, 7715.074191097105, 7759.961200193963, 8679.739607811776, 10189.796204075728, 10259.742856571542, 10272.126869216201, 10425.478726063819], "value": 7901.9084288618615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.394386469953, 1411.1674112273759, 1473.9631509212268, 1656.320908427545, 1665.2839279109985, 6835.28229535899, 7444.8883266751045, 7561.357284630806, 8063.758087257392, 8064.395170362224, 7670.501417407864, 7874.330681892032, 7920.762377128681, 7934.047914250284, 7949.24482174194, 2229.4314949687846, 2258.6499092640665, 2264.682944387787, 2264.852784569006, 2265.229821860567, 2173.7826217378215, 2185.0495034659893, 2214.6345852934246, 2219.600471915063, 2219.966700499494, 2186.147402513021, 2195.967060494094, 2214.867107973527, 2220.888955552224, 2221.2891874600136, 2102.075086961732, 2104.9579008419823, 2108.082983902, 2108.1251280718484, 2114.0803750368486, 2112.588045331161, 2139.689744986968, 2144.571085782834, 2170.4790850195996, 2179.3788770200576, 7897.842043159105, 7923.920760792376, 7943.086545047278, 7950.204979502061, 8003.439759216857, 4488.124815660947, 4628.09752098341, 4640.141573808856, 4641.141388843075, 4647.95352046482, 2858.3140046388717, 2913.6212292402065, 3009.217603423104, 3009.5636132760847, 3022.07826612883, 867.6052396159732, 869.8390797702382, 891.7057371067597, 906.9727908162765, 911.22090612526, 10680.35917844924, 10684.946575267073, 10737.892621073768, 10737.946310268399, 10739.087177589914, 4133.46264985556, 4246.023414614656, 4285.292926667127, 4368.868933931987, 4402.449693788277, 9178.265738740885, 9209.953950230207, 9217.400868943498, 9232.769180770534, 9237.07629237071, 4612.238980568169, 4659.5573420525, 4659.673822832369, 4673.929891051637, 4686.133065382915, 3844.115853353744, 4101.610347017088, 4187.455630768041, 4199.727017743837, 4230.365445183185, 3745.9438108428394, 3787.981060094682, 3809.7142714296538, 3831.3103641344824, 3890.0663840678035, 1244.6017274472263, 1246.3145270101409, 1263.2357423758679, 1267.1320145700224, 1268.042627815993, 718.8059224009488, 856.7858035491128, 857.2970164465079, 858.6512600856585, 864.9654013839375, 5160.354955630546, 5215.7913683453, 5248.580113590903, 5445.918311225335, 5484.396716361197, 798.6206551887923, 861.2851333393269, 885.4642941020719, 896.2516298890499, 914.9496777677292, 3722.813859307024, 3809.4476300936763, 3850.7689538627774, 3870.2259548089933, 3901.49280593521, 9265.907340926638, 9559.522023898777, 9632.373895696757, 9715.417074975525, 9758.170555502862, 9518.714438566854, 9544.952275238718, 9598.95200524007, 9612.615495380107, 9659.855102173473, 6945.027696122547, 7169.641517924188, 7225.855482890418, 7429.8142546436775, 7433.293837085468, 5238.580913526833, 5318.361796584435, 5486.506214440719, 5488.094464413327, 5591.4688104629995, 8694.956525217334, 8775.561221939006, 9041.954790226007, 9060.592273347584, 9063.954680226556, 8869.246114080375, 8911.910880891108, 8978.0, 9048.728538143867, 9071.682491112779, 6012.909806352821, 6564.081028656087, 6673.833154171185, 6795.38841504267, 6894.689738961659, 7491.438142139253, 7538.3215510604305, 7576.886346704694, 7641.694332226649, 7642.08295004603, 6618.371254730793, 6851.2806155354965, 6875.037494750839, 6986.6855991481525, 7013.158420989514, 6823.89764153548, 6861.039454476278, 6895.75864844728, 6938.479614028867, 7000.7549735759, 5887.970560147171, 6077.20996270482, 6276.592021518587, 6278.874422511432, 6335.3981371769605, 4441.51143374235, 4442.244818380947, 4466.731996080245, 4504.166729155117, 4594.21898277287, 4339.717918335298, 4419.779011049499, 4435.622972047412, 4446.755428451466, 4493.618042466427], "value": 4169.276299758706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3962036307023, 305.6469777407094, 309.1991741389801, 311.1784887895955, 313.5766714934837, 4998.975005124974, 5003.474635163306, 5020.849374518762, 5044.84865454036, 5048.697078175312, 4943.528235882059, 4946.936408672134, 4957.355543779313, 4973.602111831054, 4974.154393753061, 3675.724320675953, 3800.885973420788, 3927.743122200897, 3949.2891279569667, 3954.742941708794, 3923.705722070842, 3939.9015024624327, 3951.466552015484, 3955.4462375267485, 3960.465337179487, 3900.7074469414765, 3913.8238779255003, 3922.686185105185, 3936.5866584008695, 3969.8412063517426, 3830.6209764484765, 3904.824282907276, 3919.412088186766, 3921.941170882439, 3953.2884080865433, 3460.7750496217664, 3485.146139195888, 3489.8080605566684, 3498.0, 3498.1079824644808, 4842.878928026792, 4867.099586576494, 4882.316475693406, 4884.267359896008, 4903.362562866804, 4314.71954322968, 4516.0, 4524.6606504511965, 4539.931901021488, 4543.273076307808, 5197.740112994373, 5218.799676074486, 5226.007058658843, 5233.712145831978, 5245.659032162897, 3821.0638393593467, 3827.3876179811095, 3835.6356146166067, 3840.6735427488697, 3853.0367408147963, 5322.866928326823, 5355.919661205085, 5419.729013549346, 5450.236966824647, 5487.6981766002855, 3897.4215442745735, 3906.257811015898, 3914.823832927525, 3917.6865850731874, 3924.8626298080003, 3954.54522729884, 3966.5636779954184, 3977.8806635800393, 3983.7609743415487, 4014.136960553495, 4487.753173575419, 4498.865034048984, 4508.887277818015, 4523.7964291606295, 4530.682852200314, 5087.796488140507, 5183.222516622462, 5201.219817027476, 5265.1049321614655, 5269.314989051399, 1370.8286464191976, 1387.424218949145, 1388.9860401906665, 1390.65928847431, 1399.7332414165196, 850.5152063323969, 874.2306770042322, 892.7634176943116, 896.3053633434141, 900.8513595256841, 4491.797869095899, 4615.423072115986, 4664.86005419838, 4671.458418721813, 4711.363965864564, 5333.120035194227, 5443.7822487100075, 5455.481729235717, 5460.208269800856, 5477.780888764405, 4451.933221001687, 4561.589456948891, 4565.908681826345, 4626.306054091913, 4632.444106707149, 2849.0, 2877.8992735254583, 2883.7692984561604, 2898.347871728844, 2901.7678585713093, 5050.242463630485, 5051.873703157377, 5063.974680126576, 5086.821961231413, 5152.587792976553, 5257.369115706139, 5491.615586908878, 5497.422770609109, 5533.474319939599, 5584.385717571064, 5132.589392848563, 5135.15269980449, 5136.5377116059735, 5138.357705286764, 5156.484351564814, 5472.2065300531995, 5500.917486237629, 5501.257330260363, 5510.91733624004, 5516.393196748435, 5107.197320814627, 5352.357717073976, 5360.115580929103, 5372.838814835562, 5387.865303367447, 5162.6386152970435, 5171.6896986179445, 5182.144946084005, 5194.584433245407, 5202.479752024768, 3858.4405261237525, 3862.594427585063, 3882.864099756495, 3889.7277190596387, 3907.824147913294, 5307.389650190277, 5350.224217488365, 5376.946230537801, 5473.452654734495, 5557.555395568425, 5162.8967420652125, 5217.81737639196, 5233.633645644768, 5254.448282930237, 5286.233496143114, 5253.395859476209, 5297.54970827484, 5313.973430132824, 5316.867078322918, 5350.357957045024, 5069.898602027865, 5189.377274727057, 5211.872876274205, 5213.374395072616, 5218.478152184751, 5067.493250674903, 5129.0, 5284.630075894651, 5314.62797604164, 5328.440513746001, 5193.091209038327, 5206.0997735825395, 5214.739263036909, 5217.947820521898, 5242.2922905408805], "value": 3979.686394701561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.790312342242, 673.8854394752891, 684.2241156726055, 742.8737114690502, 751.8345963887942, 12748.553800616968, 13017.0, 13099.54151604694, 13102.475900963975, 13230.338483075831, 12711.491540338375, 12809.935950320236, 12877.484900603964, 12891.419886105125, 12897.0, 611.6819253987924, 752.8945947567345, 756.0662581711596, 769.638270013093, 770.4144849914078, 773.0568706178482, 774.508187301065, 778.8948491953598, 779.7582749347692, 780.6409051836163, 825.9628316725762, 833.8999320081599, 835.6364981233153, 835.8453686068096, 837.0875745437472, 823.7075838077457, 824.9711260105897, 830.6926437218208, 830.8296799156159, 833.9499630022218, 604.8276241271261, 606.5178183344252, 607.6263098194622, 607.9969600152015, 608.3399511529951, 12536.122471427003, 12565.74868502634, 12568.30874301913, 12592.622221333375, 12624.936875315656, 13311.069894865288, 13542.661433464144, 13655.38550765208, 13909.0, 13978.510752123728, 10434.634787782392, 10502.159827213805, 10528.157747380192, 10572.866921362673, 10638.734031649194, 3372.291818718072, 3393.9490907636405, 3400.4559270516847, 3413.300273443963, 3495.0912762681633, 56317.71841140768, 56645.0, 56966.43033569694, 57652.711736441466, 58111.0, 10390.48047597617, 10553.155747540332, 10559.947200264103, 10630.415327156927, 10804.729881753019, 19424.0, 19708.605827883363, 19767.23258743777, 19901.20889119957, 20287.594248114954, 7114.750983715545, 7119.822004449827, 7302.05073340473, 7337.74317898871, 7352.96323518379, 3871.1676989447406, 3885.669718073995, 3891.0, 3894.123822139996, 3899.2396482685604, 2933.2960089578773, 2993.027266138514, 3005.443992861328, 3009.5786589877434, 3015.321552650636, 504.36953807740326, 529.8251576979587, 549.7636016512938, 551.8179000929683, 554.3264933106295, 577.8324285957025, 594.7710131599365, 617.9258488981351, 625.7371903800415, 635.2948227467507, 7563.205863384375, 7988.760337189894, 8090.4336696431865, 8106.878396824052, 8197.385196110316, 474.74126601002536, 569.9772009119672, 601.7562887030759, 603.538293205698, 612.8253447767365, 3988.0, 4043.4541336919137, 4076.144009757984, 4098.159877225162, 4099.815508302134, 56020.15969760457, 56976.43023569794, 97838.0, 98430.50784746173, 99610.5019474898, 50619.49380506148, 73553.89669154967, 81072.0, 84748.0, 86442.0, 48564.0, 48947.0, 49422.752886236056, 61331.0, 81239.5938020318, 8115.878261825959, 8212.301954333949, 8661.61022753965, 8700.564971751513, 8748.91251087481, 42407.3638895423, 43646.56353436425, 43685.56314436815, 44099.55900441083, 44560.331595025455, 62268.68865655643, 62543.374566253755, 62595.0, 62676.0, 62973.68513157405, 10411.47942602882, 10647.467626618483, 10699.358038517714, 10735.46322683847, 10805.621803236849, 12166.939165304117, 12483.812742809047, 12698.936505317415, 12826.0, 12890.935545322214, 11147.498362573542, 11196.229223517737, 11474.94262528682, 11937.46281417321, 12039.699007524881, 11312.434378281218, 11541.36522491271, 11644.126690498417, 11777.705557361134, 11908.345041022827, 9943.403395796275, 10056.0, 10329.12202462769, 11428.485718142538, 11608.30350178992, 9125.361224714206, 9609.375390599589, 9660.044767767196, 9999.600015999278, 10591.417472038804, 9591.42451452915, 9858.162056225301, 9909.405435673883, 9917.15704165154, 9954.850677239703], "value": 6479.597552771172, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 113.0, 115.0, 115.0, 116.0, 118.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 144.0, 157.0, 184.0, 134.0, 171.0, 153.0, 134.0, 203.0, 134.0], "value": 158.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 171.0, 163.0, 164.0, 161.0, 164.0, 163.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 163.0, 76.0, 75.0, 76.0, 75.0, 159.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 142.0, 86.0, 87.0, 87.0, 143.0, 88.0, 88.0, 131.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 74.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 87.0, 91.0, 85.0, 86.0, 121.0, 84.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 129.0, 129.0, 141.0, 130.0, 140.0, 149.0, 147.0, 133.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 178.0, 175.0, 180.0, 174.0, 172.0, 172.0, 171.0, 166.0, 168.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 69.0, 70.0, 67.0, 71.0, 67.0, 67.0, 67.0], "value": 67.9, "unit": "score"}]}]} 10:11:11 INFO - Return code: 0 10:11:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:11 ERROR - # TBPL SUCCESS # 10:11:11 INFO - Running post-action listener: _resource_record_post_action 10:11:11 INFO - ##### 10:11:11 INFO - ##### Finished run-tests step (success) 10:11:11 INFO - ##### 10:11:11 INFO - Running post-run listener: _resource_record_post_run 10:11:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 524988416; Read time: 0; Write time: 418284 10:11:11 INFO - TinderboxPrint: CPU usage
13.4% 10:11:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:11:11 INFO - TinderboxPrint: I/O write bytes / time
524,988,416 / 418,284 10:11:11 INFO - TinderboxPrint: CPU idle
8,266.4 (86.6%) 10:11:11 INFO - TinderboxPrint: CPU user
1,228.2 (12.9%) 10:11:11 INFO - TinderboxPrint: Swap in / out
0 / 0 10:11:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238030848; Read time: 0; Write time: 235564 10:11:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286957568; Read time: 0; Write time: 182720 10:11:12 INFO - Running post-run listener: _upload_blobber_files 10:11:12 INFO - Blob upload gear active. 10:11:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:12 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 10:11:12 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'] 10:11:12 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 10:11:12 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:14 INFO - (blobuploader) - INFO - Done attempting. 10:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:20 INFO - (blobuploader) - INFO - Done attempting. 10:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:21 INFO - (blobuploader) - INFO - Done attempting. 10:11:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:21 INFO - Return code: 0 10:11:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d685d23f06916d50c7c12b51a13b99a9cbea52d8b1ad9a1edff9a171bc7948e7754c06eb66edb34bbf57abc9050c6878255c6bf1b098f43443671801067acd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b55a00e3a7b018da535401a0425e9972874bd7054660250253abdae8615597830004854e7714db31694fc95b931142b063880758c88d9bf5f83ab4bf1105cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e96ac9ddff209ce5b314ba5eff6219c761c639977c22f2bbf091da3f16dcb4a91b960f0f02c076a52ab2e67adee8525a92d55a9a4c5b9bb227c0bdd09c57557f"} 10:11:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:21 INFO - Contents: 10:11:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d685d23f06916d50c7c12b51a13b99a9cbea52d8b1ad9a1edff9a171bc7948e7754c06eb66edb34bbf57abc9050c6878255c6bf1b098f43443671801067acd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b55a00e3a7b018da535401a0425e9972874bd7054660250253abdae8615597830004854e7714db31694fc95b931142b063880758c88d9bf5f83ab4bf1105cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e96ac9ddff209ce5b314ba5eff6219c761c639977c22f2bbf091da3f16dcb4a91b960f0f02c076a52ab2e67adee8525a92d55a9a4c5b9bb227c0bdd09c57557f"} 10:11:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:21 INFO - Copying logs to upload dir... 10:11:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.967852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-10 10:11:21.419429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:21.423014) ========= 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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 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/4d685d23f06916d50c7c12b51a13b99a9cbea52d8b1ad9a1edff9a171bc7948e7754c06eb66edb34bbf57abc9050c6878255c6bf1b098f43443671801067acd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b55a00e3a7b018da535401a0425e9972874bd7054660250253abdae8615597830004854e7714db31694fc95b931142b063880758c88d9bf5f83ab4bf1105cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e96ac9ddff209ce5b314ba5eff6219c761c639977c22f2bbf091da3f16dcb4a91b960f0f02c076a52ab2e67adee8525a92d55a9a4c5b9bb227c0bdd09c57557f"} build_url:https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/LM8w9gTbTIuw3PWDZiQgVQ/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/4d685d23f06916d50c7c12b51a13b99a9cbea52d8b1ad9a1edff9a171bc7948e7754c06eb66edb34bbf57abc9050c6878255c6bf1b098f43443671801067acd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85b55a00e3a7b018da535401a0425e9972874bd7054660250253abdae8615597830004854e7714db31694fc95b931142b063880758c88d9bf5f83ab4bf1105cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e96ac9ddff209ce5b314ba5eff6219c761c639977c22f2bbf091da3f16dcb4a91b960f0f02c076a52ab2e67adee8525a92d55a9a4c5b9bb227c0bdd09c57557f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:21.450384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:21.450976) ========= 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=ed14279e38b05397cf4aa391000001a4-1465574648.215279-1388030159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:21.537209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 10:11:21.537992) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 10:11:21.538588) ========= ========= Total master_lag: 0.18 =========