builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1465577425.46 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.455932) ========= 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.456359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.456668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.531636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.531894) ========= 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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 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% 227M=0s 2016-06-10 09:50:25 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140039 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.697278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.697583) ========= 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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014826 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.747912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:25.748226) ========= 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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 09:50:25,833 truncating revision to first 12 chars 2016-06-10 09:50:25,833 Setting DEBUG logging. 2016-06-10 09:50:25,833 attempt 1/10 2016-06-10 09:50:25,833 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,141 unpacking tar archive at: fx-team-c2ffbe222854/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.393343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.393691) ========= script_repo_revision: c2ffbe22285487d5443d840e4c5feaa391f66c8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.394061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.394357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 09:50:26.404266) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-10 09:50:26.404552) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 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 --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', 09:50:26 INFO - 'system_bits': '32', 09:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:26 INFO - 'title': 'talos-linux64-ix-017', 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", 09:50:27 INFO - "repository": "", 09:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 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": 1844, 09:50:27 INFO - "slavename": "talos-linux64-ix-017", 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:32 INFO - Downloaded 1361 bytes. 09:50:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:50:32 INFO - Using the following test package requirements: 09:50:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:50:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'jsshell-linux-x86_64.zip'], 09:50:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:50:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:50:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:50:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:50:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:32 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:32 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:32 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:32 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:32 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:32 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:40 INFO - Downloaded 22891347 bytes. 09:50:40 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:40 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:41 INFO - Return code: 0 09:50:41 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:41 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:41 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:41 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:41 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:41 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:41 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:44 INFO - Downloaded 22891347 bytes. 09:50:44 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:44 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:46 INFO - Return code: 0 09:50:46 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:46 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:46 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:46 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:46 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:46 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:47 INFO - Downloaded 10833377 bytes. 09:50:47 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:47 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:48 INFO - Return code: 0 09:50:48 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:48 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:48 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:48 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:48 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:48 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:49 INFO - Downloaded 55398373 bytes. 09:50:49 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:49 INFO - mkdir: /builds/slave/test/properties 09:50:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:49 INFO - Contents: 09:50:49 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:50 INFO - Running post-action listener: _resource_record_post_action 09:50:50 INFO - Running post-action listener: set_extra_try_arguments 09:50:50 INFO - ##### 09:50:50 INFO - ##### Finished download-and-extract step (success) 09:50:50 INFO - ##### 09:50:50 INFO - ##### 09:50:50 INFO - ##### Running populate-webroot step. 09:50:50 INFO - ##### 09:50:50 INFO - Running pre-action listener: _resource_record_pre_action 09:50:50 INFO - Running main action method: populate_webroot 09:50:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:50 INFO - '--tppagecycles', 09:50:50 INFO - '7'], 09:50:50 INFO - 'tests': ['tsvgm']}}, 09:50:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['damp', 'tps']}, 09:50:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'tests': ['damp', 'tps']}, 09:50:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['dromaeo_dom']}, 09:50:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['a11yr', 09:50:50 INFO - 'ts_paint', 09:50:50 INFO - 'tpaint', 09:50:50 INFO - 'sessionrestore', 09:50:50 INFO - 'sessionrestore_no_auto_restore', 09:50:50 INFO - 'tabpaint']}, 09:50:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['tsvgx', 09:50:50 INFO - 'tsvgr_opacity', 09:50:50 INFO - 'tart', 09:50:50 INFO - 'tscrollx', 09:50:50 INFO - 'cart']}, 09:50:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:50 INFO - 'tsvgr_opacity', 09:50:50 INFO - 'tart', 09:50:50 INFO - 'tscrollx', 09:50:50 INFO - 'cart']}, 09:50:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'talos_options': ['--disable-e10s'], 09:50:50 INFO - 'tests': ['tp5o']}, 09:50:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'tests': ['tp5o']}, 09:50:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'talos_options': ['--disable-e10s', 09:50:50 INFO - '--xperf_path', 09:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:50 INFO - 'tests': ['tp5n']}, 09:50:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:50 INFO - 'talos_options': ['--xperf_path', 09:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:50 INFO - 'tests': ['tp5n']}}, 09:50:50 INFO - 'talos.zip': {'path': '', 09:50:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:50 INFO - Running post-action listener: _resource_record_post_action 09:50:50 INFO - ##### 09:50:50 INFO - ##### Finished populate-webroot step (success) 09:50:50 INFO - ##### 09:50:50 INFO - ##### 09:50:50 INFO - ##### Running create-virtualenv step. 09:50:50 INFO - ##### 09:50:50 INFO - Running pre-action listener: _resource_record_pre_action 09:50:50 INFO - Running main action method: create_virtualenv 09:50:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:50 INFO - Using real prefix '/usr' 09:50:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:53 INFO - Installing pip.................done. 09:50:53 INFO - Return code: 0 09:50:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:50:53 INFO - Using env: {'DISPLAY': ':0', 09:50:53 INFO - 'HOME': '/home/cltbld', 09:50:53 INFO - 'LANG': 'en_US.UTF-8', 09:50:53 INFO - 'LANGUAGE': 'en_US:en', 09:50:53 INFO - 'LOGNAME': 'cltbld', 09:50:53 INFO - 'MAIL': '/var/mail/cltbld', 09:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:53 INFO - 'MOZ_NO_REMOTE': '1', 09:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:53 INFO - 'NO_EM_RESTART': '1', 09:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:53 INFO - 'PWD': '/builds/slave/test', 09:50:53 INFO - 'SHELL': '/bin/bash', 09:50:53 INFO - 'SHLVL': '1', 09:50:53 INFO - 'TERM': 'linux', 09:50:53 INFO - 'TMOUT': '86400', 09:50:53 INFO - 'USER': 'cltbld', 09:50:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:53 INFO - '_': '/tools/buildbot/bin/python'} 09:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:53 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:53 INFO - Cleaning up... 09:50:53 INFO - Return code: 0 09:50:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:50:53 INFO - Using env: {'DISPLAY': ':0', 09:50:53 INFO - 'HOME': '/home/cltbld', 09:50:53 INFO - 'LANG': 'en_US.UTF-8', 09:50:53 INFO - 'LANGUAGE': 'en_US:en', 09:50:53 INFO - 'LOGNAME': 'cltbld', 09:50:53 INFO - 'MAIL': '/var/mail/cltbld', 09:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:53 INFO - 'MOZ_NO_REMOTE': '1', 09:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:53 INFO - 'NO_EM_RESTART': '1', 09:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:53 INFO - 'PWD': '/builds/slave/test', 09:50:53 INFO - 'SHELL': '/bin/bash', 09:50:53 INFO - 'SHLVL': '1', 09:50:53 INFO - 'TERM': 'linux', 09:50:53 INFO - 'TMOUT': '86400', 09:50:53 INFO - 'USER': 'cltbld', 09:50:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:53 INFO - '_': '/tools/buildbot/bin/python'} 09:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:53 INFO - Downloading/unpacking psutil>=3.1.1 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:55 INFO - Installing collected packages: psutil 09:50:55 INFO - Running setup.py install for psutil 09:50:55 INFO - building 'psutil._psutil_linux' extension 09:50:55 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:56 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:56 INFO - building 'psutil._psutil_posix' extension 09:50:56 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:57 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:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:57 INFO - Successfully installed psutil 09:50:57 INFO - Cleaning up... 09:50:57 INFO - Return code: 0 09:50:57 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 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 mozsystemmonitor==0.3 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 mozsystemmonitor-0.3.tar.gz 09:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:59 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:59 INFO - Installing collected packages: mozsystemmonitor 09:50:59 INFO - Running setup.py install for mozsystemmonitor 09:50:59 INFO - Successfully installed mozsystemmonitor 09:50:59 INFO - Cleaning up... 09:50:59 INFO - Return code: 0 09:50:59 INFO - Installing jsonschema==2.5.1 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:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:00 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:00 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:51:00 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:51:00 INFO - Using env: {'DISPLAY': ':0', 09:51:00 INFO - 'HOME': '/home/cltbld', 09:51:00 INFO - 'LANG': 'en_US.UTF-8', 09:51:00 INFO - 'LANGUAGE': 'en_US:en', 09:51:00 INFO - 'LOGNAME': 'cltbld', 09:51:00 INFO - 'MAIL': '/var/mail/cltbld', 09:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:00 INFO - 'MOZ_NO_REMOTE': '1', 09:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:00 INFO - 'NO_EM_RESTART': '1', 09:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:00 INFO - 'PWD': '/builds/slave/test', 09:51:00 INFO - 'SHELL': '/bin/bash', 09:51:00 INFO - 'SHLVL': '1', 09:51:00 INFO - 'TERM': 'linux', 09:51:00 INFO - 'TMOUT': '86400', 09:51:00 INFO - 'USER': 'cltbld', 09:51:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:00 INFO - '_': '/tools/buildbot/bin/python'} 09:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:00 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:00 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:00 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:00 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:00 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:00 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 jsonschema-2.5.1-py2.py3-none-any.whl 09:51:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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 functools32-3.2.3-2.tar.gz 09:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:02 INFO - warning: no files found matching '*.txt' 09:51:02 INFO - no previously-included directories found matching 'build' 09:51:02 INFO - no previously-included directories found matching 'dist' 09:51:02 INFO - no previously-included directories found matching '.git*' 09:51:02 INFO - Installing collected packages: jsonschema, functools32 09:51:02 INFO - Running setup.py install for functools32 09:51:02 INFO - warning: no files found matching '*.txt' 09:51:02 INFO - no previously-included directories found matching 'build' 09:51:02 INFO - no previously-included directories found matching 'dist' 09:51:02 INFO - no previously-included directories found matching '.git*' 09:51:02 INFO - Successfully installed jsonschema functools32 09:51:02 INFO - Cleaning up... 09:51:02 INFO - Return code: 0 09:51:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:02 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:51:02 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:51:02 INFO - Using env: {'DISPLAY': ':0', 09:51:02 INFO - 'HOME': '/home/cltbld', 09:51:02 INFO - 'LANG': 'en_US.UTF-8', 09:51:02 INFO - 'LANGUAGE': 'en_US:en', 09:51:02 INFO - 'LOGNAME': 'cltbld', 09:51:02 INFO - 'MAIL': '/var/mail/cltbld', 09:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:02 INFO - 'MOZ_NO_REMOTE': '1', 09:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:02 INFO - 'NO_EM_RESTART': '1', 09:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:02 INFO - 'PWD': '/builds/slave/test', 09:51:02 INFO - 'SHELL': '/bin/bash', 09:51:02 INFO - 'SHLVL': '1', 09:51:02 INFO - 'TERM': 'linux', 09:51:02 INFO - 'TMOUT': '86400', 09:51:02 INFO - 'USER': 'cltbld', 09:51:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:02 INFO - '_': '/tools/buildbot/bin/python'} 09:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:02 INFO - Downloading/unpacking 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:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading docopt-0.6.1.tar.gz 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:05 INFO - Running setup.py install for blobuploader 09:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:05 INFO - Running setup.py install for requests 09:51:05 INFO - Running setup.py install for docopt 09:51:06 INFO - Successfully installed blobuploader requests docopt 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', '--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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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', '--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:06 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: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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 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-OZpMCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Running setup.py (path:/tmp/pip-bwnTaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Running setup.py (path:/tmp/pip-KqRqyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Running setup.py (path:/tmp/pip-4t7X5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Running setup.py (path:/tmp/pip-ejpJDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Running setup.py (path:/tmp/pip-osfVqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Running setup.py (path:/tmp/pip-Ne5T7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:06 INFO - Running setup.py (path:/tmp/pip-2xvAOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:06 INFO - Running setup.py (path:/tmp/pip-wxaI20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:06 INFO - Running setup.py (path:/tmp/pip-EIsifg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Running setup.py (path:/tmp/pip-cD_7TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 INFO - Running setup.py (path:/tmp/pip-5lnZ5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Running setup.py (path:/tmp/pip-9fNtdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 INFO - Running setup.py (path:/tmp/pip-3ulXZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Running setup.py (path:/tmp/pip-lEB3wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Running setup.py (path:/tmp/pip-ERJIOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Running setup.py (path:/tmp/pip-SM7Uls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:07 INFO - Running setup.py install for manifestparser 09:51:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:07 INFO - Running setup.py install for mozcrash 09:51:07 INFO - Running setup.py install for mozdebug 09:51:07 INFO - Running setup.py install for mozdevice 09:51:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:07 INFO - Running setup.py install for mozfile 09:51:08 INFO - Running setup.py install for mozhttpd 09:51:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozinfo 09:51:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozInstall 09:51:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozleak 09:51:08 INFO - Running setup.py install for mozlog 09:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for moznetwork 09:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozprocess 09:51:08 INFO - Running setup.py install for mozprofile 09:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:08 INFO - Running setup.py install for mozrunner 09:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:09 INFO - Running setup.py install for mozscreenshot 09:51:09 INFO - Running setup.py install for moztest 09:51:09 INFO - Running setup.py install for mozversion 09:51:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 09:51:09 INFO - 'HOME': '/home/cltbld', 09:51:09 INFO - 'LANG': 'en_US.UTF-8', 09:51:09 INFO - 'LANGUAGE': 'en_US:en', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MAIL': '/var/mail/cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SHLVL': '1', 09:51:09 INFO - 'TERM': 'linux', 09:51:09 INFO - 'TMOUT': '86400', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - '_': '/tools/buildbot/bin/python'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:09 INFO - Running setup.py (path:/tmp/pip-9Vl6We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:09 INFO - Running setup.py (path:/tmp/pip-x4dyf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:09 INFO - Running setup.py (path:/tmp/pip-_lFoiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:09 INFO - Running setup.py (path:/tmp/pip-F586Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:09 INFO - Running setup.py (path:/tmp/pip-QMAJTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:09 INFO - Running setup.py (path:/tmp/pip-y0BfEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:09 INFO - Running setup.py (path:/tmp/pip-HIUwBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:10 INFO - Running setup.py (path:/tmp/pip-kcPTih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:10 INFO - Running setup.py (path:/tmp/pip-GCVa4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:10 INFO - Running setup.py (path:/tmp/pip-XtIlbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:10 INFO - Running setup.py (path:/tmp/pip-3q9G0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:10 INFO - Running setup.py (path:/tmp/pip-YXrAQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:10 INFO - Running setup.py (path:/tmp/pip-HjN8YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:10 INFO - Running setup.py (path:/tmp/pip-Rz0K_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:10 INFO - Running setup.py (path:/tmp/pip-JsLzPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:10 INFO - Running setup.py (path:/tmp/pip-PprHE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:10 INFO - Running setup.py (path:/tmp/pip-BVxeW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:12 INFO - Installing collected packages: blessings 09:51:12 INFO - Running setup.py install for blessings 09:51:12 INFO - Successfully installed blessings 09:51:12 INFO - Cleaning up... 09:51:12 INFO - Return code: 0 09:51:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:13 INFO - Reading from file tmpfile_stdout 09:51:13 INFO - Current package versions: 09:51:13 INFO - argparse == 1.2.1 09:51:13 INFO - blessings == 1.6 09:51:13 INFO - blobuploader == 1.2.4 09:51:13 INFO - docopt == 0.6.1 09:51:13 INFO - functools32 == 3.2.3-2 09:51:13 INFO - jsonschema == 2.5.1 09:51:13 INFO - manifestparser == 1.1 09:51:13 INFO - mozInstall == 1.12 09:51:13 INFO - mozcrash == 0.17 09:51:13 INFO - mozdebug == 0.1 09:51:13 INFO - mozdevice == 0.48 09:51:13 INFO - mozfile == 1.2 09:51:13 INFO - mozhttpd == 0.7 09:51:13 INFO - mozinfo == 0.9 09:51:13 INFO - mozleak == 0.1 09:51:13 INFO - mozlog == 3.2 09:51:13 INFO - moznetwork == 0.27 09:51:13 INFO - mozprocess == 0.22 09:51:13 INFO - mozprofile == 0.28 09:51:13 INFO - mozrunner == 6.11 09:51:13 INFO - mozscreenshot == 0.1 09:51:13 INFO - mozsystemmonitor == 0.3 09:51:13 INFO - moztest == 0.7 09:51:13 INFO - mozversion == 1.4 09:51:13 INFO - psutil == 3.1.1 09:51:13 INFO - requests == 1.2.3 09:51:13 INFO - wsgiref == 0.1.2 09:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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 0x7f6c896e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21bc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, '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': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Downloading/unpacking 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:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:51:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:51:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:51:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:51:15 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:15 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:15 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:15 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:15 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:15 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:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:51:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:16 INFO - no previously-included directories found matching 'docs/_build' 09:51:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:51:16 INFO - Running setup.py install for pep8 09:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:16 INFO - no previously-included directories found matching 'docs/_build' 09:51:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:51:16 INFO - Cleaning up... 09:51:16 INFO - Return code: 0 09:51:16 INFO - Running post-action listener: _resource_record_post_action 09:51:16 INFO - Running post-action listener: _start_resource_monitoring 09:51:16 INFO - Starting resource monitoring. 09:51:16 INFO - ##### 09:51:16 INFO - ##### Finished create-virtualenv step (success) 09:51:16 INFO - ##### 09:51:16 INFO - ##### 09:51:16 INFO - ##### Running install step. 09:51:16 INFO - ##### 09:51:16 INFO - Running pre-action listener: _resource_record_pre_action 09:51:16 INFO - Running main action method: install 09:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:16 INFO - Reading from file tmpfile_stdout 09:51:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:17 INFO - Reading from file tmpfile_stdout 09:51:17 INFO - Output received: 09:51:17 INFO - Usage: mozinstall [options] installer 09:51:17 INFO - Options: 09:51:17 INFO - -h, --help show this help message and exit 09:51:17 INFO - -d DEST, --destination=DEST 09:51:17 INFO - Directory to install application into. [default: 09:51:17 INFO - "/builds/slave/test"] 09:51:17 INFO - --app=APP Application being installed. [default: firefox] 09:51:17 INFO - mkdir: /builds/slave/test/build/application 09:51:17 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:17 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:32 INFO - Reading from file tmpfile_stdout 09:51:32 INFO - Output received: 09:51:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:32 INFO - Running post-action listener: _resource_record_post_action 09:51:32 INFO - ##### 09:51:32 INFO - ##### Finished install step (success) 09:51:32 INFO - ##### 09:51:32 INFO - ##### 09:51:32 INFO - ##### Running run-tests step. 09:51:32 INFO - ##### 09:51:32 INFO - Running pre-action listener: _resource_record_pre_action 09:51:32 INFO - Running main action method: run_tests 09:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:33 INFO - Python 2.7.3 09:51:33 INFO - Return code: 0 09:51:33 INFO - grabbing minidump binary from tooltool 09:51: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:51:33 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 0x224b1c0>, '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 0x224c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x224c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:33 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:33 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:33 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:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:33 INFO - Return code: 0 09:51:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:51:34 INFO - Return code: 0 09:51:34 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', '--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-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:51:34 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 --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-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:51:34 INFO - Using env: {'DISPLAY': ':0', 09:51:34 INFO - 'HOME': '/home/cltbld', 09:51:34 INFO - 'LANG': 'en_US.UTF-8', 09:51:34 INFO - 'LANGUAGE': 'en_US:en', 09:51:34 INFO - 'LOGNAME': 'cltbld', 09:51:34 INFO - 'MAIL': '/var/mail/cltbld', 09:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:34 INFO - 'MOZ_NO_REMOTE': '1', 09:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:34 INFO - 'NO_EM_RESTART': '1', 09:51:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:34 INFO - 'PWD': '/builds/slave/test', 09:51:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:34 INFO - 'SHELL': '/bin/bash', 09:51:34 INFO - 'SHLVL': '1', 09:51:34 INFO - 'TERM': 'linux', 09:51:34 INFO - 'TMOUT': '86400', 09:51:34 INFO - 'USER': 'cltbld', 09:51:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369', 09:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:34 INFO - '_': '/tools/buildbot/bin/python'} 09:51:34 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', '--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-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:51:34 INFO - mozversion application_buildid: 20160610092130 09:51:34 INFO - mozversion application_changeset: c2ffbe22285487d5443d840e4c5feaa391f66c8d 09:51:34 INFO - mozversion application_display_name: Nightly 09:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:34 INFO - mozversion application_name: Firefox 09:51:34 INFO - mozversion application_remotingname: firefox 09:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:51:34 INFO - mozversion application_vendor: Mozilla 09:51:34 INFO - mozversion application_version: 50.0a1 09:51:34 INFO - mozversion platform_buildid: 20160610092130 09:51:34 INFO - mozversion platform_changeset: c2ffbe22285487d5443d840e4c5feaa391f66c8d 09:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:51:34 INFO - mozversion platform_version: 50.0a1 09:51:34 INFO - using testdate: 1465577494 09:51:34 INFO - actual date: 1465577494 09:51:34 INFO - starting webserver on 'localhost:54975' 09:51:34 INFO - SUITE-START | Running 2 tests 09:51:34 INFO - TEST-START | dromaeo_css 09:51:34 INFO - operating with platform_type : linux_ 09:51:34 INFO - Initialising browser for dromaeo_css test... 09:51:34 INFO - TEST-INFO | started process 3337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01skGM/profile http://localhost:54975/getInfo.html) 09:51:39 INFO - PROCESS | 3337 | __metrics Screen width/height:1600/1200 09:51:39 INFO - PROCESS | 3337 | colorDepth:24 09:51:39 INFO - PROCESS | 3337 | Browser inner width/height: 1024/697 09:51:39 INFO - PROCESS | 3337 | __metrics 09:51:40 INFO - PROCESS | 3337 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:51:41 INFO - TEST-INFO | 3337: exit 0 09:51:41 INFO - Browser initialized. 09:51:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:41 INFO - TEST-INFO | started process 3419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01skGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:54 INFO - PROCESS | 3419 | RSS: Main: 175648768 09:51:54 INFO - PROCESS | 3419 | 09:52:44 INFO - PROCESS | 3419 | 1465577564880 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:57 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54975/tests/dromaeo/cssquery-ext.html) 09:54:59 INFO - PROCESS | 3419 | RSS: Main: 292114432 09:54:59 INFO - PROCESS | 3419 | 09:58:01 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-ext.html (next: http://localhost:54975/tests/dromaeo/cssquery-jquery.html) 09:58:02 INFO - PROCESS | 3419 | RSS: Main: 251740160 09:58:02 INFO - PROCESS | 3419 | 10:01:04 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54975/tests/dromaeo/cssquery-mootools.html) 10:01:05 INFO - PROCESS | 3419 | RSS: Main: 253775872 10:01:05 INFO - PROCESS | 3419 | 10:04:07 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54975/tests/dromaeo/cssquery-prototype.html) 10:04:08 INFO - PROCESS | 3419 | RSS: Main: 254197760 10:04:08 INFO - PROCESS | 3419 | 10:07:11 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54975/tests/dromaeo/cssquery-yui.html) 10:07:11 INFO - PROCESS | 3419 | RSS: Main: 229634048 10:07:11 INFO - PROCESS | 3419 | 10:10:14 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54975/tests/dromaeo/cssquery-yui.html (next: http://localhost:54975/tests/dromaeo/cssquery-dojo.html) 10:10:15 INFO - PROCESS | 3419 | RSS: Main: 286150656 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | __start_tp_report 10:10:15 INFO - PROCESS | 3419 | _x_x_mozilla_page_load 10:10:15 INFO - PROCESS | 3419 | _x_x_mozilla_page_load_details 10:10:15 INFO - PROCESS | 3419 | |i|pagename|runs| 10:10:15 INFO - PROCESS | 3419 | |0;dojo.html;2613.699424566175;2614.738526147384;2654.4956458272927;2655.083996021372;2659.4282229320693;4658.534146585348;4689.226277664186;4710.6938049026785;4747.525247475255;4805.207140821764;4704.952950470494;4707.105649926511;4710.528947105287;4752.738599377033;4763.214069678499;4146.502419709624;4273.124009578037;4364.759938203398;4395.142947125312;4539.909201815962;4439.88900277494;4476.082403107355;4482.17079840229;4497.550244975509;4520.11857687751;4240.681948853833;4284.271673815459;4295.52749197588;4336.91326173478;4344.869653910388;4300.419443375135;4306.461692288464;4315.180115777992;4351.608355248043;4365.4106695596;4327.5239723630375;4337.1976184405985;4353.0423306872435;4384.342348647697;4396.362527433536;4645.187092258875;4713.787879545429;4747.216709242971;4784.832530861403;4792.329073929653;5167.147420675584;5177.508136727042;5184.326037615086;5188.351456067991;5188.740562971836;5181.35233095863;5195.584353251731;5210.140326846104;5227.555657769094;5230.790768369261;4643.88390290242;4695.483496815347;4715.3869996900185;4726.810927562928;4760.64295177863;5219.765110570033;5246.370435547682;5248;5248.6588371755715;5254.894902102013;4856.8300109495995;4986.725730084808;4998.275250088716;5032.370953630796;5038.866255092648;5019.548240658358;5050.116229659795;5071.644984851099;5074.720890350993;5104.515071068243;5040.722760248222;5063.113955057924;5063.645544811828;5064.82273120439;5110;4838.153323168432;4861.51384861511;5049.141645920203;5052.267421223902;5060.645754797202;4153.6677065834665;4187.330027195634;4208.347706105558;4246.8301267949555;4258.893527661833;3693.778373297611;3697.242065376591;3697.3899306614107;3741.28915506053;3742.8877133686033;4400.647948164139;4406.779661016936;4412.271975124068;4421.425214722066;4458.888527786831;4948.975255123773;5013.49865013503;5039.77321020555;5074.822381216713;5076.162433198555;4378.190034843564;4411.448568928884;4419.955800442019;4425.690201685851;4466.218411777926;4469.73181609098;4480.238359478896;4484.596386325246;4500.549945005473;4535.31970204472;4672.6261899047995;4687.742174180453;4708.505606911362;4768.332433459388;4773.856784296477;5061.544460998528;5087.211482220262;5088.7201203932655;5091.821786237464;5137.152369859081;4765.35667684872;4783.258594917794;4802.807887684454;4803.1114243864995;4845.563899249085;4859.708417494961;4996.525330093781;5026.095302845523;5047.268146118866;5087.4403815581;5116.411612664591;5146.459621739664;5155.620213937302;5155.948440515697;5206.401263854706;4856.320115183807;4990.101781679333;5002.52476014778;5004.124278251219;5009.774560144875;4890.266460031024;4912.901741965212;4918.114739346952;4946.703197808143;4968.080905032581;4874.951250487592;4893.755312234445;4931;4940.308356830118;4942.703437793743;4841.05599408112;4926.975365123151;4967.801287948441;5049.091163590589;5059.898802024012;4845.079434907357;4891.388576427947;4911.238757992517;4955.35580374549;4959.057779021974 10:10:15 INFO - PROCESS | 3419 | |1;ext.html;547.1903509532481;573.8335882594046;578.5371702637889;587.9235699359083;598.4703537369428;26307.605385919225;38317.23365532691;39525.60474395259;39621.80189099057;39788.80105599475;40966.38550421739;41422;41422.17155656885;41493.96265093374;41560.79219603905;7602.923970760305;7977.6011199439945;8129.227723366271;8135.023797144351;10217.233707471933;9936.205103591732;10334;10348.844767328459;10348.844767328495;10349.430781307025;10431.687049388493;10471.267011309212;10478.476076196197;10480.68557943263;10484.475776211197;7648.235176482335;10328.122109620654;10523.052925236765;10846.29499082557;10854.34873907568;10316.58733650653;10391.272610917238;10396.948015259952;10399.688009359732;10403.063724264852;40191.7990410049;40599.59400405988;40649.79675101605;40659.186816263806;40669.79665101685;2883.5674648802637;2935.002099286253;3034.180771191766;3521.5245941797784;3711.1464363196346;29922.40155196884;30417.391652166833;30499.390012199852;30649.540256896165;31420.685793142005;3387.5765529308837;3453.8618455262013;3521.9647803521893;3549.396602577542;3589.730770192246;256647;259678;259774.9999999981;260050;260517;54424;54888;54988.72505637526;55302.72348638231;55352;57764;58090.419095809346;58172.418275817545;58513.70743146257;58559.70720146372;14152.867770578328;14606.488772892897;14617;14617.561473155822;14625.341859616343;10900.50947707355;11429;11688.532458701728;11702.76594468106;11865.703357416134;18212.362567310345;18417.907910460362;18434.170462329228;18442.35451759182;18493.352732654294;6553.606783593;6672.198506403244;6878.965605171942;6882.174139103339;7128.928710712827;844.5101840932244;883.4037025008093;892.7098692924825;972.3582435592475;1015.3501758874327;26979.730202698116;28416.010879238667;28648.427031459254;28774;29124.126276211748;888.5557221389305;950.2255661635745;965.1120968708805;1005.5575546759402;1085.234909388879;14643.48747793822;15128.54614361571;15190.316435760416;15195;15263.3894644213;373132;374998;375012;375937;379073;50314.74842625763;50934.23598646023;51308.23037654438;51427.228591571155;51469.48530514647;1081.297156848055;1130.276622961322;1172.5778719660916;1187.2045729361175;1196.491491116272;27892.30269243204;28972;29100.7089929098;29267;29937.550936736403;42518.78740606277;42986.785066074466;43016.56983430251;43031.569684304006;43094.56905430905;300254;301631;302486;303234;303454;22602;25426;25535.489290214464;25739.742602573733;26302.079427219956;42516.36225456559;42517.36223956581;42930.35604465873;43519.34720979251;43901;34865;36010.63989360073;36229.81885090663;36428;36830;36368.63631363758;36369.81815090908;36527.26945461129;36737.81631091827;36791.44812827756;35207.47188792119;35680.464793027604;36230;36461.27077458383;36473.452898206015;30944.22639433942;32632.34735305328;32855;33236;33342;24736.752632473446;25073.749262507143;25313;25318.240452786446;25443.10949116772 10:10:15 INFO - PROCESS | 3419 | |2;jquery.html;375.12969909809243;382.1478103828462;382.72252616852785;389.1613572750723;394.5896267881403;15257.771133432994;16079.598010049755;17029.659406811857;17059;17068.14659267038;15253.542393728178;16330.918345408256;16583.751243731323;16893.91553042236;16897.23962421691;4604.26331786915;4747.311639812242;4768.97615511922;4813.66304358695;4814.7833347499445;3511.297740451907;3667.358212312848;5323.893522129555;5630.465105814941;5639.7180140993;5699.487046165844;5701.230333904932;5702.65784052956;5714.77140914365;5725.370209276997;5305.389880163772;5597.160425936122;5606.271184745998;5687.8293651190115;5691.544676425876;3305.9173520661934;4969.403671559436;5275.947240527584;5282.81510147143;5355.973220133913;12449.128561000734;12505.06212034101;12580.68548286291;12620.495180192873;12730.23618582888;1713.2632967823831;1815.4190658989128;1825.9908700456413;1861.3485280151838;1921.8462522998127;9345.17900701862;9368.20370268528;9743.464109473976;9810.939702662377;9841.261905357127;1635.5829263537842;1657.8590819780334;1686.0895116637;1736.8957862528289;1746.502246859639;65413;68009.31990680129;68016.319836801;68065.65967170133;68600.3139968599;10109.848352274721;10138.847917281246;10222.488875556193;10240.692779216635;10297.94851025755;14112.435502579987;14192.219427931563;14197.21915294648;14206.07660502064;14206.360713767905;7104.68028938699;7410.666520006613;7655.157932627407;7673.846523069619;7685.923140768633;7291.4531410144455;7371.447141464411;7451.366633836076;7464.029676142067;7525.2098529654695;4346.7609281489185;4425.756583387944;4479.888002799891;4539.954600454019;4552.840650577214;1700.2094026277593;1718.321263101093;1803.6482885837397;1816.3824299738153;1865;809.2069771623842;853.0914575976565;865.7748985263877;896.4128495835238;916.7616419730784;15759.212039398213;16183.67632647364;16453.259603317878;16782.244798984077;16826.91586542084;832.427798103862;847.567223421509;879.3009557401881;893.4014210478995;926.5182105305204;9245.953770231106;9289.489078100634;9532.618695252113;9607.951960240154;9766.218702503782;400689;400846;418509;422499;427956;83623;90551.54724226336;90906.54546727357;91076;91262;916.9908300916906;919.0809190809324;927.1377618814432;943.3820847345;944.2257348973912;15518.84481155174;15587.142707150762;15642.296096675449;15740.449084281996;16095.356185752438;36755;37068.073298167765;37661;38077.42883856689;38463.230735385696;49868.50131498639;51943;52517;53980.73009634927;54522;6730.932690673227;7269.963650181715;7359.852802944019;7523.774286771406;7543.170251272246;11470.713232169262;12159.817602736142;12243.326617035793;12269.877301226874;12407.317597532223;10606.46967651599;10639.148868090379;10730.785384292114;10744.140468762636;10859.837102443627;6259.874802504016;7296.306850849161;8185.017797864294;10021.749456263651;10965.232433729881;10688.25182237236;10868;10878;10910.61812836547;10942.671719848417;7306.634668266672;7347.8163045924275;7385.741499047507;7428.294312040348;7513.8872916907385;8045.9597702011115;10068.69793906184;10476.68569942903;10493.737656558647;10503.684889453329 10:10:15 INFO - PROCESS | 3419 | |3;mootools.html;1199.682084247675;1327.263368830299;1361.7004259063006;1402.3408997771044;1676.9161541922902;6567.835804104894;7494.4004479641635;7798.025246844145;7805.60971951403;7974.641141148648;7637.694492220318;7652.19651936547;7682;7689.692412303515;7690.384769218463;1829.7712785901763;2127.712758777561;2182.334388011656;2214.22502124256;2214.5903007943584;2180.1715348167672;2212.867227966319;2214.6345852934246;2215.2468160825315;2215.7451893032267;2053.8767673939537;2064.587082583482;2076.096897849433;2103.8842863642494;2107.409925220933;1803.6122233719814;2036.450158457223;2101.13853320138;2130.275706259871;2165.0690203212534;2132.051237199447;2153.300177442322;2156.42854643518;2156.827453803692;2159.686845407423;7573.621318934086;7609.429292803006;7618.390528757742;7621.542707437571;7622.809429764245;4574.176648203322;4688.742119183444;4697.67116301859;4698.459677137139;4703.741294228816;2721.727827217282;2809.606655068292;2825.22306365749;2853.3009412694023;2915.110891178211;856.8072183758604;866.7963028688316;905.108468158863;906.542196190926;907.1019690506417;10763.3541987481;10810.72973175669;10818.404987725671;10829.566817327297;10829.783404331869;4160.396742472385;4311.8490852820005;4334.848280310174;4360.49854266757;4369.148016136823;9082.500462474627;9089.454632722058;9106.772330691785;9111.27109831212;9128.58921348541;4647.465541462708;4650.86047418578;4652.744099074515;4654.301854721751;4654.930176047362;3658.487811706363;4089.2434899543678;4098.8360465581045;4273.252180868398;4278.951656844031;3734.6825519830577;3740.382836831947;3853.3641949078647;3881.670058045098;3893.805309734502;1236.9381530923417;1247.0709321555319;1255.8492980842357;1266.5946896992873;1277.3740866975115;666.733306677333;780.9023872015998;785.7014334552833;841.5581819544666;869.7695110795644;5253.080710875582;5336.386315573681;5349.037173308764;5367.033933891937;5424.077906755861;386.33743130531275;404.71265401565216;407.03329592218483;409.65998221476104;415.03297317250735;3482.7736197147105;3497.2655742293896;3521.8767343142868;3537.451694987281;3578.3380074686265;9176.31177661678;9693.079157480028;9696.660616878375;9703.514824258758;9743.9025609743;9527.47598882068;9540.761480962892;9598.95200523993;9598.95200524007;9606.519674016272;7104.68028938699;7185.784426467214;7186.6047367395295;7194.532355396883;7194.712211511585;4809.278608208797;4885.246555402735;4962.131626965194;4974.527419895104;4986.47641997585;8634.222919936985;8706;8946.955265223633;8975.102489750972;9003.864942026006;9039.864402033843;9123.680671176477;9140.954295228481;9198.724038278862;9242.12199841014;5819.5053420459735;6053.424924632153;6079.726412311368;6675.165604299463;6732.899006515004;6917.481188910952;7001.264867189076;7002.684879180347;7006.789796306119;7579.924200757921;6656.83357916056;6672.299408562031;6710.362515561014;6763.391294783493;6765.830854228487;6498.350164983463;6651.667416629246;6666.766663166766;6816.795496135124;6908.5509441886115;6329.1139240505445;6362.77730279438;6391.041343798467;6394.872102558016;6395.840103997437;4408.294672852457;4576.954230457653;4592.242280023758;4603.263477843529;4671.808688784338;4284.721493102938;4330.5236423993965;4341.696081274281;4402.647788177002;4428.31361139024 10:10:15 INFO - PROCESS | 3419 | |4;prototype.html;304.998475007625;307.8476154303619;312.51716098627605;312.8951801146616;314.39165215308367;4853.320535125081;4873.758071287208;4896.265560165968;4896.265560165977;4917.311576379301;4795.664303498756;4801.951980480203;4849.175640141176;4853.587445067174;4879.146149423855;3627.655372739592;3729.533808273966;3735.589085200626;3746.6253374662588;3748.6813620842127;3685.1524149445645;3736.215394767102;3829.8468061277517;3854.9421758673643;3879.836049185233;3785.772853628791;3810.218905124457;3823.3118038753014;3859.749116307431;3860.305145073886;3563.5389490309108;3767.7362584619086;3823.4073718573527;3843.288991536561;3860.9227815443815;3295.3903527847424;3298.752593555469;3329.1190477380446;3333.2666813301034;3339.482380231068;4665.533446655341;4712.293156026623;4729.456112547066;4730.952690473086;4785.1625965455905;4320.351947207912;4339.414179085815;4341.60925516705;4351.063032453081;4353.25994580922;4934.149693864801;5050.974745126251;5085.73684710304;5091.567216786578;5098;3632.854685812564;3652.8356223969986;3660.6156353582755;3674.926501469956;3690.7970061646597;5274.156135018417;5286.788528458857;5318.840434786963;5346.866328341823;5350.625456218067;3629.4192929131214;3699.3341198584512;3718.925621487555;3742.746180029666;3756.9060773480337;3731.209019670519;3760.304343696425;3786.6213378662464;3812.4471951566866;3818.3890577507464;4318.719283246579;4322.848700295537;4332.870013899588;4341.565843415633;4364.148990946798;4856.417229932431;5088.669236499616;5094.363204599425;5094.694318340911;5112.821051263188;1299.3957809618573;1304.602096360619;1314.0210543145417;1317.8352705911761;1329.936051159069;816.481534225759;837.9455335403179;847.2247893177797;848.4061157189992;855.8673405622138;4450.287953927356;4596.862094137181;4609.469910960215;4629.65277604181;4630.236011058205;5238.842834714965;5260.105782017066;5317.351620997503;5327.893442131213;5338.225957236179;4447.754628703903;4562.657800664963;4593.356930029799;4593.678442509059;4610.884727881829;2791.804573679823;2802.7197280272217;2806.9017584384446;2807.4104438068234;2830.674472435655;4946.876328091755;4948.8429719036185;4972.72650004246;4986.32684587576;5000.974995125001;5113.769880355393;5354.3574771027725;5360.195970604441;5372.973135134299;5495.422980587061;4973.502649734997;5027.522385373383;5035.269885866529;5036.395632524047;5049.2173713074535;5269.78920843162;5286.497782710637;5296.205569164502;5299.947000529945;5301.416844147064;5003.77483013258;5178.844634660966;5181.870453238699;5191.558717508903;5195.818146364859;4920;4949.480304567968;4959.082569724613;4975.701457912537;4981.854173540034;3758.981205093957;3759.2481503698823;3780.4518344840394;3782.2624588205035;3786.3184626767447;5172.224166375074;5261.605379596469;5277.551408130352;5290.550303224115;5297.2583838263445;5009.624278179078;5021.748912554284;5038.689940615393;5069.239614057921;5087.287779710769;5075.147571136582;5096.872578185575;5105.2342148678;5115.309433226466;5126.974365128151;4756.762161891822;5037.345145131109;5037.722925239001;5042.344495215599;5048.64659473848;4867.393760059243;4945.18404463274;5161.974190129025;5163.509466600667;5238.292830467991;4963.801447942042;4980.252962055721;5008.173651347633;5049.6465247432325;5058.696478211319 10:10:15 INFO - PROCESS | 3419 | |5;yui.html;642.2293248102276;644.2687549631167;650.6519012328405;660.0363469334771;749.7450866705319;12448.128630995834;13646.18122912626;13707.040507164502;13714.177149371044;13736.587902362933;11995.400229988509;12012.939935300334;12019.338936358497;12069.155159138863;12091.758164836698;612.3203244398713;731.498923237584;756.6973210715703;761.5735188294573;765.2424100140848;766.5630590563381;766.6779952419997;771.9884201736978;774.28765535707;775.0776575874692;812.5003123079323;813.4753084260649;814.2793627639552;814.3363159025405;814.7392834293029;653.3825534869526;787.0869791042363;807.7697856111009;809.348474478045;810.068421315486;595.1370512756478;596.2219303808528;596.6092209602717;596.6479776931587;596.9224000879858;12739.490420383267;12808.871911280861;12809.551665691655;12818;12818.935905320413;12506.81239781404;12947.935260323638;12985.480580776757;13010.674733131747;13123.86876131236;10936.453177341102;11173.776524469466;11269.251720893362;11521.769564608745;11567.710807229887;4188.162367526476;4208.85269015583;4226.978865105685;4371.672124590668;4376.649868010583;55575;55784.442155578734;55871.44128558703;56376;57626.7118664404;10086.596536138471;10330.741731456623;10502.947485262524;10540.525676344583;10742.89257107419;18499.90750046268;18505.35231266899;18506.907465462587;18577;18585.628287434447;6821.795346139624;6904.723811047502;6927.58434493932;6961.3038696131;7114.928850711427;3753.3405919033844;3757.6242375762204;3841.8847434577006;3849.345611246095;3855.8843234703004;2817.7745780337523;2900.9129726107826;2917.3727648555237;2919.737223649882;2924.035068427414;458.93574899514095;481.7254165125915;495.5713307988636;501.1480483178538;506.06125636943676;484.17448250732417;516.6383531527946;531.346443874037;556.546414672041;603.7833764963602;7990.6004699765945;8171.387145964077;8206.179382061866;8341.916580834235;8543.871841922377;578.3609111931339;588.3616276340218;600.7116584039685;623.8627501949563;638.8690318484793;3599.226166374242;3750.4186851038135;3802.391617341212;3884.902877428087;3944.15200731844;54390.728046359516;82483.58758206171;90305;91023.59693877646;91590.54204728933;67901.99999999901;74857;80326;82020;82626;71166.64416677986;71635;72169.6391518039;72342;73309.63345183454;8247.670093196204;8415.20055594742;8504.630619255282;8590.226879580618;8603.569821509025;41324.58675413328;41409.37885931653;42970;43472.56527434812;45501.77249113733;42906.570934290256;63028;65028.34971650412;65087.67456162689;65659.67170164119;10645.946770266099;11134.777304454028;11139.830317816837;11393.601223957121;11696.181267311547;11735.765284694087;11967.401629918295;12238.510459581517;12335.136540442083;13108.082434229895;10725.892741072801;10935.671929842118;11066.39134847591;11276.548938042386;11397.943010284895;10949.83575246388;11298.548058077913;11384.260023098472;11844.407779611158;11957.222780519238;10585.4707264638;11062.280951738112;11173.49719262619;11222.607208747655;11315.20793544444;8910.153535414125;8947.418417802823;9140.542972851465;9407.294452915921;9465.100815422524;8774.473531588124;8957.686480973134;9197.908020919705;9216;9323.72028839136 10:10:15 INFO - PROCESS | 3419 | __end_tp_report 10:10:15 INFO - PROCESS | 3419 | __start_cc_report 10:10:15 INFO - PROCESS | 3419 | _x_x_mozilla_cycle_collect,1073 10:10:15 INFO - PROCESS | 3419 | __end_cc_report 10:10:15 INFO - PROCESS | 3419 | __startTimestamp1465578615160__endTimestamp 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | ------- Summary: start ------- 10:10:15 INFO - PROCESS | 3419 | Number of tests: 6 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#0] dojo.html Cycles:165 Average:4691.95 Median:4803.11 stddev:505.79 (10.5%) stddev-sans-first:480.34 10:10:15 INFO - PROCESS | 3419 | Values: 2613.7 2614.7 2654.5 2655.1 2659.4 4658.5 4689.2 4710.7 4747.5 4805.2 4705.0 4707.1 4710.5 4752.7 4763.2 4146.5 4273.1 4364.8 4395.1 4539.9 4439.9 4476.1 4482.2 4497.6 4520.1 4240.7 4284.3 4295.5 4336.9 4344.9 4300.4 4306.5 4315.2 4351.6 4365.4 4327.5 4337.2 4353.0 4384.3 4396.4 4645.2 4713.8 4747.2 4784.8 4792.3 5167.1 5177.5 5184.3 5188.4 5188.7 5181.4 5195.6 5210.1 5227.6 5230.8 4643.9 4695.5 4715.4 4726.8 4760.6 5219.8 5246.4 5248.0 5248.7 5254.9 4856.8 4986.7 4998.3 5032.4 5038.9 5019.5 5050.1 5071.6 5074.7 5104.5 5040.7 5063.1 5063.6 5064.8 5110.0 4838.2 4861.5 5049.1 5052.3 5060.6 4153.7 4187.3 4208.3 4246.8 4258.9 3693.8 3697.2 3697.4 3741.3 3742.9 4400.6 4406.8 4412.3 4421.4 4458.9 4949.0 5013.5 5039.8 5074.8 5076.2 4378.2 4411.4 4420.0 4425.7 4466.2 4469.7 4480.2 4484.6 4500.5 4535.3 4672.6 4687.7 4708.5 4768.3 4773.9 5061.5 5087.2 5088.7 5091.8 5137.2 4765.4 4783.3 4802.8 4803.1 4845.6 4859.7 4996.5 5026.1 5047.3 5087.4 5116.4 5146.5 5155.6 5155.9 5206.4 4856.3 4990.1 5002.5 5004.1 5009.8 4890.3 4912.9 4918.1 4946.7 4968.1 4875.0 4893.8 4931.0 4940.3 4942.7 4841.1 4927.0 4967.8 5049.1 5059.9 4845.1 4891.4 4911.2 4955.4 4959.1 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#1] ext.html Cycles:180 Average:47553.72 Median:18364.79 stddev:82905.88 (451.4%) stddev-sans-first:83063.33 10:10:15 INFO - PROCESS | 3419 | Values: 547.2 573.8 578.5 587.9 598.5 26307.6 38317.2 39525.6 39621.8 39788.8 40966.4 41422.0 41422.2 41494.0 41560.8 7602.9 7977.6 8129.2 8135.0 10217.2 9936.2 10334.0 10348.8 10348.8 10349.4 10431.7 10471.3 10478.5 10480.7 10484.5 7648.2 10328.1 10523.1 10846.3 10854.3 10316.6 10391.3 10396.9 10399.7 10403.1 40191.8 40599.6 40649.8 40659.2 40669.8 2883.6 2935.0 3034.2 3521.5 3711.1 29922.4 30417.4 30499.4 30649.5 31420.7 3387.6 3453.9 3522.0 3549.4 3589.7 256647.0 259678.0 259775.0 260050.0 260517.0 54424.0 54888.0 54988.7 55302.7 55352.0 57764.0 58090.4 58172.4 58513.7 58559.7 14152.9 14606.5 14617.0 14617.6 14625.3 10900.5 11429.0 11688.5 11702.8 11865.7 18212.4 18417.9 18434.2 18442.4 18493.4 6553.6 6672.2 6879.0 6882.2 7128.9 844.5 883.4 892.7 972.4 1015.4 26979.7 28416.0 28648.4 28774.0 29124.1 888.6 950.2 965.1 1005.6 1085.2 14643.5 15128.5 15190.3 15195.0 15263.4 373132.0 374998.0 375012.0 375937.0 379073.0 50314.7 50934.2 51308.2 51427.2 51469.5 1081.3 1130.3 1172.6 1187.2 1196.5 27892.3 28972.0 29100.7 29267.0 29937.6 42518.8 42986.8 43016.6 43031.6 43094.6 300254.0 301631.0 302486.0 303234.0 303454.0 22602.0 25426.0 25535.5 25739.7 26302.1 42516.4 42517.4 42930.4 43519.3 43901.0 34865.0 36010.6 36229.8 36428.0 36830.0 36368.6 36369.8 36527.3 36737.8 36791.4 35207.5 35680.5 36230.0 36461.3 36473.5 30944.2 32632.3 32855.0 33236.0 33342.0 24736.8 25073.7 25313.0 25318.2 25443.1 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#2] jquery.html Cycles:180 Average:25074.17 Median:4452.82 stddev:68582.36 (1540.2%) stddev-sans-first:68749.67 10:10:15 INFO - PROCESS | 3419 | Values: 375.1 382.1 382.7 389.2 394.6 15257.8 16079.6 17029.7 17059.0 17068.1 15253.5 16330.9 16583.8 16893.9 16897.2 4604.3 4747.3 4769.0 4813.7 4814.8 3511.3 3667.4 5323.9 5630.5 5639.7 5699.5 5701.2 5702.7 5714.8 5725.4 5305.4 5597.2 5606.3 5687.8 5691.5 3305.9 4969.4 5275.9 5282.8 5356.0 12449.1 12505.1 12580.7 12620.5 12730.2 1713.3 1815.4 1826.0 1861.3 1921.8 9345.2 9368.2 9743.5 9810.9 9841.3 1635.6 1657.9 1686.1 1736.9 1746.5 65413.0 68009.3 68016.3 68065.7 68600.3 10109.8 10138.8 10222.5 10240.7 10297.9 14112.4 14192.2 14197.2 14206.1 14206.4 7104.7 7410.7 7655.2 7673.8 7685.9 7291.5 7371.4 7451.4 7464.0 7525.2 4346.8 4425.8 4479.9 4540.0 4552.8 1700.2 1718.3 1803.6 1816.4 1865.0 809.2 853.1 865.8 896.4 916.8 15759.2 16183.7 16453.3 16782.2 16826.9 832.4 847.6 879.3 893.4 926.5 9246.0 9289.5 9532.6 9608.0 9766.2 400689.0 400846.0 418509.0 422499.0 427956.0 83623.0 90551.5 90906.5 91076.0 91262.0 917.0 919.1 927.1 943.4 944.2 15518.8 15587.1 15642.3 15740.4 16095.4 36755.0 37068.1 37661.0 38077.4 38463.2 49868.5 51943.0 52517.0 53980.7 54522.0 6730.9 7270.0 7359.9 7523.8 7543.2 11470.7 12159.8 12243.3 12269.9 12407.3 10606.5 10639.1 10730.8 10744.1 10859.8 6259.9 7296.3 8185.0 10021.7 10965.2 10688.3 10868.0 10878.0 10910.6 10942.7 7306.6 7347.8 7385.7 7428.3 7513.9 8046.0 10068.7 10476.7 10493.7 10503.7 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#3] mootools.html Cycles:180 Average:5073.82 Median:4847.26 stddev:2889.71 (59.6%) stddev-sans-first:2883.15 10:10:15 INFO - PROCESS | 3419 | Values: 1199.7 1327.3 1361.7 1402.3 1676.9 6567.8 7494.4 7798.0 7805.6 7974.6 7637.7 7652.2 7682.0 7689.7 7690.4 1829.8 2127.7 2182.3 2214.2 2214.6 2180.2 2212.9 2214.6 2215.2 2215.7 2053.9 2064.6 2076.1 2103.9 2107.4 1803.6 2036.5 2101.1 2130.3 2165.1 2132.1 2153.3 2156.4 2156.8 2159.7 7573.6 7609.4 7618.4 7621.5 7622.8 4574.2 4688.7 4697.7 4698.5 4703.7 2721.7 2809.6 2825.2 2853.3 2915.1 856.8 866.8 905.1 906.5 907.1 10763.4 10810.7 10818.4 10829.6 10829.8 4160.4 4311.8 4334.8 4360.5 4369.1 9082.5 9089.5 9106.8 9111.3 9128.6 4647.5 4650.9 4652.7 4654.3 4654.9 3658.5 4089.2 4098.8 4273.3 4279.0 3734.7 3740.4 3853.4 3881.7 3893.8 1236.9 1247.1 1255.8 1266.6 1277.4 666.7 780.9 785.7 841.6 869.8 5253.1 5336.4 5349.0 5367.0 5424.1 386.3 404.7 407.0 409.7 415.0 3482.8 3497.3 3521.9 3537.5 3578.3 9176.3 9693.1 9696.7 9703.5 9743.9 9527.5 9540.8 9599.0 9599.0 9606.5 7104.7 7185.8 7186.6 7194.5 7194.7 4809.3 4885.2 4962.1 4974.5 4986.5 8634.2 8706.0 8947.0 8975.1 9003.9 9039.9 9123.7 9141.0 9198.7 9242.1 5819.5 6053.4 6079.7 6675.2 6732.9 6917.5 7001.3 7002.7 7006.8 7579.9 6656.8 6672.3 6710.4 6763.4 6765.8 6498.4 6651.7 6666.8 6816.8 6908.6 6329.1 6362.8 6391.0 6394.9 6395.8 4408.3 4577.0 4592.2 4603.3 4671.8 4284.7 4330.5 4341.7 4402.6 4428.3 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#4] prototype.html Cycles:180 Average:4245.32 Median:4855.00 stddev:1232.66 (25.4%) stddev-sans-first:1200.11 10:10:15 INFO - PROCESS | 3419 | Values: 305.0 307.8 312.5 312.9 314.4 4853.3 4873.8 4896.3 4896.3 4917.3 4795.7 4802.0 4849.2 4853.6 4879.1 3627.7 3729.5 3735.6 3746.6 3748.7 3685.2 3736.2 3829.8 3854.9 3879.8 3785.8 3810.2 3823.3 3859.7 3860.3 3563.5 3767.7 3823.4 3843.3 3860.9 3295.4 3298.8 3329.1 3333.3 3339.5 4665.5 4712.3 4729.5 4731.0 4785.2 4320.4 4339.4 4341.6 4351.1 4353.3 4934.1 5051.0 5085.7 5091.6 5098.0 3632.9 3652.8 3660.6 3674.9 3690.8 5274.2 5286.8 5318.8 5346.9 5350.6 3629.4 3699.3 3718.9 3742.7 3756.9 3731.2 3760.3 3786.6 3812.4 3818.4 4318.7 4322.8 4332.9 4341.6 4364.1 4856.4 5088.7 5094.4 5094.7 5112.8 1299.4 1304.6 1314.0 1317.8 1329.9 816.5 837.9 847.2 848.4 855.9 4450.3 4596.9 4609.5 4629.7 4630.2 5238.8 5260.1 5317.4 5327.9 5338.2 4447.8 4562.7 4593.4 4593.7 4610.9 2791.8 2802.7 2806.9 2807.4 2830.7 4946.9 4948.8 4972.7 4986.3 5001.0 5113.8 5354.4 5360.2 5373.0 5495.4 4973.5 5027.5 5035.3 5036.4 5049.2 5269.8 5286.5 5296.2 5299.9 5301.4 5003.8 5178.8 5181.9 5191.6 5195.8 4920.0 4949.5 4959.1 4975.7 4981.9 3759.0 3759.2 3780.5 3782.3 3786.3 5172.2 5261.6 5277.6 5290.6 5297.3 5009.6 5021.7 5038.7 5069.2 5087.3 5075.1 5096.9 5105.2 5115.3 5127.0 4756.8 5037.3 5037.7 5042.3 5048.6 4867.4 4945.2 5162.0 5163.5 5238.3 4963.8 4980.3 5008.2 5049.6 5058.7 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - PROCESS | 3419 | [#5] yui.html Cycles:180 Average:16734.49 Median:503.60 stddev:23108.44 (4588.6%) stddev-sans-first:23141.68 10:10:15 INFO - PROCESS | 3419 | Values: 642.2 644.3 650.7 660.0 749.7 12448.1 13646.2 13707.0 13714.2 13736.6 11995.4 12012.9 12019.3 12069.2 12091.8 612.3 731.5 756.7 761.6 765.2 766.6 766.7 772.0 774.3 775.1 812.5 813.5 814.3 814.3 814.7 653.4 787.1 807.8 809.3 810.1 595.1 596.2 596.6 596.6 596.9 12739.5 12808.9 12809.6 12818.0 12818.9 12506.8 12947.9 12985.5 13010.7 13123.9 10936.5 11173.8 11269.3 11521.8 11567.7 4188.2 4208.9 4227.0 4371.7 4376.6 55575.0 55784.4 55871.4 56376.0 57626.7 10086.6 10330.7 10502.9 10540.5 10742.9 18499.9 18505.4 18506.9 18577.0 18585.6 6821.8 6904.7 6927.6 6961.3 7114.9 3753.3 3757.6 3841.9 3849.3 3855.9 2817.8 2900.9 2917.4 2919.7 2924.0 458.9 481.7 495.6 501.1 506.1 484.2 516.6 531.3 556.5 603.8 7990.6 8171.4 8206.2 8341.9 8543.9 578.4 588.4 600.7 623.9 638.9 3599.2 3750.4 3802.4 3884.9 3944.2 54390.7 82483.6 90305.0 91023.6 91590.5 67902.0 74857.0 80326.0 82020.0 82626.0 71166.6 71635.0 72169.6 72342.0 73309.6 8247.7 8415.2 8504.6 8590.2 8603.6 41324.6 41409.4 42970.0 43472.6 45501.8 42906.6 63028.0 65028.3 65087.7 65659.7 10645.9 11134.8 11139.8 11393.6 11696.2 11735.8 11967.4 12238.5 12335.1 13108.1 10725.9 10935.7 11066.4 11276.5 11397.9 10949.8 11298.5 11384.3 11844.4 11957.2 10585.5 11062.3 11173.5 11222.6 11315.2 8910.2 8947.4 9140.5 9407.3 9465.1 8774.5 8957.7 9197.9 9216.0 9323.7 10:10:15 INFO - PROCESS | 3419 | -------- Summary: end -------- 10:10:15 INFO - PROCESS | 3419 | 10:10:15 INFO - TEST-INFO | 3419: exit 0 10:10:15 INFO - TEST-OK | dromaeo_css | took 1121645ms 10:10:15 INFO - TEST-START | kraken 10:10:15 INFO - operating with platform_type : linux_ 10:10:15 INFO - Initialising browser for kraken test... 10:10:15 INFO - TEST-INFO | started process 3601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwotXL/profile http://localhost:54975/getInfo.html) 10:10:20 INFO - PROCESS | 3601 | __metrics Screen width/height:1600/1200 10:10:20 INFO - PROCESS | 3601 | colorDepth:24 10:10:20 INFO - PROCESS | 3601 | Browser inner width/height: 1024/697 10:10:20 INFO - PROCESS | 3601 | __metrics 10:10:21 INFO - PROCESS | 3601 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:21 INFO - PROCESS | 3601 | console.error: PushService: 10:10:21 INFO - PROCESS | 3601 | stateChangeProcessEnqueue: Error transitioning state 10:10:21 INFO - PROCESS | 3601 | UnknownError 10:10:22 INFO - TEST-INFO | 3601: exit 0 10:10:22 INFO - Browser initialized. 10:10:22 INFO - Running cycle 1/1 for kraken test... 10:10:22 INFO - TEST-INFO | started process 3683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwotXL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:34 INFO - PROCESS | 3683 | RSS: Main: 175607808 10:10:34 INFO - PROCESS | 3683 | 10:10:37 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54975/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:38 INFO - PROCESS | 3683 | RSS: Main: 233836544 10:10:38 INFO - PROCESS | 3683 | 10:10:40 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54975/tests/kraken/driver.html?testName=audio-dft) 10:10:41 INFO - PROCESS | 3683 | RSS: Main: 221929472 10:10:41 INFO - PROCESS | 3683 | 10:10:44 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54975/tests/kraken/driver.html?testName=audio-fft) 10:10:45 INFO - PROCESS | 3683 | RSS: Main: 289353728 10:10:45 INFO - PROCESS | 3683 | 10:10:47 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54975/tests/kraken/driver.html?testName=audio-oscillator) 10:10:48 INFO - PROCESS | 3683 | RSS: Main: 199294976 10:10:48 INFO - PROCESS | 3683 | 10:10:50 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:51 INFO - PROCESS | 3683 | RSS: Main: 202780672 10:10:51 INFO - PROCESS | 3683 | 10:10:54 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54975/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:54 INFO - PROCESS | 3683 | RSS: Main: 238497792 10:10:54 INFO - PROCESS | 3683 | 10:10:58 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54975/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:59 INFO - PROCESS | 3683 | RSS: Main: 235241472 10:10:59 INFO - PROCESS | 3683 | 10:11:01 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54975/tests/kraken/driver.html?testName=json-parse-financial) 10:11:02 INFO - PROCESS | 3683 | RSS: Main: 237821952 10:11:02 INFO - PROCESS | 3683 | 10:11:04 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:04 INFO - PROCESS | 3683 | RSS: Main: 225669120 10:11:04 INFO - PROCESS | 3683 | 10:11:06 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:07 INFO - PROCESS | 3683 | RSS: Main: 230555648 10:11:07 INFO - PROCESS | 3683 | 10:11:09 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:10 INFO - PROCESS | 3683 | RSS: Main: 238870528 10:11:10 INFO - PROCESS | 3683 | 10:11:13 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:13 INFO - PROCESS | 3683 | RSS: Main: 243527680 10:11:13 INFO - PROCESS | 3683 | 10:11:16 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:17 INFO - PROCESS | 3683 | RSS: Main: 241405952 10:11:17 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | Cycle 1(1): loaded http://localhost:54975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54975/tests/kraken/driver.html?testName=ai-astar) 10:11:19 INFO - PROCESS | 3683 | RSS: Main: 285556736 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | __start_tp_report 10:11:19 INFO - PROCESS | 3683 | _x_x_mozilla_page_load 10:11:19 INFO - PROCESS | 3683 | _x_x_mozilla_page_load_details 10:11:19 INFO - PROCESS | 3683 | |i|pagename|runs| 10:11:19 INFO - PROCESS | 3683 | |0;ai-astar;113;108;117;116;115;113;116;113;116;114 10:11:19 INFO - PROCESS | 3683 | |1;audio-beat-detection;178;137;138;180;131;160;155;133;192;130 10:11:19 INFO - PROCESS | 3683 | |2;audio-dft;163;161;161;164;164;161;162;161;161;161 10:11:19 INFO - PROCESS | 3683 | |3;audio-fft;74;75;75;101;75;76;74;75;109;76 10:11:19 INFO - PROCESS | 3683 | |4;audio-oscillator;87;86;114;87;87;86;131;85;86;121 10:11:19 INFO - PROCESS | 3683 | |5;imaging-gaussian-blur;117;118;118;118;117;118;120;117;125;117 10:11:19 INFO - PROCESS | 3683 | |6;imaging-darkroom;148;147;146;146;146;147;146;146;145;146 10:11:19 INFO - PROCESS | 3683 | |7;imaging-desaturate;95;96;95;95;95;96;96;94;95;95 10:11:19 INFO - PROCESS | 3683 | |8;json-parse-financial;63;61;64;63;65;62;62;61;61;62 10:11:19 INFO - PROCESS | 3683 | |9;json-stringify-tinderbox;65;65;65;65;66;66;66;65;66;66 10:11:19 INFO - PROCESS | 3683 | |10;stanford-crypto-aes;84;86;90;84;83;90;89;85;141;84 10:11:19 INFO - PROCESS | 3683 | |11;stanford-crypto-ccm;142;131;132;128;127;131;133;133;144;132 10:11:19 INFO - PROCESS | 3683 | |12;stanford-crypto-pbkdf2;170;174;168;174;169;169;170;173;164;164 10:11:19 INFO - PROCESS | 3683 | |13;stanford-crypto-sha256-iterative;68;68;67;69;67;71;67;69;67;65 10:11:19 INFO - PROCESS | 3683 | __end_tp_report 10:11:19 INFO - PROCESS | 3683 | __start_cc_report 10:11:19 INFO - PROCESS | 3683 | _x_x_mozilla_cycle_collect,1872 10:11:19 INFO - PROCESS | 3683 | __end_cc_report 10:11:19 INFO - PROCESS | 3683 | __startTimestamp1465578679257__endTimestamp 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | ------- Summary: start ------- 10:11:19 INFO - PROCESS | 3683 | Number of tests: 14 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.50 stddev:2.60 (2.3%) stddev-sans-first:2.73 10:11:19 INFO - PROCESS | 3683 | Values: 113.0 108.0 117.0 116.0 115.0 113.0 116.0 113.0 116.0 114.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:157.50 stddev:23.14 (14.7%) stddev-sans-first:22.77 10:11:19 INFO - PROCESS | 3683 | Values: 178.0 137.0 138.0 180.0 131.0 160.0 155.0 133.0 192.0 130.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 10:11:19 INFO - PROCESS | 3683 | Values: 163.0 161.0 161.0 164.0 164.0 161.0 162.0 161.0 161.0 161.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:12.81 (17.1%) stddev-sans-first:13.33 10:11:19 INFO - PROCESS | 3683 | Values: 74.0 75.0 75.0 101.0 75.0 76.0 74.0 75.0 109.0 76.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.00 stddev:17.73 (20.6%) stddev-sans-first:18.43 10:11:19 INFO - PROCESS | 3683 | Values: 87.0 86.0 114.0 87.0 87.0 86.0 131.0 85.0 86.0 121.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:2.46 (2.1%) stddev-sans-first:2.55 10:11:19 INFO - PROCESS | 3683 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 120.0 117.0 125.0 117.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 10:11:19 INFO - PROCESS | 3683 | Values: 148.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 146.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:11:19 INFO - PROCESS | 3683 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 94.0 95.0 95.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.41 10:11:19 INFO - PROCESS | 3683 | Values: 63.0 61.0 64.0 63.0 65.0 62.0 62.0 61.0 61.0 62.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:11:19 INFO - PROCESS | 3683 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:85.50 stddev:17.56 (20.5%) stddev-sans-first:18.41 10:11:19 INFO - PROCESS | 3683 | Values: 84.0 86.0 90.0 84.0 83.0 90.0 89.0 85.0 141.0 84.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:132.50 stddev:5.50 (4.1%) stddev-sans-first:4.85 10:11:19 INFO - PROCESS | 3683 | Values: 142.0 131.0 132.0 128.0 127.0 131.0 133.0 133.0 144.0 132.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:3.60 (2.1%) stddev-sans-first:3.81 10:11:19 INFO - PROCESS | 3683 | Values: 170.0 174.0 168.0 174.0 169.0 169.0 170.0 173.0 164.0 164.0 10:11:19 INFO - PROCESS | 3683 | 10:11:19 INFO - PROCESS | 3683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 10:11:19 INFO - PROCESS | 3683 | Values: 68.0 68.0 67.0 69.0 67.0 71.0 67.0 69.0 67.0 65.0 10:11:19 INFO - PROCESS | 3683 | -------- Summary: end -------- 10:11:19 INFO - PROCESS | 3683 | 10:11:20 INFO - TEST-INFO | 3683: exit 0 10:11:20 INFO - TEST-OK | kraken | took 64376ms 10:11:20 INFO - SUITE-END | took 1186s 10:11:20 INFO - Completed test suite (00:19:46) 10:11:20 INFO - javascript benchmark 10:11:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.699424566175, 2614.738526147384, 2654.4956458272927, 2655.083996021372, 2659.4282229320693, 4658.534146585348, 4689.226277664186, 4710.6938049026785, 4747.525247475255, 4805.207140821764, 4704.952950470494, 4707.105649926511, 4710.528947105287, 4752.738599377033, 4763.214069678499, 4146.502419709624, 4273.124009578037, 4364.759938203398, 4395.142947125312, 4539.909201815962, 4439.88900277494, 4476.082403107355, 4482.17079840229, 4497.550244975509, 4520.11857687751, 4240.681948853833, 4284.271673815459, 4295.52749197588, 4336.91326173478, 4344.869653910388, 4300.419443375135, 4306.461692288464, 4315.180115777992, 4351.608355248043, 4365.4106695596, 4327.5239723630375, 4337.1976184405985, 4353.0423306872435, 4384.342348647697, 4396.362527433536, 4645.187092258875, 4713.787879545429, 4747.216709242971, 4784.832530861403, 4792.329073929653, 5167.147420675584, 5177.508136727042, 5184.326037615086, 5188.351456067991, 5188.740562971836, 5181.35233095863, 5195.584353251731, 5210.140326846104, 5227.555657769094, 5230.790768369261, 4643.88390290242, 4695.483496815347, 4715.3869996900185, 4726.810927562928, 4760.64295177863, 5219.765110570033, 5246.370435547682, 5248.0, 5248.6588371755715, 5254.894902102013, 4856.8300109495995, 4986.725730084808, 4998.275250088716, 5032.370953630796, 5038.866255092648, 5019.548240658358, 5050.116229659795, 5071.644984851099, 5074.720890350993, 5104.515071068243, 5040.722760248222, 5063.113955057924, 5063.645544811828, 5064.82273120439, 5110.0, 4838.153323168432, 4861.51384861511, 5049.141645920203, 5052.267421223902, 5060.645754797202, 4153.6677065834665, 4187.330027195634, 4208.347706105558, 4246.8301267949555, 4258.893527661833, 3693.778373297611, 3697.242065376591, 3697.3899306614107, 3741.28915506053, 3742.8877133686033, 4400.647948164139, 4406.779661016936, 4412.271975124068, 4421.425214722066, 4458.888527786831, 4948.975255123773, 5013.49865013503, 5039.77321020555, 5074.822381216713, 5076.162433198555, 4378.190034843564, 4411.448568928884, 4419.955800442019, 4425.690201685851, 4466.218411777926, 4469.73181609098, 4480.238359478896, 4484.596386325246, 4500.549945005473, 4535.31970204472, 4672.6261899047995, 4687.742174180453, 4708.505606911362, 4768.332433459388, 4773.856784296477, 5061.544460998528, 5087.211482220262, 5088.7201203932655, 5091.821786237464, 5137.152369859081, 4765.35667684872, 4783.258594917794, 4802.807887684454, 4803.1114243864995, 4845.563899249085, 4859.708417494961, 4996.525330093781, 5026.095302845523, 5047.268146118866, 5087.4403815581, 5116.411612664591, 5146.459621739664, 5155.620213937302, 5155.948440515697, 5206.401263854706, 4856.320115183807, 4990.101781679333, 5002.52476014778, 5004.124278251219, 5009.774560144875, 4890.266460031024, 4912.901741965212, 4918.114739346952, 4946.703197808143, 4968.080905032581, 4874.951250487592, 4893.755312234445, 4931.0, 4940.308356830118, 4942.703437793743, 4841.05599408112, 4926.975365123151, 4967.801287948441, 5049.091163590589, 5059.898802024012, 4845.079434907357, 4891.388576427947, 4911.238757992517, 4955.35580374549, 4959.057779021974], "value": 4658.924091493957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.1903509532481, 573.8335882594046, 578.5371702637889, 587.9235699359083, 598.4703537369428, 26307.605385919225, 38317.23365532691, 39525.60474395259, 39621.80189099057, 39788.80105599475, 40966.38550421739, 41422.0, 41422.17155656885, 41493.96265093374, 41560.79219603905, 7602.923970760305, 7977.6011199439945, 8129.227723366271, 8135.023797144351, 10217.233707471933, 9936.205103591732, 10334.0, 10348.844767328459, 10348.844767328495, 10349.430781307025, 10431.687049388493, 10471.267011309212, 10478.476076196197, 10480.68557943263, 10484.475776211197, 7648.235176482335, 10328.122109620654, 10523.052925236765, 10846.29499082557, 10854.34873907568, 10316.58733650653, 10391.272610917238, 10396.948015259952, 10399.688009359732, 10403.063724264852, 40191.7990410049, 40599.59400405988, 40649.79675101605, 40659.186816263806, 40669.79665101685, 2883.5674648802637, 2935.002099286253, 3034.180771191766, 3521.5245941797784, 3711.1464363196346, 29922.40155196884, 30417.391652166833, 30499.390012199852, 30649.540256896165, 31420.685793142005, 3387.5765529308837, 3453.8618455262013, 3521.9647803521893, 3549.396602577542, 3589.730770192246, 256647.0, 259678.0, 259774.9999999981, 260050.0, 260517.0, 54424.0, 54888.0, 54988.72505637526, 55302.72348638231, 55352.0, 57764.0, 58090.419095809346, 58172.418275817545, 58513.70743146257, 58559.70720146372, 14152.867770578328, 14606.488772892897, 14617.0, 14617.561473155822, 14625.341859616343, 10900.50947707355, 11429.0, 11688.532458701728, 11702.76594468106, 11865.703357416134, 18212.362567310345, 18417.907910460362, 18434.170462329228, 18442.35451759182, 18493.352732654294, 6553.606783593, 6672.198506403244, 6878.965605171942, 6882.174139103339, 7128.928710712827, 844.5101840932244, 883.4037025008093, 892.7098692924825, 972.3582435592475, 1015.3501758874327, 26979.730202698116, 28416.010879238667, 28648.427031459254, 28774.0, 29124.126276211748, 888.5557221389305, 950.2255661635745, 965.1120968708805, 1005.5575546759402, 1085.234909388879, 14643.48747793822, 15128.54614361571, 15190.316435760416, 15195.0, 15263.3894644213, 373132.0, 374998.0, 375012.0, 375937.0, 379073.0, 50314.74842625763, 50934.23598646023, 51308.23037654438, 51427.228591571155, 51469.48530514647, 1081.297156848055, 1130.276622961322, 1172.5778719660916, 1187.2045729361175, 1196.491491116272, 27892.30269243204, 28972.0, 29100.7089929098, 29267.0, 29937.550936736403, 42518.78740606277, 42986.785066074466, 43016.56983430251, 43031.569684304006, 43094.56905430905, 300254.0, 301631.0, 302486.0, 303234.0, 303454.0, 22602.0, 25426.0, 25535.489290214464, 25739.742602573733, 26302.079427219956, 42516.36225456559, 42517.36223956581, 42930.35604465873, 43519.34720979251, 43901.0, 34865.0, 36010.63989360073, 36229.81885090663, 36428.0, 36830.0, 36368.63631363758, 36369.81815090908, 36527.26945461129, 36737.81631091827, 36791.44812827756, 35207.47188792119, 35680.464793027604, 36230.0, 36461.27077458383, 36473.452898206015, 30944.22639433942, 32632.34735305328, 32855.0, 33236.0, 33342.0, 24736.752632473446, 25073.749262507143, 25313.0, 25318.240452786446, 25443.10949116772], "value": 18288.99212562126, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.12969909809243, 382.1478103828462, 382.72252616852785, 389.1613572750723, 394.5896267881403, 15257.771133432994, 16079.598010049755, 17029.659406811857, 17059.0, 17068.14659267038, 15253.542393728178, 16330.918345408256, 16583.751243731323, 16893.91553042236, 16897.23962421691, 4604.26331786915, 4747.311639812242, 4768.97615511922, 4813.66304358695, 4814.7833347499445, 3511.297740451907, 3667.358212312848, 5323.893522129555, 5630.465105814941, 5639.7180140993, 5699.487046165844, 5701.230333904932, 5702.65784052956, 5714.77140914365, 5725.370209276997, 5305.389880163772, 5597.160425936122, 5606.271184745998, 5687.8293651190115, 5691.544676425876, 3305.9173520661934, 4969.403671559436, 5275.947240527584, 5282.81510147143, 5355.973220133913, 12449.128561000734, 12505.06212034101, 12580.68548286291, 12620.495180192873, 12730.23618582888, 1713.2632967823831, 1815.4190658989128, 1825.9908700456413, 1861.3485280151838, 1921.8462522998127, 9345.17900701862, 9368.20370268528, 9743.464109473976, 9810.939702662377, 9841.261905357127, 1635.5829263537842, 1657.8590819780334, 1686.0895116637, 1736.8957862528289, 1746.502246859639, 65413.0, 68009.31990680129, 68016.319836801, 68065.65967170133, 68600.3139968599, 10109.848352274721, 10138.847917281246, 10222.488875556193, 10240.692779216635, 10297.94851025755, 14112.435502579987, 14192.219427931563, 14197.21915294648, 14206.07660502064, 14206.360713767905, 7104.68028938699, 7410.666520006613, 7655.157932627407, 7673.846523069619, 7685.923140768633, 7291.4531410144455, 7371.447141464411, 7451.366633836076, 7464.029676142067, 7525.2098529654695, 4346.7609281489185, 4425.756583387944, 4479.888002799891, 4539.954600454019, 4552.840650577214, 1700.2094026277593, 1718.321263101093, 1803.6482885837397, 1816.3824299738153, 1865.0, 809.2069771623842, 853.0914575976565, 865.7748985263877, 896.4128495835238, 916.7616419730784, 15759.212039398213, 16183.67632647364, 16453.259603317878, 16782.244798984077, 16826.91586542084, 832.427798103862, 847.567223421509, 879.3009557401881, 893.4014210478995, 926.5182105305204, 9245.953770231106, 9289.489078100634, 9532.618695252113, 9607.951960240154, 9766.218702503782, 400689.0, 400846.0, 418509.0, 422499.0, 427956.0, 83623.0, 90551.54724226336, 90906.54546727357, 91076.0, 91262.0, 916.9908300916906, 919.0809190809324, 927.1377618814432, 943.3820847345, 944.2257348973912, 15518.84481155174, 15587.142707150762, 15642.296096675449, 15740.449084281996, 16095.356185752438, 36755.0, 37068.073298167765, 37661.0, 38077.42883856689, 38463.230735385696, 49868.50131498639, 51943.0, 52517.0, 53980.73009634927, 54522.0, 6730.932690673227, 7269.963650181715, 7359.852802944019, 7523.774286771406, 7543.170251272246, 11470.713232169262, 12159.817602736142, 12243.326617035793, 12269.877301226874, 12407.317597532223, 10606.46967651599, 10639.148868090379, 10730.785384292114, 10744.140468762636, 10859.837102443627, 6259.874802504016, 7296.306850849161, 8185.017797864294, 10021.749456263651, 10965.232433729881, 10688.25182237236, 10868.0, 10878.0, 10910.61812836547, 10942.671719848417, 7306.634668266672, 7347.8163045924275, 7385.741499047507, 7428.294312040348, 7513.8872916907385, 8045.9597702011115, 10068.69793906184, 10476.68569942903, 10493.737656558647, 10503.684889453329], "value": 8088.518635301131, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.682084247675, 1327.263368830299, 1361.7004259063006, 1402.3408997771044, 1676.9161541922902, 6567.835804104894, 7494.4004479641635, 7798.025246844145, 7805.60971951403, 7974.641141148648, 7637.694492220318, 7652.19651936547, 7682.0, 7689.692412303515, 7690.384769218463, 1829.7712785901763, 2127.712758777561, 2182.334388011656, 2214.22502124256, 2214.5903007943584, 2180.1715348167672, 2212.867227966319, 2214.6345852934246, 2215.2468160825315, 2215.7451893032267, 2053.8767673939537, 2064.587082583482, 2076.096897849433, 2103.8842863642494, 2107.409925220933, 1803.6122233719814, 2036.450158457223, 2101.13853320138, 2130.275706259871, 2165.0690203212534, 2132.051237199447, 2153.300177442322, 2156.42854643518, 2156.827453803692, 2159.686845407423, 7573.621318934086, 7609.429292803006, 7618.390528757742, 7621.542707437571, 7622.809429764245, 4574.176648203322, 4688.742119183444, 4697.67116301859, 4698.459677137139, 4703.741294228816, 2721.727827217282, 2809.606655068292, 2825.22306365749, 2853.3009412694023, 2915.110891178211, 856.8072183758604, 866.7963028688316, 905.108468158863, 906.542196190926, 907.1019690506417, 10763.3541987481, 10810.72973175669, 10818.404987725671, 10829.566817327297, 10829.783404331869, 4160.396742472385, 4311.8490852820005, 4334.848280310174, 4360.49854266757, 4369.148016136823, 9082.500462474627, 9089.454632722058, 9106.772330691785, 9111.27109831212, 9128.58921348541, 4647.465541462708, 4650.86047418578, 4652.744099074515, 4654.301854721751, 4654.930176047362, 3658.487811706363, 4089.2434899543678, 4098.8360465581045, 4273.252180868398, 4278.951656844031, 3734.6825519830577, 3740.382836831947, 3853.3641949078647, 3881.670058045098, 3893.805309734502, 1236.9381530923417, 1247.0709321555319, 1255.8492980842357, 1266.5946896992873, 1277.3740866975115, 666.733306677333, 780.9023872015998, 785.7014334552833, 841.5581819544666, 869.7695110795644, 5253.080710875582, 5336.386315573681, 5349.037173308764, 5367.033933891937, 5424.077906755861, 386.33743130531275, 404.71265401565216, 407.03329592218483, 409.65998221476104, 415.03297317250735, 3482.7736197147105, 3497.2655742293896, 3521.8767343142868, 3537.451694987281, 3578.3380074686265, 9176.31177661678, 9693.079157480028, 9696.660616878375, 9703.514824258758, 9743.9025609743, 9527.47598882068, 9540.761480962892, 9598.95200523993, 9598.95200524007, 9606.519674016272, 7104.68028938699, 7185.784426467214, 7186.6047367395295, 7194.532355396883, 7194.712211511585, 4809.278608208797, 4885.246555402735, 4962.131626965194, 4974.527419895104, 4986.47641997585, 8634.222919936985, 8706.0, 8946.955265223633, 8975.102489750972, 9003.864942026006, 9039.864402033843, 9123.680671176477, 9140.954295228481, 9198.724038278862, 9242.12199841014, 5819.5053420459735, 6053.424924632153, 6079.726412311368, 6675.165604299463, 6732.899006515004, 6917.481188910952, 7001.264867189076, 7002.684879180347, 7006.789796306119, 7579.924200757921, 6656.83357916056, 6672.299408562031, 6710.362515561014, 6763.391294783493, 6765.830854228487, 6498.350164983463, 6651.667416629246, 6666.766663166766, 6816.795496135124, 6908.5509441886115, 6329.1139240505445, 6362.77730279438, 6391.041343798467, 6394.872102558016, 6395.840103997437, 4408.294672852457, 4576.954230457653, 4592.242280023758, 4603.263477843529, 4671.808688784338, 4284.721493102938, 4330.5236423993965, 4341.696081274281, 4402.647788177002, 4428.31361139024], "value": 4001.828691908762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.998475007625, 307.8476154303619, 312.51716098627605, 312.8951801146616, 314.39165215308367, 4853.320535125081, 4873.758071287208, 4896.265560165968, 4896.265560165977, 4917.311576379301, 4795.664303498756, 4801.951980480203, 4849.175640141176, 4853.587445067174, 4879.146149423855, 3627.655372739592, 3729.533808273966, 3735.589085200626, 3746.6253374662588, 3748.6813620842127, 3685.1524149445645, 3736.215394767102, 3829.8468061277517, 3854.9421758673643, 3879.836049185233, 3785.772853628791, 3810.218905124457, 3823.3118038753014, 3859.749116307431, 3860.305145073886, 3563.5389490309108, 3767.7362584619086, 3823.4073718573527, 3843.288991536561, 3860.9227815443815, 3295.3903527847424, 3298.752593555469, 3329.1190477380446, 3333.2666813301034, 3339.482380231068, 4665.533446655341, 4712.293156026623, 4729.456112547066, 4730.952690473086, 4785.1625965455905, 4320.351947207912, 4339.414179085815, 4341.60925516705, 4351.063032453081, 4353.25994580922, 4934.149693864801, 5050.974745126251, 5085.73684710304, 5091.567216786578, 5098.0, 3632.854685812564, 3652.8356223969986, 3660.6156353582755, 3674.926501469956, 3690.7970061646597, 5274.156135018417, 5286.788528458857, 5318.840434786963, 5346.866328341823, 5350.625456218067, 3629.4192929131214, 3699.3341198584512, 3718.925621487555, 3742.746180029666, 3756.9060773480337, 3731.209019670519, 3760.304343696425, 3786.6213378662464, 3812.4471951566866, 3818.3890577507464, 4318.719283246579, 4322.848700295537, 4332.870013899588, 4341.565843415633, 4364.148990946798, 4856.417229932431, 5088.669236499616, 5094.363204599425, 5094.694318340911, 5112.821051263188, 1299.3957809618573, 1304.602096360619, 1314.0210543145417, 1317.8352705911761, 1329.936051159069, 816.481534225759, 837.9455335403179, 847.2247893177797, 848.4061157189992, 855.8673405622138, 4450.287953927356, 4596.862094137181, 4609.469910960215, 4629.65277604181, 4630.236011058205, 5238.842834714965, 5260.105782017066, 5317.351620997503, 5327.893442131213, 5338.225957236179, 4447.754628703903, 4562.657800664963, 4593.356930029799, 4593.678442509059, 4610.884727881829, 2791.804573679823, 2802.7197280272217, 2806.9017584384446, 2807.4104438068234, 2830.674472435655, 4946.876328091755, 4948.8429719036185, 4972.72650004246, 4986.32684587576, 5000.974995125001, 5113.769880355393, 5354.3574771027725, 5360.195970604441, 5372.973135134299, 5495.422980587061, 4973.502649734997, 5027.522385373383, 5035.269885866529, 5036.395632524047, 5049.2173713074535, 5269.78920843162, 5286.497782710637, 5296.205569164502, 5299.947000529945, 5301.416844147064, 5003.77483013258, 5178.844634660966, 5181.870453238699, 5191.558717508903, 5195.818146364859, 4920.0, 4949.480304567968, 4959.082569724613, 4975.701457912537, 4981.854173540034, 3758.981205093957, 3759.2481503698823, 3780.4518344840394, 3782.2624588205035, 3786.3184626767447, 5172.224166375074, 5261.605379596469, 5277.551408130352, 5290.550303224115, 5297.2583838263445, 5009.624278179078, 5021.748912554284, 5038.689940615393, 5069.239614057921, 5087.287779710769, 5075.147571136582, 5096.872578185575, 5105.2342148678, 5115.309433226466, 5126.974365128151, 4756.762161891822, 5037.345145131109, 5037.722925239001, 5042.344495215599, 5048.64659473848, 4867.393760059243, 4945.18404463274, 5161.974190129025, 5163.509466600667, 5238.292830467991, 4963.801447942042, 4980.252962055721, 5008.173651347633, 5049.6465247432325, 5058.696478211319], "value": 3853.932368942895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.2293248102276, 644.2687549631167, 650.6519012328405, 660.0363469334771, 749.7450866705319, 12448.128630995834, 13646.18122912626, 13707.040507164502, 13714.177149371044, 13736.587902362933, 11995.400229988509, 12012.939935300334, 12019.338936358497, 12069.155159138863, 12091.758164836698, 612.3203244398713, 731.498923237584, 756.6973210715703, 761.5735188294573, 765.2424100140848, 766.5630590563381, 766.6779952419997, 771.9884201736978, 774.28765535707, 775.0776575874692, 812.5003123079323, 813.4753084260649, 814.2793627639552, 814.3363159025405, 814.7392834293029, 653.3825534869526, 787.0869791042363, 807.7697856111009, 809.348474478045, 810.068421315486, 595.1370512756478, 596.2219303808528, 596.6092209602717, 596.6479776931587, 596.9224000879858, 12739.490420383267, 12808.871911280861, 12809.551665691655, 12818.0, 12818.935905320413, 12506.81239781404, 12947.935260323638, 12985.480580776757, 13010.674733131747, 13123.86876131236, 10936.453177341102, 11173.776524469466, 11269.251720893362, 11521.769564608745, 11567.710807229887, 4188.162367526476, 4208.85269015583, 4226.978865105685, 4371.672124590668, 4376.649868010583, 55575.0, 55784.442155578734, 55871.44128558703, 56376.0, 57626.7118664404, 10086.596536138471, 10330.741731456623, 10502.947485262524, 10540.525676344583, 10742.89257107419, 18499.90750046268, 18505.35231266899, 18506.907465462587, 18577.0, 18585.628287434447, 6821.795346139624, 6904.723811047502, 6927.58434493932, 6961.3038696131, 7114.928850711427, 3753.3405919033844, 3757.6242375762204, 3841.8847434577006, 3849.345611246095, 3855.8843234703004, 2817.7745780337523, 2900.9129726107826, 2917.3727648555237, 2919.737223649882, 2924.035068427414, 458.93574899514095, 481.7254165125915, 495.5713307988636, 501.1480483178538, 506.06125636943676, 484.17448250732417, 516.6383531527946, 531.346443874037, 556.546414672041, 603.7833764963602, 7990.6004699765945, 8171.387145964077, 8206.179382061866, 8341.916580834235, 8543.871841922377, 578.3609111931339, 588.3616276340218, 600.7116584039685, 623.8627501949563, 638.8690318484793, 3599.226166374242, 3750.4186851038135, 3802.391617341212, 3884.902877428087, 3944.15200731844, 54390.728046359516, 82483.58758206171, 90305.0, 91023.59693877646, 91590.54204728933, 67901.99999999901, 74857.0, 80326.0, 82020.0, 82626.0, 71166.64416677986, 71635.0, 72169.6391518039, 72342.0, 73309.63345183454, 8247.670093196204, 8415.20055594742, 8504.630619255282, 8590.226879580618, 8603.569821509025, 41324.58675413328, 41409.37885931653, 42970.0, 43472.56527434812, 45501.77249113733, 42906.570934290256, 63028.0, 65028.34971650412, 65087.67456162689, 65659.67170164119, 10645.946770266099, 11134.777304454028, 11139.830317816837, 11393.601223957121, 11696.181267311547, 11735.765284694087, 11967.401629918295, 12238.510459581517, 12335.136540442083, 13108.082434229895, 10725.892741072801, 10935.671929842118, 11066.39134847591, 11276.548938042386, 11397.943010284895, 10949.83575246388, 11298.548058077913, 11384.260023098472, 11844.407779611158, 11957.222780519238, 10585.4707264638, 11062.280951738112, 11173.49719262619, 11222.607208747655, 11315.20793544444, 8910.153535414125, 8947.418417802823, 9140.542972851465, 9407.294452915921, 9465.100815422524, 8774.473531588124, 8957.686480973134, 9197.908020919705, 9216.0, 9323.72028839136], "value": 6429.869890752008, "unit": "score"}], "name": "dromaeo_css", "value": 6394.307362912417, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 117.0, 116.0, 115.0, 113.0, 116.0, 113.0, 116.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 137.0, 138.0, 180.0, 131.0, 160.0, 155.0, 133.0, 192.0, 130.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 164.0, 164.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 101.0, 75.0, 76.0, 74.0, 75.0, 109.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 114.0, 87.0, 87.0, 86.0, 131.0, 85.0, 86.0, 121.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 120.0, 117.0, 125.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 64.0, 63.0, 65.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 90.0, 84.0, 83.0, 90.0, 89.0, 85.0, 141.0, 84.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 131.0, 132.0, 128.0, 127.0, 131.0, 133.0, 133.0, 144.0, 132.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 168.0, 174.0, 169.0, 169.0, 170.0, 173.0, 164.0, 164.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 67.0, 71.0, 67.0, 69.0, 67.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1557.5, "alertThreshold": 2.0}]} 10:11:20 INFO - Return code: 0 10:11:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:20 INFO - # TBPL SUCCESS # 10:11:20 INFO - Running post-action listener: _resource_record_post_action 10:11:20 INFO - ##### 10:11:20 INFO - ##### Finished run-tests step (success) 10:11:20 INFO - ##### 10:11:20 INFO - Running post-run listener: _resource_record_post_run 10:11:20 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7929856; Write bytes: 422137856; Read time: 1852; Write time: 447160 10:11:20 INFO - TinderboxPrint: CPU usage
13.2% 10:11:20 INFO - TinderboxPrint: I/O read bytes / time
7,929,856 / 1,852 10:11:20 INFO - TinderboxPrint: I/O write bytes / time
422,137,856 / 447,160 10:11:20 INFO - TinderboxPrint: CPU idle
8,336.1 (86.8%) 10:11:20 INFO - TinderboxPrint: CPU user
1,214.6 (12.7%) 10:11:20 INFO - TinderboxPrint: Swap in / out
0 / 0 10:11:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 90382336; Read time: 0; Write time: 77592 10:11:20 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 6168576; Write bytes: 321404928; Read time: 1816; Write time: 347836 10:11:21 INFO - Running post-run listener: _upload_blobber_files 10:11:21 INFO - Blob upload gear active. 10:11:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:21 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:21 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:21 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:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:22 INFO - (blobuploader) - INFO - Done attempting. 10:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:23 INFO - (blobuploader) - INFO - Done attempting. 10:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:27 INFO - (blobuploader) - INFO - Done attempting. 10:11:27 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:27 INFO - Return code: 0 10:11:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e522f4e7cdbf6bbd4de73b7fa2952a112aaf903db287c63195d2e208a1569aad4c6b925d9ddf1cea3520acb5d7335ff76eff6012e6ba17b97a170e99ca84876", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9f2ff9b9b6693c79b97bd5805ed2790b25510694e26b028bffd0f063b5ebb369ff6b7ade1ccdf30a9974596bbfc0578c7de6905969dc9c4ee1f324424179310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3d9934594d15b572ce9759f8b7602aa57b9f28c8b2fef70941bd193121865cc161b11c952afa02639b9dbed090a1cf1f568d2a4511efe39929db914e9f2f0f"} 10:11:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:27 INFO - Contents: 10:11:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e522f4e7cdbf6bbd4de73b7fa2952a112aaf903db287c63195d2e208a1569aad4c6b925d9ddf1cea3520acb5d7335ff76eff6012e6ba17b97a170e99ca84876", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9f2ff9b9b6693c79b97bd5805ed2790b25510694e26b028bffd0f063b5ebb369ff6b7ade1ccdf30a9974596bbfc0578c7de6905969dc9c4ee1f324424179310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3d9934594d15b572ce9759f8b7602aa57b9f28c8b2fef70941bd193121865cc161b11c952afa02639b9dbed090a1cf1f568d2a4511efe39929db914e9f2f0f"} 10:11:27 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:27 INFO - Copying logs to upload dir... 10:11:27 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.889883 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-10 10:11:27.315562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:27.324056) ========= 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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e522f4e7cdbf6bbd4de73b7fa2952a112aaf903db287c63195d2e208a1569aad4c6b925d9ddf1cea3520acb5d7335ff76eff6012e6ba17b97a170e99ca84876", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9f2ff9b9b6693c79b97bd5805ed2790b25510694e26b028bffd0f063b5ebb369ff6b7ade1ccdf30a9974596bbfc0578c7de6905969dc9c4ee1f324424179310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3d9934594d15b572ce9759f8b7602aa57b9f28c8b2fef70941bd193121865cc161b11c952afa02639b9dbed090a1cf1f568d2a4511efe39929db914e9f2f0f"} 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.011158 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e522f4e7cdbf6bbd4de73b7fa2952a112aaf903db287c63195d2e208a1569aad4c6b925d9ddf1cea3520acb5d7335ff76eff6012e6ba17b97a170e99ca84876", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9f2ff9b9b6693c79b97bd5805ed2790b25510694e26b028bffd0f063b5ebb369ff6b7ade1ccdf30a9974596bbfc0578c7de6905969dc9c4ee1f324424179310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b3d9934594d15b572ce9759f8b7602aa57b9f28c8b2fef70941bd193121865cc161b11c952afa02639b9dbed090a1cf1f568d2a4511efe39929db914e9f2f0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:27.356934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:27.357376) ========= 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=0333a256a5e4f052382dd180000001b1-1465574899.597572-1954926369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 10:11:27.436793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 10:11:27.437189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 10:11:27.440572) ========= ========= Total master_lag: 0.19 =========