builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1465515487.81 results: success (0) buildid: 20160609160129 builduid: c2470b5c4cd3408eb951ea7aa37d6172 revision: 880822ee2a0d1e9a847d2f1625964427313fc47a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.813751) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.814381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.814695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.830898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.831397) ========= 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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:38:08-- 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% 46.2M=0s 2016-06-09 16:38:08 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.925634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.926432) ========= 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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.978420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:07.978818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 880822ee2a0d1e9a847d2f1625964427313fc47a --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 880822ee2a0d1e9a847d2f1625964427313fc47a --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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:38:08,201 truncating revision to first 12 chars 2016-06-09 16:38:08,201 Setting DEBUG logging. 2016-06-09 16:38:08,201 attempt 1/10 2016-06-09 16:38:08,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/880822ee2a0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:38:08,788 unpacking tar archive at: fx-team-880822ee2a0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:08.903286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:08.903788) ========= script_repo_revision: 880822ee2a0d1e9a847d2f1625964427313fc47a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:08.904274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:08.904588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:38:08.921725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 16:38:08.922038) ========= /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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:38:09 INFO - MultiFileLogger online at 20160609 16:38:09 in /builds/slave/test 16:38:09 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 16:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:38:09 INFO - {'append_to_log': False, 16:38:09 INFO - 'base_work_dir': '/builds/slave/test', 16:38:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:38:09 INFO - 'branch': 'Fx-Team-Non-PGO', 16:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:09 INFO - 'config_files': ('talos/linux_config.py',), 16:38:09 INFO - 'default_actions': ('clobber', 16:38:09 INFO - 'read-buildbot-config', 16:38:09 INFO - 'download-and-extract', 16:38:09 INFO - 'populate-webroot', 16:38:09 INFO - 'create-virtualenv', 16:38:09 INFO - 'install', 16:38:09 INFO - 'run-tests'), 16:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:09 INFO - 'download_minidump_stackwalk': True, 16:38:09 INFO - 'download_symbols': 'ondemand', 16:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:09 INFO - 'installer_path': 'installer.exe', 16:38:09 INFO - 'log_level': 'info', 16:38:09 INFO - 'log_name': 'talos', 16:38:09 INFO - 'log_to_console': True, 16:38:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:38:09 INFO - 'opt_config_files': (), 16:38:09 INFO - 'pip_index': False, 16:38:09 INFO - 'sps_profile': False, 16:38:09 INFO - 'sps_profile_interval': 0, 16:38:09 INFO - 'suite': 'dromaeojs', 16:38:09 INFO - 'system_bits': '32', 16:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:09 INFO - 'title': 'talos-linux64-ix-031', 16:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:09 INFO - 'use_talos_json': True, 16:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:09 INFO - 'work_dir': 'build'} 16:38:09 INFO - ##### 16:38:09 INFO - ##### Running clobber step. 16:38:09 INFO - ##### 16:38:09 INFO - Running pre-action listener: _resource_record_pre_action 16:38:09 INFO - Running main action method: clobber 16:38:09 INFO - rmtree: /builds/slave/test/build 16:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:09 INFO - Running post-action listener: _resource_record_post_action 16:38:09 INFO - ##### 16:38:09 INFO - ##### Finished clobber step (success) 16:38:09 INFO - ##### 16:38:09 INFO - ##### 16:38:09 INFO - ##### Running read-buildbot-config step. 16:38:09 INFO - ##### 16:38:09 INFO - Running pre-action listener: _resource_record_pre_action 16:38:09 INFO - Running main action method: read_buildbot_config 16:38:09 INFO - Using buildbot properties: 16:38:09 INFO - { 16:38:09 INFO - "project": "", 16:38:09 INFO - "product": "firefox", 16:38:09 INFO - "script_repo_revision": "production", 16:38:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:38:09 INFO - "repository": "", 16:38:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:38:09 INFO - "buildid": "20160609160129", 16:38:09 INFO - "pgo_build": "False", 16:38:09 INFO - "basedir": "/builds/slave/test", 16:38:09 INFO - "buildnumber": 1759, 16:38:09 INFO - "slavename": "talos-linux64-ix-031", 16:38:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:38:09 INFO - "platform": "ubuntu64_hw", 16:38:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:38:09 INFO - "branch": "fx-team", 16:38:09 INFO - "repo_path": "integration/fx-team", 16:38:09 INFO - "revision": "880822ee2a0d1e9a847d2f1625964427313fc47a", 16:38:09 INFO - "stage_platform": "linux64", 16:38:09 INFO - "builduid": "c2470b5c4cd3408eb951ea7aa37d6172", 16:38:09 INFO - "slavebuilddir": "test" 16:38:09 INFO - } 16:38:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:38:09 INFO - Running post-action listener: _resource_record_post_action 16:38:09 INFO - ##### 16:38:09 INFO - ##### Finished read-buildbot-config step (success) 16:38:09 INFO - ##### 16:38:09 INFO - ##### 16:38:09 INFO - ##### Running download-and-extract step. 16:38:09 INFO - ##### 16:38:09 INFO - Running pre-action listener: _resource_record_pre_action 16:38:09 INFO - Running main action method: download_and_extract 16:38:09 INFO - mkdir: /builds/slave/test/build/tests 16:38: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')]} 16:38:09 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:38:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:38:10 INFO - Downloaded 1361 bytes. 16:38:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:38:10 INFO - Using the following test package requirements: 16:38:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:38:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:38:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'jsshell-linux-x86_64.zip'], 16:38:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:38:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:38:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:38:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:38:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:38:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:38:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:38:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:10 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:12 INFO - Downloaded 22880050 bytes. 16:38:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:38:13 INFO - Return code: 0 16:38:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:38: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')]} 16:38:13 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:38:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:38:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:14 INFO - Downloaded 22880050 bytes. 16:38:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:38:16 INFO - Return code: 0 16:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:16 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:38:17 INFO - Downloaded 10833377 bytes. 16:38:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:38:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:38:17 INFO - Return code: 0 16:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:17 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:38:18 INFO - Downloaded 55379494 bytes. 16:38:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:18 INFO - mkdir: /builds/slave/test/properties 16:38:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:18 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:18 INFO - Contents: 16:38:18 INFO - build_url:https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:38:19 INFO - Running post-action listener: _resource_record_post_action 16:38:19 INFO - Running post-action listener: set_extra_try_arguments 16:38:19 INFO - ##### 16:38:19 INFO - ##### Finished download-and-extract step (success) 16:38:19 INFO - ##### 16:38:19 INFO - ##### 16:38:19 INFO - ##### Running populate-webroot step. 16:38:19 INFO - ##### 16:38:19 INFO - Running pre-action listener: _resource_record_pre_action 16:38:19 INFO - Running main action method: populate_webroot 16:38:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:19 INFO - '--tppagecycles', 16:38:19 INFO - '7'], 16:38:19 INFO - 'tests': ['tsvgm']}}, 16:38:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['damp', 'tps']}, 16:38:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'tests': ['damp', 'tps']}, 16:38:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['dromaeo_dom']}, 16:38:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['a11yr', 16:38:19 INFO - 'ts_paint', 16:38:19 INFO - 'tpaint', 16:38:19 INFO - 'sessionrestore', 16:38:19 INFO - 'sessionrestore_no_auto_restore', 16:38:19 INFO - 'tabpaint']}, 16:38:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['tsvgx', 16:38:19 INFO - 'tsvgr_opacity', 16:38:19 INFO - 'tart', 16:38:19 INFO - 'tscrollx', 16:38:19 INFO - 'cart']}, 16:38:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:19 INFO - 'tsvgr_opacity', 16:38:19 INFO - 'tart', 16:38:19 INFO - 'tscrollx', 16:38:19 INFO - 'cart']}, 16:38:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'talos_options': ['--disable-e10s'], 16:38:19 INFO - 'tests': ['tp5o']}, 16:38:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'tests': ['tp5o']}, 16:38:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'talos_options': ['--disable-e10s', 16:38:19 INFO - '--xperf_path', 16:38:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:19 INFO - 'tests': ['tp5n']}, 16:38:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:19 INFO - 'talos_options': ['--xperf_path', 16:38:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:19 INFO - 'tests': ['tp5n']}}, 16:38:19 INFO - 'talos.zip': {'path': '', 16:38:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:19 INFO - Running post-action listener: _resource_record_post_action 16:38:19 INFO - ##### 16:38:19 INFO - ##### Finished populate-webroot step (success) 16:38:19 INFO - ##### 16:38:19 INFO - ##### 16:38:19 INFO - ##### Running create-virtualenv step. 16:38:19 INFO - ##### 16:38:19 INFO - Running pre-action listener: _resource_record_pre_action 16:38:19 INFO - Running main action method: create_virtualenv 16:38:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:38:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:19 INFO - Using real prefix '/usr' 16:38:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:22 INFO - Installing pip.................done. 16:38:22 INFO - Return code: 0 16:38:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:38:22 INFO - Using env: {'DISPLAY': ':0', 16:38:22 INFO - 'HOME': '/home/cltbld', 16:38:22 INFO - 'LANG': 'en_US.UTF-8', 16:38:22 INFO - 'LANGUAGE': 'en_US:en', 16:38:22 INFO - 'LOGNAME': 'cltbld', 16:38:22 INFO - 'MAIL': '/var/mail/cltbld', 16:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:22 INFO - 'MOZ_NO_REMOTE': '1', 16:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:22 INFO - 'NO_EM_RESTART': '1', 16:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:22 INFO - 'PWD': '/builds/slave/test', 16:38:22 INFO - 'SHELL': '/bin/bash', 16:38:22 INFO - 'SHLVL': '1', 16:38:22 INFO - 'TERM': 'linux', 16:38:22 INFO - 'TMOUT': '86400', 16:38:22 INFO - 'USER': 'cltbld', 16:38:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:22 INFO - '_': '/tools/buildbot/bin/python'} 16:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:38:22 INFO - Cleaning up... 16:38:22 INFO - Return code: 0 16:38:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:38:22 INFO - Using env: {'DISPLAY': ':0', 16:38:22 INFO - 'HOME': '/home/cltbld', 16:38:22 INFO - 'LANG': 'en_US.UTF-8', 16:38:22 INFO - 'LANGUAGE': 'en_US:en', 16:38:22 INFO - 'LOGNAME': 'cltbld', 16:38:22 INFO - 'MAIL': '/var/mail/cltbld', 16:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:22 INFO - 'MOZ_NO_REMOTE': '1', 16:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:22 INFO - 'NO_EM_RESTART': '1', 16:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:22 INFO - 'PWD': '/builds/slave/test', 16:38:22 INFO - 'SHELL': '/bin/bash', 16:38:22 INFO - 'SHLVL': '1', 16:38:22 INFO - 'TERM': 'linux', 16:38:22 INFO - 'TMOUT': '86400', 16:38:22 INFO - 'USER': 'cltbld', 16:38:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:22 INFO - '_': '/tools/buildbot/bin/python'} 16:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:22 INFO - Downloading/unpacking psutil>=3.1.1 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:24 INFO - Installing collected packages: psutil 16:38:24 INFO - Running setup.py install for psutil 16:38:24 INFO - building 'psutil._psutil_linux' extension 16:38:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:38:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:38:24 INFO - building 'psutil._psutil_posix' extension 16:38:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:38:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:38:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:25 INFO - Successfully installed psutil 16:38:25 INFO - Cleaning up... 16:38:25 INFO - Return code: 0 16:38:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:25 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:38:25 INFO - Using env: {'DISPLAY': ':0', 16:38:25 INFO - 'HOME': '/home/cltbld', 16:38:25 INFO - 'LANG': 'en_US.UTF-8', 16:38:25 INFO - 'LANGUAGE': 'en_US:en', 16:38:25 INFO - 'LOGNAME': 'cltbld', 16:38:25 INFO - 'MAIL': '/var/mail/cltbld', 16:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:25 INFO - 'MOZ_NO_REMOTE': '1', 16:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:25 INFO - 'NO_EM_RESTART': '1', 16:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:25 INFO - 'PWD': '/builds/slave/test', 16:38:25 INFO - 'SHELL': '/bin/bash', 16:38:25 INFO - 'SHLVL': '1', 16:38:25 INFO - 'TERM': 'linux', 16:38:25 INFO - 'TMOUT': '86400', 16:38:25 INFO - 'USER': 'cltbld', 16:38:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:25 INFO - '_': '/tools/buildbot/bin/python'} 16:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:38:27 INFO - Installing collected packages: mozsystemmonitor 16:38:27 INFO - Running setup.py install for mozsystemmonitor 16:38:27 INFO - Successfully installed mozsystemmonitor 16:38:27 INFO - Cleaning up... 16:38:27 INFO - Return code: 0 16:38:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:27 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:38:27 INFO - Using env: {'DISPLAY': ':0', 16:38:27 INFO - 'HOME': '/home/cltbld', 16:38:27 INFO - 'LANG': 'en_US.UTF-8', 16:38:27 INFO - 'LANGUAGE': 'en_US:en', 16:38:27 INFO - 'LOGNAME': 'cltbld', 16:38:27 INFO - 'MAIL': '/var/mail/cltbld', 16:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:27 INFO - 'MOZ_NO_REMOTE': '1', 16:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:27 INFO - 'NO_EM_RESTART': '1', 16:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:27 INFO - 'PWD': '/builds/slave/test', 16:38:27 INFO - 'SHELL': '/bin/bash', 16:38:27 INFO - 'SHLVL': '1', 16:38:27 INFO - 'TERM': 'linux', 16:38:27 INFO - 'TMOUT': '86400', 16:38:27 INFO - 'USER': 'cltbld', 16:38:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:27 INFO - '_': '/tools/buildbot/bin/python'} 16:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:29 INFO - warning: no files found matching '*.txt' 16:38:29 INFO - no previously-included directories found matching 'build' 16:38:29 INFO - no previously-included directories found matching 'dist' 16:38:29 INFO - no previously-included directories found matching '.git*' 16:38:29 INFO - Installing collected packages: jsonschema, functools32 16:38:29 INFO - Running setup.py install for functools32 16:38:30 INFO - warning: no files found matching '*.txt' 16:38:30 INFO - no previously-included directories found matching 'build' 16:38:30 INFO - no previously-included directories found matching 'dist' 16:38:30 INFO - no previously-included directories found matching '.git*' 16:38:30 INFO - Successfully installed jsonschema functools32 16:38:30 INFO - Cleaning up... 16:38:30 INFO - Return code: 0 16:38:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:30 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:38:30 INFO - Using env: {'DISPLAY': ':0', 16:38:30 INFO - 'HOME': '/home/cltbld', 16:38:30 INFO - 'LANG': 'en_US.UTF-8', 16:38:30 INFO - 'LANGUAGE': 'en_US:en', 16:38:30 INFO - 'LOGNAME': 'cltbld', 16:38:30 INFO - 'MAIL': '/var/mail/cltbld', 16:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:30 INFO - 'MOZ_NO_REMOTE': '1', 16:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:30 INFO - 'NO_EM_RESTART': '1', 16:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:30 INFO - 'PWD': '/builds/slave/test', 16:38:30 INFO - 'SHELL': '/bin/bash', 16:38:30 INFO - 'SHLVL': '1', 16:38:30 INFO - 'TERM': 'linux', 16:38:30 INFO - 'TMOUT': '86400', 16:38:30 INFO - 'USER': 'cltbld', 16:38:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:30 INFO - '_': '/tools/buildbot/bin/python'} 16:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:32 INFO - Downloading docopt-0.6.1.tar.gz 16:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:32 INFO - Running setup.py install for blobuploader 16:38:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:33 INFO - Running setup.py install for requests 16:38:33 INFO - Running setup.py install for docopt 16:38:33 INFO - Successfully installed blobuploader requests docopt 16:38:33 INFO - Cleaning up... 16:38:33 INFO - Return code: 0 16:38:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:33 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:33 INFO - Using env: {'DISPLAY': ':0', 16:38:33 INFO - 'HOME': '/home/cltbld', 16:38:33 INFO - 'LANG': 'en_US.UTF-8', 16:38:33 INFO - 'LANGUAGE': 'en_US:en', 16:38:33 INFO - 'LOGNAME': 'cltbld', 16:38:33 INFO - 'MAIL': '/var/mail/cltbld', 16:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:33 INFO - 'MOZ_NO_REMOTE': '1', 16:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:33 INFO - 'NO_EM_RESTART': '1', 16:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:33 INFO - 'PWD': '/builds/slave/test', 16:38:33 INFO - 'SHELL': '/bin/bash', 16:38:33 INFO - 'SHLVL': '1', 16:38:33 INFO - 'TERM': 'linux', 16:38:33 INFO - 'TMOUT': '86400', 16:38:33 INFO - 'USER': 'cltbld', 16:38:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:33 INFO - '_': '/tools/buildbot/bin/python'} 16:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:33 INFO - Running setup.py (path:/tmp/pip-GdYVLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:33 INFO - Running setup.py (path:/tmp/pip-7zJCzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:33 INFO - Running setup.py (path:/tmp/pip-RksoOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:34 INFO - Running setup.py (path:/tmp/pip-a5BLOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:34 INFO - Running setup.py (path:/tmp/pip-E_c30b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:34 INFO - Running setup.py (path:/tmp/pip-ZBlpoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:34 INFO - Running setup.py (path:/tmp/pip-T13HQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:34 INFO - Running setup.py (path:/tmp/pip-O2hwGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:34 INFO - Running setup.py (path:/tmp/pip-dwzfi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:34 INFO - Running setup.py (path:/tmp/pip-Z7z1Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:34 INFO - Running setup.py (path:/tmp/pip-jfkQOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:34 INFO - Running setup.py (path:/tmp/pip-kbhve_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:34 INFO - Running setup.py (path:/tmp/pip-sd6gZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:34 INFO - Running setup.py (path:/tmp/pip-sCMWWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:34 INFO - Running setup.py (path:/tmp/pip-XP5b1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:34 INFO - Running setup.py (path:/tmp/pip-Ebelsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:34 INFO - Running setup.py (path:/tmp/pip-1PnwS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:35 INFO - Running setup.py install for manifestparser 16:38:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Running setup.py install for mozcrash 16:38:35 INFO - Running setup.py install for mozdebug 16:38:35 INFO - Running setup.py install for mozdevice 16:38:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Running setup.py install for mozfile 16:38:35 INFO - Running setup.py install for mozhttpd 16:38:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Running setup.py install for mozinfo 16:38:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Running setup.py install for mozInstall 16:38:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:35 INFO - Running setup.py install for mozleak 16:38:35 INFO - Running setup.py install for mozlog 16:38:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Running setup.py install for moznetwork 16:38:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Running setup.py install for mozprocess 16:38:36 INFO - Running setup.py install for mozprofile 16:38:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Running setup.py install for mozrunner 16:38:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Running setup.py install for mozscreenshot 16:38:36 INFO - Running setup.py install for moztest 16:38:36 INFO - Running setup.py install for mozversion 16:38:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:36 INFO - Cleaning up... 16:38:36 INFO - Return code: 0 16:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:36 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:36 INFO - Using env: {'DISPLAY': ':0', 16:38:36 INFO - 'HOME': '/home/cltbld', 16:38:36 INFO - 'LANG': 'en_US.UTF-8', 16:38:36 INFO - 'LANGUAGE': 'en_US:en', 16:38:36 INFO - 'LOGNAME': 'cltbld', 16:38:36 INFO - 'MAIL': '/var/mail/cltbld', 16:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:36 INFO - 'MOZ_NO_REMOTE': '1', 16:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:36 INFO - 'NO_EM_RESTART': '1', 16:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:36 INFO - 'PWD': '/builds/slave/test', 16:38:36 INFO - 'SHELL': '/bin/bash', 16:38:36 INFO - 'SHLVL': '1', 16:38:36 INFO - 'TERM': 'linux', 16:38:36 INFO - 'TMOUT': '86400', 16:38:36 INFO - 'USER': 'cltbld', 16:38:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:36 INFO - '_': '/tools/buildbot/bin/python'} 16:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:37 INFO - Running setup.py (path:/tmp/pip-RmjuAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:37 INFO - Running setup.py (path:/tmp/pip-8gnWdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:37 INFO - Running setup.py (path:/tmp/pip-5iHENg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:37 INFO - Running setup.py (path:/tmp/pip-2j3Dvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:37 INFO - Running setup.py (path:/tmp/pip-4mhpgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:37 INFO - Running setup.py (path:/tmp/pip-aqe7vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:37 INFO - Running setup.py (path:/tmp/pip-y3lTLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:37 INFO - Running setup.py (path:/tmp/pip-1cPyKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:37 INFO - Running setup.py (path:/tmp/pip-69xDG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:37 INFO - Running setup.py (path:/tmp/pip-KMzSMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:37 INFO - Running setup.py (path:/tmp/pip-kqH_nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:37 INFO - Running setup.py (path:/tmp/pip-BNsn6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:37 INFO - Running setup.py (path:/tmp/pip-ri1cZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:37 INFO - Running setup.py (path:/tmp/pip-ybYn0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:38 INFO - Running setup.py (path:/tmp/pip-JzbN0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:38 INFO - Running setup.py (path:/tmp/pip-4mBX9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:38 INFO - Running setup.py (path:/tmp/pip-xh6pyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:38:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:40 INFO - Downloading blessings-1.6.tar.gz 16:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:40 INFO - Installing collected packages: blessings 16:38:40 INFO - Running setup.py install for blessings 16:38:40 INFO - Successfully installed blessings 16:38:40 INFO - Cleaning up... 16:38:40 INFO - Return code: 0 16:38:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:40 INFO - Reading from file tmpfile_stdout 16:38:40 INFO - Current package versions: 16:38:40 INFO - argparse == 1.2.1 16:38:40 INFO - blessings == 1.6 16:38:40 INFO - blobuploader == 1.2.4 16:38:40 INFO - docopt == 0.6.1 16:38:40 INFO - functools32 == 3.2.3-2 16:38:40 INFO - jsonschema == 2.5.1 16:38:40 INFO - manifestparser == 1.1 16:38:40 INFO - mozInstall == 1.12 16:38:40 INFO - mozcrash == 0.17 16:38:40 INFO - mozdebug == 0.1 16:38:40 INFO - mozdevice == 0.48 16:38:40 INFO - mozfile == 1.2 16:38:40 INFO - mozhttpd == 0.7 16:38:40 INFO - mozinfo == 0.9 16:38:40 INFO - mozleak == 0.1 16:38:40 INFO - mozlog == 3.2 16:38:40 INFO - moznetwork == 0.27 16:38:40 INFO - mozprocess == 0.22 16:38:40 INFO - mozprofile == 0.28 16:38:40 INFO - mozrunner == 6.11 16:38:40 INFO - mozscreenshot == 0.1 16:38:40 INFO - mozsystemmonitor == 0.3 16:38:40 INFO - moztest == 0.7 16:38:40 INFO - mozversion == 1.4 16:38:40 INFO - psutil == 3.1.1 16:38:40 INFO - requests == 1.2.3 16:38:40 INFO - wsgiref == 0.1.2 16:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:38:40 INFO - Using env: {'DISPLAY': ':0', 16:38:40 INFO - 'HOME': '/home/cltbld', 16:38:40 INFO - 'LANG': 'en_US.UTF-8', 16:38:40 INFO - 'LANGUAGE': 'en_US:en', 16:38:40 INFO - 'LOGNAME': 'cltbld', 16:38:40 INFO - 'MAIL': '/var/mail/cltbld', 16:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:40 INFO - 'MOZ_NO_REMOTE': '1', 16:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:40 INFO - 'NO_EM_RESTART': '1', 16:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:40 INFO - 'PWD': '/builds/slave/test', 16:38:40 INFO - 'SHELL': '/bin/bash', 16:38:40 INFO - 'SHLVL': '1', 16:38:40 INFO - 'TERM': 'linux', 16:38:40 INFO - 'TMOUT': '86400', 16:38:40 INFO - 'USER': 'cltbld', 16:38:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:40 INFO - '_': '/tools/buildbot/bin/python'} 16:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:38:40 INFO - Cleaning up... 16:38:40 INFO - Return code: 0 16:38:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:38:40 INFO - Using env: {'DISPLAY': ':0', 16:38:40 INFO - 'HOME': '/home/cltbld', 16:38:40 INFO - 'LANG': 'en_US.UTF-8', 16:38:40 INFO - 'LANGUAGE': 'en_US:en', 16:38:40 INFO - 'LOGNAME': 'cltbld', 16:38:40 INFO - 'MAIL': '/var/mail/cltbld', 16:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:40 INFO - 'MOZ_NO_REMOTE': '1', 16:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:40 INFO - 'NO_EM_RESTART': '1', 16:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:40 INFO - 'PWD': '/builds/slave/test', 16:38:40 INFO - 'SHELL': '/bin/bash', 16:38:40 INFO - 'SHLVL': '1', 16:38:40 INFO - 'TERM': 'linux', 16:38:40 INFO - 'TMOUT': '86400', 16:38:40 INFO - 'USER': 'cltbld', 16:38:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:40 INFO - '_': '/tools/buildbot/bin/python'} 16:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:41 INFO - Cleaning up... 16:38:41 INFO - Return code: 0 16:38:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:41 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 0x7f6c75987f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b66350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, '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': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:38:41 INFO - Using env: {'DISPLAY': ':0', 16:38:41 INFO - 'HOME': '/home/cltbld', 16:38:41 INFO - 'LANG': 'en_US.UTF-8', 16:38:41 INFO - 'LANGUAGE': 'en_US:en', 16:38:41 INFO - 'LOGNAME': 'cltbld', 16:38:41 INFO - 'MAIL': '/var/mail/cltbld', 16:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:41 INFO - 'MOZ_NO_REMOTE': '1', 16:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:41 INFO - 'NO_EM_RESTART': '1', 16:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:41 INFO - 'PWD': '/builds/slave/test', 16:38:41 INFO - 'SHELL': '/bin/bash', 16:38:41 INFO - 'SHLVL': '1', 16:38:41 INFO - 'TERM': 'linux', 16:38:41 INFO - 'TMOUT': '86400', 16:38:41 INFO - 'USER': 'cltbld', 16:38:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:41 INFO - '_': '/tools/buildbot/bin/python'} 16:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:41 INFO - Downloading/unpacking flake8 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:38:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:38:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:38:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:43 INFO - no previously-included directories found matching 'docs/_build' 16:38:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:38:43 INFO - Running setup.py install for pep8 16:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:44 INFO - no previously-included directories found matching 'docs/_build' 16:38:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:38:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:38:44 INFO - Cleaning up... 16:38:44 INFO - Return code: 0 16:38:44 INFO - Running post-action listener: _resource_record_post_action 16:38:44 INFO - Running post-action listener: _start_resource_monitoring 16:38:44 INFO - Starting resource monitoring. 16:38:44 INFO - ##### 16:38:44 INFO - ##### Finished create-virtualenv step (success) 16:38:44 INFO - ##### 16:38:44 INFO - ##### 16:38:44 INFO - ##### Running install step. 16:38:44 INFO - ##### 16:38:44 INFO - Running pre-action listener: _resource_record_pre_action 16:38:44 INFO - Running main action method: install 16:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:44 INFO - Reading from file tmpfile_stdout 16:38:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:38:44 INFO - Reading from file tmpfile_stdout 16:38:44 INFO - Output received: 16:38:44 INFO - Usage: mozinstall [options] installer 16:38:44 INFO - Options: 16:38:44 INFO - -h, --help show this help message and exit 16:38:44 INFO - -d DEST, --destination=DEST 16:38:44 INFO - Directory to install application into. [default: 16:38:44 INFO - "/builds/slave/test"] 16:38:44 INFO - --app=APP Application being installed. [default: firefox] 16:38:44 INFO - mkdir: /builds/slave/test/build/application 16:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:39:00 INFO - Reading from file tmpfile_stdout 16:39:00 INFO - Output received: 16:39:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:39:00 INFO - Running post-action listener: _resource_record_post_action 16:39:00 INFO - ##### 16:39:00 INFO - ##### Finished install step (success) 16:39:00 INFO - ##### 16:39:00 INFO - ##### 16:39:00 INFO - ##### Running run-tests step. 16:39:00 INFO - ##### 16:39:00 INFO - Running pre-action listener: _resource_record_pre_action 16:39:00 INFO - Running main action method: run_tests 16:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:00 INFO - Python 2.7.3 16:39:00 INFO - Return code: 0 16:39:00 INFO - grabbing minidump binary from tooltool 16:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:00 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 0x2bf51c0>, '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 0x2bf60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:39:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:39:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:39:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:00 INFO - Return code: 0 16:39:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:39:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:39:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:39:01 INFO - Return code: 0 16:39:01 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:39:01 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 16:39:01 INFO - Using env: {'DISPLAY': ':0', 16:39:01 INFO - 'HOME': '/home/cltbld', 16:39:01 INFO - 'LANG': 'en_US.UTF-8', 16:39:01 INFO - 'LANGUAGE': 'en_US:en', 16:39:01 INFO - 'LOGNAME': 'cltbld', 16:39:01 INFO - 'MAIL': '/var/mail/cltbld', 16:39:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:01 INFO - 'MOZ_NO_REMOTE': '1', 16:39:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:01 INFO - 'NO_EM_RESTART': '1', 16:39:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:01 INFO - 'PWD': '/builds/slave/test', 16:39:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:01 INFO - 'SHELL': '/bin/bash', 16:39:01 INFO - 'SHLVL': '1', 16:39:01 INFO - 'TERM': 'linux', 16:39:01 INFO - 'TMOUT': '86400', 16:39:01 INFO - 'USER': 'cltbld', 16:39:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084', 16:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:01 INFO - '_': '/tools/buildbot/bin/python'} 16:39:01 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 16:39:01 INFO - mozversion application_buildid: 20160609160129 16:39:01 INFO - mozversion application_changeset: 880822ee2a0d1e9a847d2f1625964427313fc47a 16:39:01 INFO - mozversion application_display_name: Nightly 16:39:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:01 INFO - mozversion application_name: Firefox 16:39:01 INFO - mozversion application_remotingname: firefox 16:39:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:39:01 INFO - mozversion application_vendor: Mozilla 16:39:01 INFO - mozversion application_version: 50.0a1 16:39:01 INFO - mozversion platform_buildid: 20160609160129 16:39:01 INFO - mozversion platform_changeset: 880822ee2a0d1e9a847d2f1625964427313fc47a 16:39:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:39:01 INFO - mozversion platform_version: 50.0a1 16:39:01 INFO - using testdate: 1465515541 16:39:01 INFO - actual date: 1465515541 16:39:01 INFO - starting webserver on 'localhost:56278' 16:39:01 INFO - SUITE-START | Running 2 tests 16:39:01 INFO - TEST-START | dromaeo_css 16:39:01 INFO - operating with platform_type : linux_ 16:39:01 INFO - Initialising browser for dromaeo_css test... 16:39:01 INFO - TEST-INFO | started process 17694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0G4pI/profile http://localhost:56278/getInfo.html) 16:39:06 INFO - PROCESS | 17694 | __metrics Screen width/height:1600/1200 16:39:06 INFO - PROCESS | 17694 | colorDepth:24 16:39:06 INFO - PROCESS | 17694 | Browser inner width/height: 1024/697 16:39:06 INFO - PROCESS | 17694 | __metrics 16:39:07 ERROR - PROCESS | 17694 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:39:07 INFO - PROCESS | 17694 | console.error: PushService: 16:39:07 INFO - PROCESS | 17694 | stateChangeProcessEnqueue: Error transitioning state 16:39:07 INFO - PROCESS | 17694 | UnknownError 16:39:08 INFO - TEST-INFO | 17694: exit 0 16:39:08 INFO - Browser initialized. 16:39:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:08 INFO - TEST-INFO | started process 17772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0G4pI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:20 INFO - PROCESS | 17772 | RSS: Main: 175190016 16:39:20 INFO - PROCESS | 17772 | 16:40:12 INFO - PROCESS | 17772 | 1465515612376 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:42:23 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56278/tests/dromaeo/cssquery-ext.html) 16:42:24 INFO - PROCESS | 17772 | RSS: Main: 281079808 16:42:24 INFO - PROCESS | 17772 | 16:45:27 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-ext.html (next: http://localhost:56278/tests/dromaeo/cssquery-jquery.html) 16:45:28 INFO - PROCESS | 17772 | RSS: Main: 261459968 16:45:28 INFO - PROCESS | 17772 | 16:48:30 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56278/tests/dromaeo/cssquery-mootools.html) 16:48:31 INFO - PROCESS | 17772 | RSS: Main: 252559360 16:48:31 INFO - PROCESS | 17772 | 16:51:33 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56278/tests/dromaeo/cssquery-prototype.html) 16:51:33 INFO - PROCESS | 17772 | RSS: Main: 253919232 16:51:33 INFO - PROCESS | 17772 | 16:54:36 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56278/tests/dromaeo/cssquery-yui.html) 16:54:37 INFO - PROCESS | 17772 | RSS: Main: 241950720 16:54:37 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-yui.html (next: http://localhost:56278/tests/dromaeo/cssquery-dojo.html) 16:57:40 INFO - PROCESS | 17772 | RSS: Main: 296214528 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | __start_tp_report 16:57:40 INFO - PROCESS | 17772 | _x_x_mozilla_page_load 16:57:40 INFO - PROCESS | 17772 | _x_x_mozilla_page_load_details 16:57:40 INFO - PROCESS | 17772 | |i|pagename|runs| 16:57:40 INFO - PROCESS | 17772 | |0;dojo.html;2581.1482210870413;2609.647697560831;2629.355807827082;2651.244395347326;2651.2841532786147;4462.665300102497;4542.659300552464;4599.8390056348035;4657.790399432025;4702.224133018052;4565.726056436616;4568.680192386534;4595.03504264105;4625.444946606412;4626.5373462653715;4246.447961764974;4259.233337999174;4273.572642735717;4279.7860106994685;4418.779061046951;4291.742495450283;4349.195398851207;4368.89077773055;4373.190959672471;4414.29371300592;4139.048018955657;4321.027768752006;4354.129174165179;4364.629006534448;4374.759388233646;4180.163967206571;4218.050938538835;4235.8729238122905;4237.385579091046;4239.894002649928;4215.199112168678;4269.274223382002;4271.893202669927;4280.9143817123795;4318.438602981623;4497.775111244425;4664.346991421204;4682.227432473638;4702.247640377557;4706.294055891643;4893.217085266376;4941.209406494943;4954.826581069645;5009.674371165899;5012.598992080625;4995.725235112068;5025.3718285214345;5031.597472202252;5044.092063428581;5049.166887463564;4526.569975852289;4672.57946784791;4691.014886873795;4691.038337140878;4696.084263568571;5064.873378165576;5090.974545127251;5111.514406131411;5111.667741596784;5178;4955.702657840541;4958.107540642647;4967.602591792648;4974.154393752999;4974.228994505857;4811.78346974387;4885.096257192431;5007.824726134568;5009.148444764399;5048.116579598555;4887.584555312767;4924.162892308316;4956.8760780980765;4965.8013679452415;4970.527799859007;4893.828715994994;4900.117978763786;4900.656954013185;4914.189158788831;4956.479569645207;4036.2936486114813;4141.358089496133;4152.8131234094535;4160.750354978711;4192.622663960258;3597.6402359763815;3667.4865518827387;3677.0623491010156;3682.6317368262958;3740.139767853409;4396.736195828261;4399.142167277414;4399.62603178727;4437.689361744711;4439.001224724411;4847.709137451764;5048.268001139888;5054.342935418372;5056;5082.618803589746;4273.358996150602;4326.805293761789;4373.322135069069;4376.431063961664;4390.05613793036;4472.329150627367;4482.843100491467;4486.775661216926;4490.034642551867;4519.344695019204;4598.839040633562;4768.904621907612;4769.761511924459;4770.809167633256;4809.615230781529;4957.206846904478;4987.875303117451;4993.300937868628;4996.350474438445;5009.323741294878;4708.693934894221;4714.57568818808;4734.147853386424;4742.976285118552;4782.258749893772;4749.952500474951;4842.346283251716;4918.532739389752;4949.925751113664;4982.028504441599;4937.604991600735;4968.726720030433;4976.527229913152;4977.203647416396;5017;4835.032993401404;4844.636652251025;4849.515048495122;4859.4654587996;4897.534734200245;4687.343771871872;4776.8566942991765;4813.15769740287;4858.028394321079;4888.2178851383605;4785.832495862628;4792.281157826354;4814.975925120352;4829.154897892925;4831.057943700945;4869.610431165427;4873.074115917964;4875.0493653737185;4908.901821963612;4917.508249175054;4624.1445332613575;4766.642501812308;4813.03739252144;4816.181249187716;4838.612910967044 16:57:40 INFO - PROCESS | 17772 | |1;ext.html;558.6396774080717;582.0076769108668;585.1398444286897;586.7447660267782;598.4135547163779;27108.593371099425;39646.801765991164;41044;41063.384049239285;44677.32984005234;41575;41972.16055678885;42001.57998420015;42045.57954420455;42058.7897060515;7462.738804141856;7870.842583148334;8021.077576078738;8021.639026243833;8023.558704271263;10019.949900250489;10296.48517574122;10313.07182353588;10652.680419587425;10672.62645807397;10327.84508232377;10432.530536125892;10438.269321147523;10440.791184176313;10442.477876106203;7546.24537546241;10070.194384449227;10367.585296588128;10392.168626509936;10436.947815260914;10240.231982601335;10296.79406411875;10301.227407944434;10303.896961030368;10317.48412579368;39114;39350.80324598387;39418.21163576741;39429.211415771526;39453.40819887704;2767.8892844286406;2878.3955369372457;2894.5079336512845;3232.997770691093;3289.1283809790425;29841;30073.699263007307;30575.541366879515;31169.688303116905;31217.37565248705;3573.982130089359;3583.45000148939;3594.676479116892;3612.9277414451826;3683.7053035757344;245903;246014;246080;247018;247961;31641.683583164333;32882.3423531528;32906.341873162404;52906.47093529093;53323.466765332625;33882.322353552794;33960.49059264113;34107.31785364279;34124.14689632729;34128.658713413046;13879.167249964832;14114.505992290426;14115.85884141166;14120.293985300694;14123.929380353238;9795.069468400634;11412.543498260142;11557.190996630155;11587.536498540132;11623.709407264885;7967.601619918981;7971.362291016821;7986.520808751377;8030.558319292495;8067;3122.2038380213353;3132.4988001919583;3136.905892823219;3175.36492701456;3189.7607679424136;859.6604341285157;910.6812615584493;932;940.2431043010442;1027.5684212630713;27821.210654719504;28431.431371372455;28442.857785710938;28498.430031399257;28532.28669283243;951.5622813505727;953.5756588318131;973.78576713123;1050.4695128959827;1087.0162502934857;14744.41022359115;14879.70240595182;15023.173725445205;15161.772573411408;15280.617984550252;373411;375658;376464;376722;376952;48280.03439931252;49563.752181239586;49631.50368496341;49646;49745.502544974814;1087.499750114956;1143.2568830260398;1144.0904480937675;1185.875483074282;1231.1197493791803;20061.799382005993;28234.71765282321;28803.711962880105;29268.121956341343;29296.707032929397;52059;54045.189322159415;54048;54143.458565415414;54146.18780718371;345881;353005;354185;355489;355620;32369.35261294714;38968.41547376848;40520.3921941177;41411.585884140775;42385.78807105945;42126.78936605297;42587.5741242596;42797.786011069744;42939.785301073294;43602;35597.64402356047;36690.44964325591;37011.44482832706;37383.43924841075;37835.24329513339;36520.45219321659;36526.452103219;36781;36967.26065478729;37070.25859482849;35684;36019.27961440704;36336;36745.816270918476;36808.07979800527;31066.223344416572;31571.181716005885;31789.523157153122;32074.19814504656;32122.35755284928;24905.62641560342;24958.37604059913;25427.74572254254;25682.101126460486;25747.742522574536 16:57:40 INFO - PROCESS | 17772 | |2;jquery.html;355.5218231478661;356.87509371719887;362.14533700466893;372.78192257529344;379.78352339166685;15776.132312722795;16607.50177494674;17776.822231777678;17789.11054447279;17793.733094003568;16759.162041897886;16864.072476013815;16935.576610584743;17332.566685832862;17342.306307747676;4888.780004899788;5138.974305128488;5151.948480515184;5156.278121063054;5162.096633089194;3147.0716138739012;3276.410246155691;5107.744612769366;5553.500184983351;5889.85275368115;5881.323647780496;5889.146073819294;5927.525797936155;5937;5945.108233764927;5756.827295181151;5884.117382392633;5920.082387229986;5922.052471604544;5947.375525569818;2834.1214223590546;4811.615070794328;5112.795488180468;5129.204973229155;5135.460776618476;20325.593488130155;20373.388798336073;20416.489587760276;20816.687749683766;20822.895885520626;1842.824931631493;1867.159778099847;1903.4860587641397;2156.212982261479;2219.2343641443676;13024.348782560834;13096.803547946789;13177;13223.33883305831;13672.248026358546;1575.4249698859833;1694.8644108471292;1819.1268191268266;1849.2658793488713;1939.2824654877645;67727.66136169338;67952.660236699;68646.31353686449;69457.65271173662;69774.3022569778;9803.558839852223;9942.254330925065;9942.552585133686;10094;10470.534125222475;13901.374438150307;13980.091294065853;13986.720265594631;13987.650308742363;14001.29993500321;7495.625218739041;7565.73519926811;7586.468947173645;7593.696252149852;7714.845703085907;7123.180834204133;7130.607816570138;7247.16657584374;7259.656963461776;7320.67056982437;4217.683673724483;4324.329728891964;4345.630621397154;4398.890027749268;4523.117991991596;1683.5622738088184;1732.5322163016167;1739.3563082886803;1786.6694661487666;1813.193129057583;370.06373874098574;382.9425586162098;393.6004954970707;398.20756694178954;824.282873899711;10793.29843560166;10817.350958942488;10841.945790270998;10860.72848178786;11035;391.3210579644315;395.8317714971183;397.5626810508418;400.055868151163;403.2962480471537;4975.353204083446;5719.685417302005;5787.797427090031;5857.502112320501;5884.382139875337;363868;365556;371545;372406;395093;80448;80502.59748701219;81261;81607;82206;408.46083170215627;415.0122707955048;418.0364260379793;418.18245330379034;418.34946657946574;9861.359011664219;9998.100170984646;10238.078572928473;10356.896431035593;10375.221858360805;34462.310753785285;34572.654273456945;35235;35250;35381.28960119269;48603.756981214865;49714;49859.50140498549;50595.74702126466;51049.744751276005;6280.685965701605;6997.020417141706;7013.824654383681;7795.610219489116;7971.481853679492;10550.630727924487;11199.21605487608;11634.418279086181;11962.700932476757;12063.939680301542;9793.951030244803;9935.503224838874;10111.3427627204;10128.493575321352;10484;9549.618015279311;9857.11285984265;9900.455474948947;10114.241431892491;10215.284930054824;10146.543405546916;10281.84577231357;10310.381377117397;10534.52594633228;10546.26176167661;7052.929470705228;7090.220075791555;7125.893111603226;7191.316824901626;7257.600831954293;7723.1118421380015;7734.574598397142;7735.497192682457;8877.911220887709;10210.642627508001 16:57:40 INFO - PROCESS | 17772 | |3;mootools.html;1247.151936683055;1353.857844926283;1396.1413730555707;1443.7906503556985;1654.5532706169336;6513.185851768529;7094.11323584552;7295.234000429945;7297.927020729791;7488.138864030638;7247.818804529889;7357.926420735791;7365.189829118806;7378.151512576055;7391.704331826721;1820.1172431370774;1882.2753240002628;1885.0668918885171;2093.2673564252505;2129.691194776756;1829.1860122245605;2082.6251274770534;2160.503084290614;2162.9891850540725;2174.4672555223915;2098.1187901081507;2121.575684863026;2122.7983341582526;2135.5942370949547;2138.2836749688795;1771.6722406354866;2049.784772598878;2062.6905964105354;2064.6386882295537;2067.080149333547;2033.5526184239443;2093.2568938027084;2094.7800480949586;2102.127617038927;2107.262458139654;7654.043244594426;7678.5392876427595;7725.806854828675;7732.265434783687;7766.37868970481;4325.113351762881;4448.822047118111;4454.732716037016;4456.064226512436;4458.464984201884;2627.4351014531776;2720.3607152319387;2745.094118940745;2745.8489783061923;2748.093129267337;838.6813011055821;863.9265662418702;877.9824403511958;878.6265837019241;879.4195830751673;10481.109105726022;10527.78944421115;10553.208509361752;10560.102391296748;10571.2600117991;3996.660283875903;4072.450219220367;4097.09863829957;4145.751254924654;4183.518895327015;8936.597853096626;8985.281177505783;8989.865152022725;8994.370394072483;9028.593713282919;4505.031418245093;4514.706544074625;4521.118381915495;4529.569690879362;4533.637309015271;3421.5209870618132;3516.156122530574;4005.239004589119;4104.548499665035;4114.670826333946;3507.193345530542;3537.4870643756512;3599.208174201671;3603.7117030637487;3618.16782140104;1117.8379135025539;1128.6896103571419;1128.6952522818792;1138.408027825526;1146.810776221914;669.3473862983552;775.7129861951001;793.1592511937365;794.265304593249;801.867691830853;4829.541193586674;4853.778429202471;4940.110780059624;4978.377702787152;4996.375453068366;854.2482615298497;854.8715695282292;856.7729551668813;857.1428571428571;868.4355169140109;3307.58655168104;3434.8797792077157;3467.809270490097;3485.8605655773486;3486.633903440153;9140.771480712903;9334.579943902541;9481;9509.049095090573;9543.809123817486;9227.077292270718;9372.95313523428;9402.717918462457;9403.764905877408;9433.48115853621;7091.468139889529;7165.7850264492145;7256.854862902713;7332.670029848563;7338.559686418938;4920.852374428773;4938.530839570235;4988.900221995613;5044.192929131322;5066.797328106834;8653;8715.38992270535;8793.384463087777;8904.065073167483;8914.153155450222;8764.78088047804;8892.86660700103;8898.35380454618;8937.687180948635;8961.148690874357;5555.7499912504845;5995.340512543529;6519.674016299071;6540.37866402691;6585.703643335965;7057.6471176442;7245.746398876014;7297.343239108293;7299.452541059548;7301.4158867289425;6295.842603934938;6557.540972132096;6561.934380656323;6586.571872828251;6665.633390163393;6416.390442907917;6420.357964203729;6504.707288171949;6551.705173267119;6594.90107648376;5909.3795151508475;5942.702864856827;5955.940440595712;5965.463108320272;5965.880682386415;4202.41166236721;4259.361095835649;4366.2577361847925;4436.955630443784;4504.926796186252;4226.1758957003085;4286.635635970977;4319.784010799384;4409.977950110358;4430.778461076998 16:57:40 INFO - PROCESS | 17772 | |4;prototype.html;282.32242617717475;287.4466651695486;291.31250249411397;295.1426107158703;300.46667165780735;4686.55477729616;4845.951540484594;4885.53587409196;4895.510448955103;4920.434150072742;4703.90592188156;4812.470628230892;4828.203346447832;4852.064500976911;4860.513948605138;3813.4470501777228;3820.7134464915102;3821.331267028273;3824.9617503824884;3830.5211848518934;3605.4772058051567;3655.707543396522;3816.1413681921485;3821.254855303217;3831.2912111259507;3776.6978641708597;3779.338615742234;3791.2986097571898;3793.60167182446;3812.5043744313202;3764.1154328732864;3765.9058523536855;3781.978865706244;3783.791891445969;3802.391617341212;3335.34960682667;3339.1985923378456;3355.2115252915546;3357.0432426758503;3365.158710322419;4652.325412815123;4706.835260765857;4711.128441238382;4718.664261190698;4756.31033500144;4321.395004699345;4323.546027667113;4331.306990881444;4332.826686932519;4358.844906099886;4862.951370486286;5050;5057.216131499624;5076.390833100015;5107.9744601277125;3536.8231588420476;3559.3059353426092;3559.4660800879815;3560.7507474476797;3565.714742820568;5289.44460831611;5294.947050529522;5310.734463276821;5313.920291195635;5339.771852473953;3539.5752509699;3574.8391322390553;3583.605803361628;3593.658602432765;3595.26297109092;3505;3628.1473853644375;3647.5774447965314;3648.7810731356203;3650.306441776107;4195.454590903224;4197.601227883346;4197.63576837529;4200.915981680349;4228.429162063082;5022.42242142151;5036.657954051384;5038.672486288379;5040.899182016339;5061.31672224245;1182.6156499137815;1215.5198696514826;1245.0910835090435;1246.902725601465;1255.1276862580419;760.9657565409569;779.5595488548952;783.8432313537315;787.4605894961969;789.7393860026177;3968.047668559525;4032.6572241359813;4060.451839001756;4061.3907913813164;4092.570280120604;4674.11191873543;4674.228752255908;4677.812887484531;4680.882977925511;4686.078707729815;4067.898302542401;4077.7553346799286;4095.3447448408706;4101.159262351211;4117.938230926538;2398.952020959571;2452.3991622052713;2485.291691867809;2493.9501209975697;2526.873656317177;4376.715513491613;4442.378067070613;4486.214912390384;4489.910201795946;4508.932366014513;4628.514006029386;4682.929756053662;4692.935108552226;4759.90648042683;4761.95238047622;4072;4382.342648602735;4382.430284063052;4399.49405818335;4403.207422663887;4540.409746732904;4607.585317321457;4673.556012178838;4686.484486706391;4711.599514041208;4534.276974749574;4588.609968152745;4610.68595450295;4615.746133962664;4618.4919658836825;4414.492333381702;4493.2251760555055;4519.41247637805;4556;5011.123053465556;3641.872534461387;3641.890743277706;3650.2516984018744;3651.689606383487;3659.3596120678244;5008.799648014038;5262.342207224097;5291.470852914677;5300.946990530046;5308;4990.3762029746285;5108.514691104339;5163;5170.146925757358;5173.560247379015;5098.694078355311;5121.385433747974;5138.640295179451;5138.922916156186;5162.399656106619;4757.643176761688;5011.824586139468;5028.974855125701;5046.419661738947;5096.464871188472;5158.432572417106;5171.431142574239;5174.586033117266;5181.455947125498;5194.961007798531;5011.624128190473;5031.295618613471;5041.697498150123;5068.163752980717;5077.7461126944245 16:57:40 INFO - PROCESS | 17772 | |5;yui.html;531.6198917773792;569.5016860247283;589.4488653109346;589.7699897040155;598.0520874414053;11219.943900280497;11893.76212475752;11901.642950711472;12022.759544809098;12022.797720227984;12218.633440996762;12224.205426647284;12319.507219711224;12329.383530823468;12347.197432166902;618.6133666458463;765.0627980723625;767.892495050692;781.9178986206451;783.1502819440914;770.6686124966262;777.8910952466659;779.166292067488;779.9727009554666;779.9977029517072;825.6656054298019;830.5556527257918;831.40969911363;831.6049876308736;832.076395201326;638.7987783848096;792.1009654042646;810.7365106340404;822.1737154160061;822.6873787960567;597.7519329478262;598.1177762799879;598.1954271504819;598.2760859360179;598.34780089702;12062.396880155957;12082.516699332016;12088.153829231956;12106.273623582525;12113.576024839176;12205.20666156706;12604.243745375306;12618.495260189582;12920;12941.288229147392;10990.230683852133;11071.944640276828;11155.665330040112;11195.272307300082;11227.831582526269;3954.8418063277436;3989.68082553395;4041.9191616167805;4068.247374235746;4097.692673049533;54999.17501237485;55013;55076.17385739217;55108.724456377866;55165;8936.32977526688;9107.362484626012;9476.668316608886;9506.429614223169;9517.952410237904;19101.713474297896;19103.235870565022;19130.617387652168;19131.80868191328;19159.32942347039;6413.839654008687;6677.866442671217;6678.065070890079;6834.214065382445;6980.581165130108;3491.5984661764223;3685.870994515179;3758.3047136279874;3775.9244815103543;3796.2597293527497;2523.570992931206;2647.4308023774597;2656.150031989783;2658.3619931216367;2658.70754217036;456.69173308016957;463.5480406603535;465.49726295601346;466.47754514943483;466.52414537172575;494.8094983431405;497.8406909788833;504.79555779909197;505.3329604921542;509.8648858052619;6833.453323734089;6859.828504287433;7048.541844780073;7152.28477152291;7254.274572542809;461.4577871001627;499.787590274132;514.8198130654316;518.5074179529462;522.3601088666353;3214.614246290413;3273.623533293654;3275.6888095630875;3315.900522984314;3330.550375699298;71262;75131.62434187904;75177;88439;92764;52193;54724;64487.355126449074;72633.63683181656;78030;67819.32180678229;69903.65048174828;69931.65034174899;71671.2832871675;71699;7518.210587888193;7581.431392645463;7775.533467991939;7919.643616037408;7995.400344974267;42273.577264228195;42391.36412953746;42812;43150;43322.13355732931;52056;57327.426725732206;58408.70795645995;58580.70709646425;58734.70632646809;10859.07697845692;11010.614628487965;11066.667999960015;11139.275947063416;11781.116416268986;11579.53906689174;11736.401259380786;11760.059195264188;11827.02981287672;12105.818412723993;11143.442827858737;11320.6037788677;11435.828462572901;11833.585824496446;11858.991985680968;10654.467276635982;11100.888991109985;11153.776924461303;11754.177207595387;11787.469563869476;10037.447940363058;10638.946805265925;10656.680299591024;10659.520321585702;10813.459327033774;8684.794396521735;8834.418104735116;9019.684311049083;9299.814003720023;9300.72097837066;9264.768380790534;9286.257099432165;9305.86041209396;9331.58007889633;9340 16:57:40 INFO - PROCESS | 17772 | __end_tp_report 16:57:40 INFO - PROCESS | 17772 | __start_cc_report 16:57:40 INFO - PROCESS | 17772 | _x_x_mozilla_cycle_collect,995 16:57:40 INFO - PROCESS | 17772 | __end_cc_report 16:57:40 INFO - PROCESS | 17772 | __startTimestamp1465516660751__endTimestamp 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | ------- Summary: start ------- 16:57:40 INFO - PROCESS | 17772 | Number of tests: 6 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#0] dojo.html Cycles:165 Average:4606.08 Median:4749.95 stddev:480.33 (10.1%) stddev-sans-first:454.78 16:57:40 INFO - PROCESS | 17772 | Values: 2581.1 2609.6 2629.4 2651.2 2651.3 4462.7 4542.7 4599.8 4657.8 4702.2 4565.7 4568.7 4595.0 4625.4 4626.5 4246.4 4259.2 4273.6 4279.8 4418.8 4291.7 4349.2 4368.9 4373.2 4414.3 4139.0 4321.0 4354.1 4364.6 4374.8 4180.2 4218.1 4235.9 4237.4 4239.9 4215.2 4269.3 4271.9 4280.9 4318.4 4497.8 4664.3 4682.2 4702.2 4706.3 4893.2 4941.2 4954.8 5009.7 5012.6 4995.7 5025.4 5031.6 5044.1 5049.2 4526.6 4672.6 4691.0 4691.0 4696.1 5064.9 5091.0 5111.5 5111.7 5178.0 4955.7 4958.1 4967.6 4974.2 4974.2 4811.8 4885.1 5007.8 5009.1 5048.1 4887.6 4924.2 4956.9 4965.8 4970.5 4893.8 4900.1 4900.7 4914.2 4956.5 4036.3 4141.4 4152.8 4160.8 4192.6 3597.6 3667.5 3677.1 3682.6 3740.1 4396.7 4399.1 4399.6 4437.7 4439.0 4847.7 5048.3 5054.3 5056.0 5082.6 4273.4 4326.8 4373.3 4376.4 4390.1 4472.3 4482.8 4486.8 4490.0 4519.3 4598.8 4768.9 4769.8 4770.8 4809.6 4957.2 4987.9 4993.3 4996.4 5009.3 4708.7 4714.6 4734.1 4743.0 4782.3 4750.0 4842.3 4918.5 4949.9 4982.0 4937.6 4968.7 4976.5 4977.2 5017.0 4835.0 4844.6 4849.5 4859.5 4897.5 4687.3 4776.9 4813.2 4858.0 4888.2 4785.8 4792.3 4815.0 4829.2 4831.1 4869.6 4873.1 4875.0 4908.9 4917.5 4624.1 4766.6 4813.0 4816.2 4838.6 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#1] ext.html Cycles:180 Average:47740.02 Median:190004.83 stddev:86890.32 (45.7%) stddev-sans-first:87061.86 16:57:40 INFO - PROCESS | 17772 | Values: 558.6 582.0 585.1 586.7 598.4 27108.6 39646.8 41044.0 41063.4 44677.3 41575.0 41972.2 42001.6 42045.6 42058.8 7462.7 7870.8 8021.1 8021.6 8023.6 10019.9 10296.5 10313.1 10652.7 10672.6 10327.8 10432.5 10438.3 10440.8 10442.5 7546.2 10070.2 10367.6 10392.2 10436.9 10240.2 10296.8 10301.2 10303.9 10317.5 39114.0 39350.8 39418.2 39429.2 39453.4 2767.9 2878.4 2894.5 3233.0 3289.1 29841.0 30073.7 30575.5 31169.7 31217.4 3574.0 3583.5 3594.7 3612.9 3683.7 245903.0 246014.0 246080.0 247018.0 247961.0 31641.7 32882.3 32906.3 52906.5 53323.5 33882.3 33960.5 34107.3 34124.1 34128.7 13879.2 14114.5 14115.9 14120.3 14123.9 9795.1 11412.5 11557.2 11587.5 11623.7 7967.6 7971.4 7986.5 8030.6 8067.0 3122.2 3132.5 3136.9 3175.4 3189.8 859.7 910.7 932.0 940.2 1027.6 27821.2 28431.4 28442.9 28498.4 28532.3 951.6 953.6 973.8 1050.5 1087.0 14744.4 14879.7 15023.2 15161.8 15280.6 373411.0 375658.0 376464.0 376722.0 376952.0 48280.0 49563.8 49631.5 49646.0 49745.5 1087.5 1143.3 1144.1 1185.9 1231.1 20061.8 28234.7 28803.7 29268.1 29296.7 52059.0 54045.2 54048.0 54143.5 54146.2 345881.0 353005.0 354185.0 355489.0 355620.0 32369.4 38968.4 40520.4 41411.6 42385.8 42126.8 42587.6 42797.8 42939.8 43602.0 35597.6 36690.4 37011.4 37383.4 37835.2 36520.5 36526.5 36781.0 36967.3 37070.3 35684.0 36019.3 36336.0 36745.8 36808.1 31066.2 31571.2 31789.5 32074.2 32122.4 24905.6 24958.4 25427.7 25682.1 25747.7 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#2] jquery.html Cycles:180 Average:23454.62 Median:399.13 stddev:62004.30 (15534.8%) stddev-sans-first:62153.98 16:57:40 INFO - PROCESS | 17772 | Values: 355.5 356.9 362.1 372.8 379.8 15776.1 16607.5 17776.8 17789.1 17793.7 16759.2 16864.1 16935.6 17332.6 17342.3 4888.8 5139.0 5151.9 5156.3 5162.1 3147.1 3276.4 5107.7 5553.5 5889.9 5881.3 5889.1 5927.5 5937.0 5945.1 5756.8 5884.1 5920.1 5922.1 5947.4 2834.1 4811.6 5112.8 5129.2 5135.5 20325.6 20373.4 20416.5 20816.7 20822.9 1842.8 1867.2 1903.5 2156.2 2219.2 13024.3 13096.8 13177.0 13223.3 13672.2 1575.4 1694.9 1819.1 1849.3 1939.3 67727.7 67952.7 68646.3 69457.7 69774.3 9803.6 9942.3 9942.6 10094.0 10470.5 13901.4 13980.1 13986.7 13987.7 14001.3 7495.6 7565.7 7586.5 7593.7 7714.8 7123.2 7130.6 7247.2 7259.7 7320.7 4217.7 4324.3 4345.6 4398.9 4523.1 1683.6 1732.5 1739.4 1786.7 1813.2 370.1 382.9 393.6 398.2 824.3 10793.3 10817.4 10841.9 10860.7 11035.0 391.3 395.8 397.6 400.1 403.3 4975.4 5719.7 5787.8 5857.5 5884.4 363868.0 365556.0 371545.0 372406.0 395093.0 80448.0 80502.6 81261.0 81607.0 82206.0 408.5 415.0 418.0 418.2 418.3 9861.4 9998.1 10238.1 10356.9 10375.2 34462.3 34572.7 35235.0 35250.0 35381.3 48603.8 49714.0 49859.5 50595.7 51049.7 6280.7 6997.0 7013.8 7795.6 7971.5 10550.6 11199.2 11634.4 11962.7 12063.9 9794.0 9935.5 10111.3 10128.5 10484.0 9549.6 9857.1 9900.5 10114.2 10215.3 10146.5 10281.8 10310.4 10534.5 10546.3 7052.9 7090.2 7125.9 7191.3 7257.6 7723.1 7734.6 7735.5 8877.9 10210.6 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#3] mootools.html Cycles:180 Average:4955.12 Median:4983.64 stddev:2827.78 (56.7%) stddev-sans-first:2821.98 16:57:40 INFO - PROCESS | 17772 | Values: 1247.2 1353.9 1396.1 1443.8 1654.6 6513.2 7094.1 7295.2 7297.9 7488.1 7247.8 7357.9 7365.2 7378.2 7391.7 1820.1 1882.3 1885.1 2093.3 2129.7 1829.2 2082.6 2160.5 2163.0 2174.5 2098.1 2121.6 2122.8 2135.6 2138.3 1771.7 2049.8 2062.7 2064.6 2067.1 2033.6 2093.3 2094.8 2102.1 2107.3 7654.0 7678.5 7725.8 7732.3 7766.4 4325.1 4448.8 4454.7 4456.1 4458.5 2627.4 2720.4 2745.1 2745.8 2748.1 838.7 863.9 878.0 878.6 879.4 10481.1 10527.8 10553.2 10560.1 10571.3 3996.7 4072.5 4097.1 4145.8 4183.5 8936.6 8985.3 8989.9 8994.4 9028.6 4505.0 4514.7 4521.1 4529.6 4533.6 3421.5 3516.2 4005.2 4104.5 4114.7 3507.2 3537.5 3599.2 3603.7 3618.2 1117.8 1128.7 1128.7 1138.4 1146.8 669.3 775.7 793.2 794.3 801.9 4829.5 4853.8 4940.1 4978.4 4996.4 854.2 854.9 856.8 857.1 868.4 3307.6 3434.9 3467.8 3485.9 3486.6 9140.8 9334.6 9481.0 9509.0 9543.8 9227.1 9373.0 9402.7 9403.8 9433.5 7091.5 7165.8 7256.9 7332.7 7338.6 4920.9 4938.5 4988.9 5044.2 5066.8 8653.0 8715.4 8793.4 8904.1 8914.2 8764.8 8892.9 8898.4 8937.7 8961.1 5555.7 5995.3 6519.7 6540.4 6585.7 7057.6 7245.7 7297.3 7299.5 7301.4 6295.8 6557.5 6561.9 6586.6 6665.6 6416.4 6420.4 6504.7 6551.7 6594.9 5909.4 5942.7 5955.9 5965.5 5965.9 4202.4 4259.4 4366.3 4437.0 4504.9 4226.2 4286.6 4319.8 4410.0 4430.8 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#4] prototype.html Cycles:180 Average:4077.43 Median:4501.08 stddev:1195.17 (26.6%) stddev-sans-first:1164.09 16:57:40 INFO - PROCESS | 17772 | Values: 282.3 287.4 291.3 295.1 300.5 4686.6 4846.0 4885.5 4895.5 4920.4 4703.9 4812.5 4828.2 4852.1 4860.5 3813.4 3820.7 3821.3 3825.0 3830.5 3605.5 3655.7 3816.1 3821.3 3831.3 3776.7 3779.3 3791.3 3793.6 3812.5 3764.1 3765.9 3782.0 3783.8 3802.4 3335.3 3339.2 3355.2 3357.0 3365.2 4652.3 4706.8 4711.1 4718.7 4756.3 4321.4 4323.5 4331.3 4332.8 4358.8 4863.0 5050.0 5057.2 5076.4 5108.0 3536.8 3559.3 3559.5 3560.8 3565.7 5289.4 5294.9 5310.7 5313.9 5339.8 3539.6 3574.8 3583.6 3593.7 3595.3 3505.0 3628.1 3647.6 3648.8 3650.3 4195.5 4197.6 4197.6 4200.9 4228.4 5022.4 5036.7 5038.7 5040.9 5061.3 1182.6 1215.5 1245.1 1246.9 1255.1 761.0 779.6 783.8 787.5 789.7 3968.0 4032.7 4060.5 4061.4 4092.6 4674.1 4674.2 4677.8 4680.9 4686.1 4067.9 4077.8 4095.3 4101.2 4117.9 2399.0 2452.4 2485.3 2494.0 2526.9 4376.7 4442.4 4486.2 4489.9 4508.9 4628.5 4682.9 4692.9 4759.9 4762.0 4072.0 4382.3 4382.4 4399.5 4403.2 4540.4 4607.6 4673.6 4686.5 4711.6 4534.3 4588.6 4610.7 4615.7 4618.5 4414.5 4493.2 4519.4 4556.0 5011.1 3641.9 3641.9 3650.3 3651.7 3659.4 5008.8 5262.3 5291.5 5300.9 5308.0 4990.4 5108.5 5163.0 5170.1 5173.6 5098.7 5121.4 5138.6 5138.9 5162.4 4757.6 5011.8 5029.0 5046.4 5096.5 5158.4 5171.4 5174.6 5181.5 5195.0 5011.6 5031.3 5041.7 5068.2 5077.7 16:57:40 INFO - PROCESS | 17772 | 16:57:40 INFO - PROCESS | 17772 | [#5] yui.html Cycles:180 Average:15946.22 Median:507.60 stddev:21721.55 (4279.3%) stddev-sans-first:21751.64 16:57:40 INFO - PROCESS | 17772 | Values: 531.6 569.5 589.4 589.8 598.1 11219.9 11893.8 11901.6 12022.8 12022.8 12218.6 12224.2 12319.5 12329.4 12347.2 618.6 765.1 767.9 781.9 783.2 770.7 777.9 779.2 780.0 780.0 825.7 830.6 831.4 831.6 832.1 638.8 792.1 810.7 822.2 822.7 597.8 598.1 598.2 598.3 598.3 12062.4 12082.5 12088.2 12106.3 12113.6 12205.2 12604.2 12618.5 12920.0 12941.3 10990.2 11071.9 11155.7 11195.3 11227.8 3954.8 3989.7 4041.9 4068.2 4097.7 54999.2 55013.0 55076.2 55108.7 55165.0 8936.3 9107.4 9476.7 9506.4 9518.0 19101.7 19103.2 19130.6 19131.8 19159.3 6413.8 6677.9 6678.1 6834.2 6980.6 3491.6 3685.9 3758.3 3775.9 3796.3 2523.6 2647.4 2656.2 2658.4 2658.7 456.7 463.5 465.5 466.5 466.5 494.8 497.8 504.8 505.3 509.9 6833.5 6859.8 7048.5 7152.3 7254.3 461.5 499.8 514.8 518.5 522.4 3214.6 3273.6 3275.7 3315.9 3330.6 71262.0 75131.6 75177.0 88439.0 92764.0 52193.0 54724.0 64487.4 72633.6 78030.0 67819.3 69903.7 69931.7 71671.3 71699.0 7518.2 7581.4 7775.5 7919.6 7995.4 42273.6 42391.4 42812.0 43150.0 43322.1 52056.0 57327.4 58408.7 58580.7 58734.7 10859.1 11010.6 11066.7 11139.3 11781.1 11579.5 11736.4 11760.1 11827.0 12105.8 11143.4 11320.6 11435.8 11833.6 11859.0 10654.5 11100.9 11153.8 11754.2 11787.5 10037.4 10638.9 10656.7 10659.5 10813.5 8684.8 8834.4 9019.7 9299.8 9300.7 9264.8 9286.3 9305.9 9331.6 9340.0 16:57:40 INFO - PROCESS | 17772 | -------- Summary: end -------- 16:57:40 INFO - PROCESS | 17772 | 16:57:41 INFO - TEST-INFO | 17772: exit 0 16:57:41 INFO - TEST-OK | dromaeo_css | took 1119620ms 16:57:41 INFO - TEST-START | kraken 16:57:41 INFO - operating with platform_type : linux_ 16:57:41 INFO - Initialising browser for kraken test... 16:57:41 INFO - TEST-INFO | started process 17954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDMycf/profile http://localhost:56278/getInfo.html) 16:57:45 INFO - PROCESS | 17954 | __metrics Screen width/height:1600/1200 16:57:45 INFO - PROCESS | 17954 | colorDepth:24 16:57:45 INFO - PROCESS | 17954 | Browser inner width/height: 1024/697 16:57:45 INFO - PROCESS | 17954 | __metrics 16:57:46 ERROR - PROCESS | 17954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:57:46 INFO - PROCESS | 17954 | console.error: PushService: 16:57:46 INFO - PROCESS | 17954 | stateChangeProcessEnqueue: Error transitioning state 16:57:46 INFO - PROCESS | 17954 | UnknownError 16:57:47 INFO - TEST-INFO | 17954: exit 0 16:57:47 INFO - Browser initialized. 16:57:47 INFO - Running cycle 1/1 for kraken test... 16:57:47 INFO - TEST-INFO | started process 18034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDMycf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:59 INFO - PROCESS | 18034 | RSS: Main: 175280128 16:57:59 INFO - PROCESS | 18034 | 16:58:02 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:03 INFO - PROCESS | 18034 | RSS: Main: 232558592 16:58:03 INFO - PROCESS | 18034 | 16:58:06 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-dft) 16:58:06 INFO - PROCESS | 18034 | RSS: Main: 220676096 16:58:06 INFO - PROCESS | 18034 | 16:58:10 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-fft) 16:58:10 INFO - PROCESS | 18034 | RSS: Main: 287477760 16:58:10 INFO - PROCESS | 18034 | 16:58:12 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-oscillator) 16:58:13 INFO - PROCESS | 18034 | RSS: Main: 198574080 16:58:13 INFO - PROCESS | 18034 | 16:58:15 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:16 INFO - PROCESS | 18034 | RSS: Main: 202244096 16:58:16 INFO - PROCESS | 18034 | 16:58:19 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:20 INFO - PROCESS | 18034 | RSS: Main: 238075904 16:58:20 INFO - PROCESS | 18034 | 16:58:23 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:24 INFO - PROCESS | 18034 | RSS: Main: 233713664 16:58:24 INFO - PROCESS | 18034 | 16:58:27 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56278/tests/kraken/driver.html?testName=json-parse-financial) 16:58:28 INFO - PROCESS | 18034 | RSS: Main: 236859392 16:58:28 INFO - PROCESS | 18034 | 16:58:29 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:30 INFO - PROCESS | 18034 | RSS: Main: 222580736 16:58:30 INFO - PROCESS | 18034 | 16:58:32 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:32 INFO - PROCESS | 18034 | RSS: Main: 226156544 16:58:32 INFO - PROCESS | 18034 | 16:58:35 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:35 INFO - PROCESS | 18034 | RSS: Main: 233635840 16:58:35 INFO - PROCESS | 18034 | 16:58:38 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:39 INFO - PROCESS | 18034 | RSS: Main: 239661056 16:58:39 INFO - PROCESS | 18034 | 16:58:42 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:42 INFO - PROCESS | 18034 | RSS: Main: 238411776 16:58:42 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56278/tests/kraken/driver.html?testName=ai-astar) 16:58:44 INFO - PROCESS | 18034 | RSS: Main: 281927680 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | __start_tp_report 16:58:44 INFO - PROCESS | 18034 | _x_x_mozilla_page_load 16:58:44 INFO - PROCESS | 18034 | _x_x_mozilla_page_load_details 16:58:44 INFO - PROCESS | 18034 | |i|pagename|runs| 16:58:44 INFO - PROCESS | 18034 | |0;ai-astar;115;108;114;116;113;114;114;115;113;114 16:58:44 INFO - PROCESS | 18034 | |1;audio-beat-detection;167;128;133;200;133;139;164;130;185;132 16:58:44 INFO - PROCESS | 18034 | |2;audio-dft;162;161;161;164;161;161;162;162;160;160 16:58:44 INFO - PROCESS | 18034 | |3;audio-fft;76;76;85;110;76;78;76;75;99;76 16:58:44 INFO - PROCESS | 18034 | |4;audio-oscillator;87;86;116;87;87;87;125;87;87;130 16:58:44 INFO - PROCESS | 18034 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;119;118;118 16:58:44 INFO - PROCESS | 18034 | |6;imaging-darkroom;149;146;148;147;148;146;147;146;148;146 16:58:44 INFO - PROCESS | 18034 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 16:58:44 INFO - PROCESS | 18034 | |8;json-parse-financial;65;65;64;64;64;63;62;68;62;62 16:58:44 INFO - PROCESS | 18034 | |9;json-stringify-tinderbox;65;65;64;64;64;65;65;65;65;65 16:58:44 INFO - PROCESS | 18034 | |10;stanford-crypto-aes;90;84;83;83;84;85;84;86;123;87 16:58:44 INFO - PROCESS | 18034 | |11;stanford-crypto-ccm;129;129;132;152;133;139;129;137;136;148 16:58:44 INFO - PROCESS | 18034 | |12;stanford-crypto-pbkdf2;166;173;167;168;166;168;166;172;170;166 16:58:44 INFO - PROCESS | 18034 | |13;stanford-crypto-sha256-iterative;67;66;72;66;66;66;66;66;65;65 16:58:44 INFO - PROCESS | 18034 | __end_tp_report 16:58:44 INFO - PROCESS | 18034 | __start_cc_report 16:58:44 INFO - PROCESS | 18034 | _x_x_mozilla_cycle_collect,1924 16:58:44 INFO - PROCESS | 18034 | __end_cc_report 16:58:44 INFO - PROCESS | 18034 | __startTimestamp1465516724640__endTimestamp 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | ------- Summary: start ------- 16:58:44 INFO - PROCESS | 18034 | Number of tests: 14 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.17 (1.9%) stddev-sans-first:2.24 16:58:44 INFO - PROCESS | 18034 | Values: 115.0 108.0 114.0 116.0 113.0 114.0 114.0 115.0 113.0 114.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:151.50 stddev:26.04 (17.2%) stddev-sans-first:26.98 16:58:44 INFO - PROCESS | 18034 | Values: 167.0 128.0 133.0 200.0 133.0 139.0 164.0 130.0 185.0 132.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 16:58:44 INFO - PROCESS | 18034 | Values: 162.0 161.0 161.0 164.0 161.0 161.0 162.0 162.0 160.0 160.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:12.12 (15.9%) stddev-sans-first:12.61 16:58:44 INFO - PROCESS | 18034 | Values: 76.0 76.0 85.0 110.0 76.0 78.0 76.0 75.0 99.0 76.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:87.00 stddev:18.10 (20.8%) stddev-sans-first:18.76 16:58:44 INFO - PROCESS | 18034 | Values: 87.0 86.0 116.0 87.0 87.0 87.0 125.0 87.0 87.0 130.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:58:44 INFO - PROCESS | 18034 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 119.0 118.0 118.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:0.93 16:58:44 INFO - PROCESS | 18034 | Values: 149.0 146.0 148.0 147.0 148.0 146.0 147.0 146.0 148.0 146.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:58:44 INFO - PROCESS | 18034 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.85 (2.9%) stddev-sans-first:1.92 16:58:44 INFO - PROCESS | 18034 | Values: 65.0 65.0 64.0 64.0 64.0 63.0 62.0 68.0 62.0 62.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 16:58:44 INFO - PROCESS | 18034 | Values: 65.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:84.50 stddev:12.17 (14.4%) stddev-sans-first:12.90 16:58:44 INFO - PROCESS | 18034 | Values: 90.0 84.0 83.0 83.0 84.0 85.0 84.0 86.0 123.0 87.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:136.50 stddev:8.03 (5.9%) stddev-sans-first:8.06 16:58:44 INFO - PROCESS | 18034 | Values: 129.0 129.0 132.0 152.0 133.0 139.0 129.0 137.0 136.0 148.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.00 stddev:2.62 (1.6%) stddev-sans-first:2.65 16:58:44 INFO - PROCESS | 18034 | Values: 166.0 173.0 167.0 168.0 166.0 168.0 166.0 172.0 170.0 166.0 16:58:44 INFO - PROCESS | 18034 | 16:58:44 INFO - PROCESS | 18034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 16:58:44 INFO - PROCESS | 18034 | Values: 67.0 66.0 72.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 16:58:44 INFO - PROCESS | 18034 | -------- Summary: end -------- 16:58:44 INFO - PROCESS | 18034 | 16:58:45 INFO - TEST-INFO | 18034: exit 0 16:58:45 INFO - TEST-OK | kraken | took 64208ms 16:58:45 INFO - SUITE-END | took 1183s 16:58:45 INFO - Completed test suite (00:19:43) 16:58:45 INFO - javascript benchmark 16:58:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.1482210870413, 2609.647697560831, 2629.355807827082, 2651.244395347326, 2651.2841532786147, 4462.665300102497, 4542.659300552464, 4599.8390056348035, 4657.790399432025, 4702.224133018052, 4565.726056436616, 4568.680192386534, 4595.03504264105, 4625.444946606412, 4626.5373462653715, 4246.447961764974, 4259.233337999174, 4273.572642735717, 4279.7860106994685, 4418.779061046951, 4291.742495450283, 4349.195398851207, 4368.89077773055, 4373.190959672471, 4414.29371300592, 4139.048018955657, 4321.027768752006, 4354.129174165179, 4364.629006534448, 4374.759388233646, 4180.163967206571, 4218.050938538835, 4235.8729238122905, 4237.385579091046, 4239.894002649928, 4215.199112168678, 4269.274223382002, 4271.893202669927, 4280.9143817123795, 4318.438602981623, 4497.775111244425, 4664.346991421204, 4682.227432473638, 4702.247640377557, 4706.294055891643, 4893.217085266376, 4941.209406494943, 4954.826581069645, 5009.674371165899, 5012.598992080625, 4995.725235112068, 5025.3718285214345, 5031.597472202252, 5044.092063428581, 5049.166887463564, 4526.569975852289, 4672.57946784791, 4691.014886873795, 4691.038337140878, 4696.084263568571, 5064.873378165576, 5090.974545127251, 5111.514406131411, 5111.667741596784, 5178.0, 4955.702657840541, 4958.107540642647, 4967.602591792648, 4974.154393752999, 4974.228994505857, 4811.78346974387, 4885.096257192431, 5007.824726134568, 5009.148444764399, 5048.116579598555, 4887.584555312767, 4924.162892308316, 4956.8760780980765, 4965.8013679452415, 4970.527799859007, 4893.828715994994, 4900.117978763786, 4900.656954013185, 4914.189158788831, 4956.479569645207, 4036.2936486114813, 4141.358089496133, 4152.8131234094535, 4160.750354978711, 4192.622663960258, 3597.6402359763815, 3667.4865518827387, 3677.0623491010156, 3682.6317368262958, 3740.139767853409, 4396.736195828261, 4399.142167277414, 4399.62603178727, 4437.689361744711, 4439.001224724411, 4847.709137451764, 5048.268001139888, 5054.342935418372, 5056.0, 5082.618803589746, 4273.358996150602, 4326.805293761789, 4373.322135069069, 4376.431063961664, 4390.05613793036, 4472.329150627367, 4482.843100491467, 4486.775661216926, 4490.034642551867, 4519.344695019204, 4598.839040633562, 4768.904621907612, 4769.761511924459, 4770.809167633256, 4809.615230781529, 4957.206846904478, 4987.875303117451, 4993.300937868628, 4996.350474438445, 5009.323741294878, 4708.693934894221, 4714.57568818808, 4734.147853386424, 4742.976285118552, 4782.258749893772, 4749.952500474951, 4842.346283251716, 4918.532739389752, 4949.925751113664, 4982.028504441599, 4937.604991600735, 4968.726720030433, 4976.527229913152, 4977.203647416396, 5017.0, 4835.032993401404, 4844.636652251025, 4849.515048495122, 4859.4654587996, 4897.534734200245, 4687.343771871872, 4776.8566942991765, 4813.15769740287, 4858.028394321079, 4888.2178851383605, 4785.832495862628, 4792.281157826354, 4814.975925120352, 4829.154897892925, 4831.057943700945, 4869.610431165427, 4873.074115917964, 4875.0493653737185, 4908.901821963612, 4917.508249175054, 4624.1445332613575, 4766.642501812308, 4813.03739252144, 4816.181249187716, 4838.612910967044], "value": 4575.732452911953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6396774080717, 582.0076769108668, 585.1398444286897, 586.7447660267782, 598.4135547163779, 27108.593371099425, 39646.801765991164, 41044.0, 41063.384049239285, 44677.32984005234, 41575.0, 41972.16055678885, 42001.57998420015, 42045.57954420455, 42058.7897060515, 7462.738804141856, 7870.842583148334, 8021.077576078738, 8021.639026243833, 8023.558704271263, 10019.949900250489, 10296.48517574122, 10313.07182353588, 10652.680419587425, 10672.62645807397, 10327.84508232377, 10432.530536125892, 10438.269321147523, 10440.791184176313, 10442.477876106203, 7546.24537546241, 10070.194384449227, 10367.585296588128, 10392.168626509936, 10436.947815260914, 10240.231982601335, 10296.79406411875, 10301.227407944434, 10303.896961030368, 10317.48412579368, 39114.0, 39350.80324598387, 39418.21163576741, 39429.211415771526, 39453.40819887704, 2767.8892844286406, 2878.3955369372457, 2894.5079336512845, 3232.997770691093, 3289.1283809790425, 29841.0, 30073.699263007307, 30575.541366879515, 31169.688303116905, 31217.37565248705, 3573.982130089359, 3583.45000148939, 3594.676479116892, 3612.9277414451826, 3683.7053035757344, 245903.0, 246014.0, 246080.0, 247018.0, 247961.0, 31641.683583164333, 32882.3423531528, 32906.341873162404, 52906.47093529093, 53323.466765332625, 33882.322353552794, 33960.49059264113, 34107.31785364279, 34124.14689632729, 34128.658713413046, 13879.167249964832, 14114.505992290426, 14115.85884141166, 14120.293985300694, 14123.929380353238, 9795.069468400634, 11412.543498260142, 11557.190996630155, 11587.536498540132, 11623.709407264885, 7967.601619918981, 7971.362291016821, 7986.520808751377, 8030.558319292495, 8067.0, 3122.2038380213353, 3132.4988001919583, 3136.905892823219, 3175.36492701456, 3189.7607679424136, 859.6604341285157, 910.6812615584493, 932.0, 940.2431043010442, 1027.5684212630713, 27821.210654719504, 28431.431371372455, 28442.857785710938, 28498.430031399257, 28532.28669283243, 951.5622813505727, 953.5756588318131, 973.78576713123, 1050.4695128959827, 1087.0162502934857, 14744.41022359115, 14879.70240595182, 15023.173725445205, 15161.772573411408, 15280.617984550252, 373411.0, 375658.0, 376464.0, 376722.0, 376952.0, 48280.03439931252, 49563.752181239586, 49631.50368496341, 49646.0, 49745.502544974814, 1087.499750114956, 1143.2568830260398, 1144.0904480937675, 1185.875483074282, 1231.1197493791803, 20061.799382005993, 28234.71765282321, 28803.711962880105, 29268.121956341343, 29296.707032929397, 52059.0, 54045.189322159415, 54048.0, 54143.458565415414, 54146.18780718371, 345881.0, 353005.0, 354185.0, 355489.0, 355620.0, 32369.35261294714, 38968.41547376848, 40520.3921941177, 41411.585884140775, 42385.78807105945, 42126.78936605297, 42587.5741242596, 42797.786011069744, 42939.785301073294, 43602.0, 35597.64402356047, 36690.44964325591, 37011.44482832706, 37383.43924841075, 37835.24329513339, 36520.45219321659, 36526.452103219, 36781.0, 36967.26065478729, 37070.25859482849, 35684.0, 36019.27961440704, 36336.0, 36745.816270918476, 36808.07979800527, 31066.223344416572, 31571.181716005885, 31789.523157153122, 32074.19814504656, 32122.35755284928, 24905.62641560342, 24958.37604059913, 25427.74572254254, 25682.101126460486, 25747.742522574536], "value": 17363.108013794146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5218231478661, 356.87509371719887, 362.14533700466893, 372.78192257529344, 379.78352339166685, 15776.132312722795, 16607.50177494674, 17776.822231777678, 17789.11054447279, 17793.733094003568, 16759.162041897886, 16864.072476013815, 16935.576610584743, 17332.566685832862, 17342.306307747676, 4888.780004899788, 5138.974305128488, 5151.948480515184, 5156.278121063054, 5162.096633089194, 3147.0716138739012, 3276.410246155691, 5107.744612769366, 5553.500184983351, 5889.85275368115, 5881.323647780496, 5889.146073819294, 5927.525797936155, 5937.0, 5945.108233764927, 5756.827295181151, 5884.117382392633, 5920.082387229986, 5922.052471604544, 5947.375525569818, 2834.1214223590546, 4811.615070794328, 5112.795488180468, 5129.204973229155, 5135.460776618476, 20325.593488130155, 20373.388798336073, 20416.489587760276, 20816.687749683766, 20822.895885520626, 1842.824931631493, 1867.159778099847, 1903.4860587641397, 2156.212982261479, 2219.2343641443676, 13024.348782560834, 13096.803547946789, 13177.0, 13223.33883305831, 13672.248026358546, 1575.4249698859833, 1694.8644108471292, 1819.1268191268266, 1849.2658793488713, 1939.2824654877645, 67727.66136169338, 67952.660236699, 68646.31353686449, 69457.65271173662, 69774.3022569778, 9803.558839852223, 9942.254330925065, 9942.552585133686, 10094.0, 10470.534125222475, 13901.374438150307, 13980.091294065853, 13986.720265594631, 13987.650308742363, 14001.29993500321, 7495.625218739041, 7565.73519926811, 7586.468947173645, 7593.696252149852, 7714.845703085907, 7123.180834204133, 7130.607816570138, 7247.16657584374, 7259.656963461776, 7320.67056982437, 4217.683673724483, 4324.329728891964, 4345.630621397154, 4398.890027749268, 4523.117991991596, 1683.5622738088184, 1732.5322163016167, 1739.3563082886803, 1786.6694661487666, 1813.193129057583, 370.06373874098574, 382.9425586162098, 393.6004954970707, 398.20756694178954, 824.282873899711, 10793.29843560166, 10817.350958942488, 10841.945790270998, 10860.72848178786, 11035.0, 391.3210579644315, 395.8317714971183, 397.5626810508418, 400.055868151163, 403.2962480471537, 4975.353204083446, 5719.685417302005, 5787.797427090031, 5857.502112320501, 5884.382139875337, 363868.0, 365556.0, 371545.0, 372406.0, 395093.0, 80448.0, 80502.59748701219, 81261.0, 81607.0, 82206.0, 408.46083170215627, 415.0122707955048, 418.0364260379793, 418.18245330379034, 418.34946657946574, 9861.359011664219, 9998.100170984646, 10238.078572928473, 10356.896431035593, 10375.221858360805, 34462.310753785285, 34572.654273456945, 35235.0, 35250.0, 35381.28960119269, 48603.756981214865, 49714.0, 49859.50140498549, 50595.74702126466, 51049.744751276005, 6280.685965701605, 6997.020417141706, 7013.824654383681, 7795.610219489116, 7971.481853679492, 10550.630727924487, 11199.21605487608, 11634.418279086181, 11962.700932476757, 12063.939680301542, 9793.951030244803, 9935.503224838874, 10111.3427627204, 10128.493575321352, 10484.0, 9549.618015279311, 9857.11285984265, 9900.455474948947, 10114.241431892491, 10215.284930054824, 10146.543405546916, 10281.84577231357, 10310.381377117397, 10534.52594633228, 10546.26176167661, 7052.929470705228, 7090.220075791555, 7125.893111603226, 7191.316824901626, 7257.600831954293, 7723.1118421380015, 7734.574598397142, 7735.497192682457, 8877.911220887709, 10210.642627508001], "value": 7416.501093925402, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.151936683055, 1353.857844926283, 1396.1413730555707, 1443.7906503556985, 1654.5532706169336, 6513.185851768529, 7094.11323584552, 7295.234000429945, 7297.927020729791, 7488.138864030638, 7247.818804529889, 7357.926420735791, 7365.189829118806, 7378.151512576055, 7391.704331826721, 1820.1172431370774, 1882.2753240002628, 1885.0668918885171, 2093.2673564252505, 2129.691194776756, 1829.1860122245605, 2082.6251274770534, 2160.503084290614, 2162.9891850540725, 2174.4672555223915, 2098.1187901081507, 2121.575684863026, 2122.7983341582526, 2135.5942370949547, 2138.2836749688795, 1771.6722406354866, 2049.784772598878, 2062.6905964105354, 2064.6386882295537, 2067.080149333547, 2033.5526184239443, 2093.2568938027084, 2094.7800480949586, 2102.127617038927, 2107.262458139654, 7654.043244594426, 7678.5392876427595, 7725.806854828675, 7732.265434783687, 7766.37868970481, 4325.113351762881, 4448.822047118111, 4454.732716037016, 4456.064226512436, 4458.464984201884, 2627.4351014531776, 2720.3607152319387, 2745.094118940745, 2745.8489783061923, 2748.093129267337, 838.6813011055821, 863.9265662418702, 877.9824403511958, 878.6265837019241, 879.4195830751673, 10481.109105726022, 10527.78944421115, 10553.208509361752, 10560.102391296748, 10571.2600117991, 3996.660283875903, 4072.450219220367, 4097.09863829957, 4145.751254924654, 4183.518895327015, 8936.597853096626, 8985.281177505783, 8989.865152022725, 8994.370394072483, 9028.593713282919, 4505.031418245093, 4514.706544074625, 4521.118381915495, 4529.569690879362, 4533.637309015271, 3421.5209870618132, 3516.156122530574, 4005.239004589119, 4104.548499665035, 4114.670826333946, 3507.193345530542, 3537.4870643756512, 3599.208174201671, 3603.7117030637487, 3618.16782140104, 1117.8379135025539, 1128.6896103571419, 1128.6952522818792, 1138.408027825526, 1146.810776221914, 669.3473862983552, 775.7129861951001, 793.1592511937365, 794.265304593249, 801.867691830853, 4829.541193586674, 4853.778429202471, 4940.110780059624, 4978.377702787152, 4996.375453068366, 854.2482615298497, 854.8715695282292, 856.7729551668813, 857.1428571428571, 868.4355169140109, 3307.58655168104, 3434.8797792077157, 3467.809270490097, 3485.8605655773486, 3486.633903440153, 9140.771480712903, 9334.579943902541, 9481.0, 9509.049095090573, 9543.809123817486, 9227.077292270718, 9372.95313523428, 9402.717918462457, 9403.764905877408, 9433.48115853621, 7091.468139889529, 7165.7850264492145, 7256.854862902713, 7332.670029848563, 7338.559686418938, 4920.852374428773, 4938.530839570235, 4988.900221995613, 5044.192929131322, 5066.797328106834, 8653.0, 8715.38992270535, 8793.384463087777, 8904.065073167483, 8914.153155450222, 8764.78088047804, 8892.86660700103, 8898.35380454618, 8937.687180948635, 8961.148690874357, 5555.7499912504845, 5995.340512543529, 6519.674016299071, 6540.37866402691, 6585.703643335965, 7057.6471176442, 7245.746398876014, 7297.343239108293, 7299.452541059548, 7301.4158867289425, 6295.842603934938, 6557.540972132096, 6561.934380656323, 6586.571872828251, 6665.633390163393, 6416.390442907917, 6420.357964203729, 6504.707288171949, 6551.705173267119, 6594.90107648376, 5909.3795151508475, 5942.702864856827, 5955.940440595712, 5965.463108320272, 5965.880682386415, 4202.41166236721, 4259.361095835649, 4366.2577361847925, 4436.955630443784, 4504.926796186252, 4226.1758957003085, 4286.635635970977, 4319.784010799384, 4409.977950110358, 4430.778461076998], "value": 3967.961697166437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.32242617717475, 287.4466651695486, 291.31250249411397, 295.1426107158703, 300.46667165780735, 4686.55477729616, 4845.951540484594, 4885.53587409196, 4895.510448955103, 4920.434150072742, 4703.90592188156, 4812.470628230892, 4828.203346447832, 4852.064500976911, 4860.513948605138, 3813.4470501777228, 3820.7134464915102, 3821.331267028273, 3824.9617503824884, 3830.5211848518934, 3605.4772058051567, 3655.707543396522, 3816.1413681921485, 3821.254855303217, 3831.2912111259507, 3776.6978641708597, 3779.338615742234, 3791.2986097571898, 3793.60167182446, 3812.5043744313202, 3764.1154328732864, 3765.9058523536855, 3781.978865706244, 3783.791891445969, 3802.391617341212, 3335.34960682667, 3339.1985923378456, 3355.2115252915546, 3357.0432426758503, 3365.158710322419, 4652.325412815123, 4706.835260765857, 4711.128441238382, 4718.664261190698, 4756.31033500144, 4321.395004699345, 4323.546027667113, 4331.306990881444, 4332.826686932519, 4358.844906099886, 4862.951370486286, 5050.0, 5057.216131499624, 5076.390833100015, 5107.9744601277125, 3536.8231588420476, 3559.3059353426092, 3559.4660800879815, 3560.7507474476797, 3565.714742820568, 5289.44460831611, 5294.947050529522, 5310.734463276821, 5313.920291195635, 5339.771852473953, 3539.5752509699, 3574.8391322390553, 3583.605803361628, 3593.658602432765, 3595.26297109092, 3505.0, 3628.1473853644375, 3647.5774447965314, 3648.7810731356203, 3650.306441776107, 4195.454590903224, 4197.601227883346, 4197.63576837529, 4200.915981680349, 4228.429162063082, 5022.42242142151, 5036.657954051384, 5038.672486288379, 5040.899182016339, 5061.31672224245, 1182.6156499137815, 1215.5198696514826, 1245.0910835090435, 1246.902725601465, 1255.1276862580419, 760.9657565409569, 779.5595488548952, 783.8432313537315, 787.4605894961969, 789.7393860026177, 3968.047668559525, 4032.6572241359813, 4060.451839001756, 4061.3907913813164, 4092.570280120604, 4674.11191873543, 4674.228752255908, 4677.812887484531, 4680.882977925511, 4686.078707729815, 4067.898302542401, 4077.7553346799286, 4095.3447448408706, 4101.159262351211, 4117.938230926538, 2398.952020959571, 2452.3991622052713, 2485.291691867809, 2493.9501209975697, 2526.873656317177, 4376.715513491613, 4442.378067070613, 4486.214912390384, 4489.910201795946, 4508.932366014513, 4628.514006029386, 4682.929756053662, 4692.935108552226, 4759.90648042683, 4761.95238047622, 4072.0, 4382.342648602735, 4382.430284063052, 4399.49405818335, 4403.207422663887, 4540.409746732904, 4607.585317321457, 4673.556012178838, 4686.484486706391, 4711.599514041208, 4534.276974749574, 4588.609968152745, 4610.68595450295, 4615.746133962664, 4618.4919658836825, 4414.492333381702, 4493.2251760555055, 4519.41247637805, 4556.0, 5011.123053465556, 3641.872534461387, 3641.890743277706, 3650.2516984018744, 3651.689606383487, 3659.3596120678244, 5008.799648014038, 5262.342207224097, 5291.470852914677, 5300.946990530046, 5308.0, 4990.3762029746285, 5108.514691104339, 5163.0, 5170.146925757358, 5173.560247379015, 5098.694078355311, 5121.385433747974, 5138.640295179451, 5138.922916156186, 5162.399656106619, 4757.643176761688, 5011.824586139468, 5028.974855125701, 5046.419661738947, 5096.464871188472, 5158.432572417106, 5171.431142574239, 5174.586033117266, 5181.455947125498, 5194.961007798531, 5011.624128190473, 5031.295618613471, 5041.697498150123, 5068.163752980717, 5077.7461126944245], "value": 3692.920119892846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.6198917773792, 569.5016860247283, 589.4488653109346, 589.7699897040155, 598.0520874414053, 11219.943900280497, 11893.76212475752, 11901.642950711472, 12022.759544809098, 12022.797720227984, 12218.633440996762, 12224.205426647284, 12319.507219711224, 12329.383530823468, 12347.197432166902, 618.6133666458463, 765.0627980723625, 767.892495050692, 781.9178986206451, 783.1502819440914, 770.6686124966262, 777.8910952466659, 779.166292067488, 779.9727009554666, 779.9977029517072, 825.6656054298019, 830.5556527257918, 831.40969911363, 831.6049876308736, 832.076395201326, 638.7987783848096, 792.1009654042646, 810.7365106340404, 822.1737154160061, 822.6873787960567, 597.7519329478262, 598.1177762799879, 598.1954271504819, 598.2760859360179, 598.34780089702, 12062.396880155957, 12082.516699332016, 12088.153829231956, 12106.273623582525, 12113.576024839176, 12205.20666156706, 12604.243745375306, 12618.495260189582, 12920.0, 12941.288229147392, 10990.230683852133, 11071.944640276828, 11155.665330040112, 11195.272307300082, 11227.831582526269, 3954.8418063277436, 3989.68082553395, 4041.9191616167805, 4068.247374235746, 4097.692673049533, 54999.17501237485, 55013.0, 55076.17385739217, 55108.724456377866, 55165.0, 8936.32977526688, 9107.362484626012, 9476.668316608886, 9506.429614223169, 9517.952410237904, 19101.713474297896, 19103.235870565022, 19130.617387652168, 19131.80868191328, 19159.32942347039, 6413.839654008687, 6677.866442671217, 6678.065070890079, 6834.214065382445, 6980.581165130108, 3491.5984661764223, 3685.870994515179, 3758.3047136279874, 3775.9244815103543, 3796.2597293527497, 2523.570992931206, 2647.4308023774597, 2656.150031989783, 2658.3619931216367, 2658.70754217036, 456.69173308016957, 463.5480406603535, 465.49726295601346, 466.47754514943483, 466.52414537172575, 494.8094983431405, 497.8406909788833, 504.79555779909197, 505.3329604921542, 509.8648858052619, 6833.453323734089, 6859.828504287433, 7048.541844780073, 7152.28477152291, 7254.274572542809, 461.4577871001627, 499.787590274132, 514.8198130654316, 518.5074179529462, 522.3601088666353, 3214.614246290413, 3273.623533293654, 3275.6888095630875, 3315.900522984314, 3330.550375699298, 71262.0, 75131.62434187904, 75177.0, 88439.0, 92764.0, 52193.0, 54724.0, 64487.355126449074, 72633.63683181656, 78030.0, 67819.32180678229, 69903.65048174828, 69931.65034174899, 71671.2832871675, 71699.0, 7518.210587888193, 7581.431392645463, 7775.533467991939, 7919.643616037408, 7995.400344974267, 42273.577264228195, 42391.36412953746, 42812.0, 43150.0, 43322.13355732931, 52056.0, 57327.426725732206, 58408.70795645995, 58580.70709646425, 58734.70632646809, 10859.07697845692, 11010.614628487965, 11066.667999960015, 11139.275947063416, 11781.116416268986, 11579.53906689174, 11736.401259380786, 11760.059195264188, 11827.02981287672, 12105.818412723993, 11143.442827858737, 11320.6037788677, 11435.828462572901, 11833.585824496446, 11858.991985680968, 10654.467276635982, 11100.888991109985, 11153.776924461303, 11754.177207595387, 11787.469563869476, 10037.447940363058, 10638.946805265925, 10656.680299591024, 10659.520321585702, 10813.459327033774, 8684.794396521735, 8834.418104735116, 9019.684311049083, 9299.814003720023, 9300.72097837066, 9264.768380790534, 9286.257099432165, 9305.86041209396, 9331.58007889633, 9340.0], "value": 6139.246738825739, "unit": "score"}], "name": "dromaeo_css", "value": 6129.124697290054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 116.0, 113.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 128.0, 133.0, 200.0, 133.0, 139.0, 164.0, 130.0, 185.0, 132.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 164.0, 161.0, 161.0, 162.0, 162.0, 160.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 85.0, 110.0, 76.0, 78.0, 76.0, 75.0, 99.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 116.0, 87.0, 87.0, 87.0, 125.0, 87.0, 87.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 148.0, 147.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 63.0, 62.0, 68.0, 62.0, 62.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 83.0, 83.0, 84.0, 85.0, 84.0, 86.0, 123.0, 87.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 132.0, 152.0, 133.0, 139.0, 129.0, 137.0, 136.0, 148.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 173.0, 167.0, 168.0, 166.0, 168.0, 166.0, 172.0, 170.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 72.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1554.7000000000003, "alertThreshold": 2.0}]} 16:58:45 INFO - Return code: 0 16:58:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:45 ERROR - # TBPL SUCCESS # 16:58:45 INFO - Running post-action listener: _resource_record_post_action 16:58:45 INFO - ##### 16:58:45 INFO - ##### Finished run-tests step (success) 16:58:45 INFO - ##### 16:58:45 INFO - Running post-run listener: _resource_record_post_run 16:58:46 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530677760; Read time: 24; Write time: 732596 16:58:46 INFO - TinderboxPrint: CPU usage
13.2% 16:58:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 16:58:46 INFO - TinderboxPrint: I/O write bytes / time
530,677,760 / 732,596 16:58:46 INFO - TinderboxPrint: CPU idle
8,314.4 (86.7%) 16:58:46 INFO - TinderboxPrint: CPU user
1,220.8 (12.7%) 16:58:46 INFO - TinderboxPrint: Swap in / out
0 / 0 16:58:46 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244449280; Read time: 0; Write time: 486288 16:58:46 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286224384; Read time: 24; Write time: 246308 16:58:46 INFO - Running post-run listener: _upload_blobber_files 16:58:46 INFO - Blob upload gear active. 16:58:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:52 INFO - (blobuploader) - INFO - Done attempting. 16:58:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:58:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:58:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:52 INFO - (blobuploader) - INFO - Done attempting. 16:58:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:58:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:58:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:53 INFO - (blobuploader) - INFO - Done attempting. 16:58:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:53 INFO - Return code: 0 16:58:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e50efd15c9fc2266e16389c540f1852ac27b97d16ed469ef4eba4dc10687a8c8368c7aae42c6e241872879f20942418aabf181444607a6fe41ef9a5d0e39cdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79fa64741087f9d74b12a14770a7be2401a9b84d3517fcf58f8dbaf473740adfb726edf05c4e50b760ed5984b44474c226da4727517ee6ff338fed46b2413b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfada67f8005a78058edcdc65af4ce3ca7d90b952f2f12a3651fe972d5fef98c76c5d5c087461b36a7dd983753266ea2fc0aff911b524281d9431c1086716d2c"} 16:58:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:53 INFO - Contents: 16:58:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e50efd15c9fc2266e16389c540f1852ac27b97d16ed469ef4eba4dc10687a8c8368c7aae42c6e241872879f20942418aabf181444607a6fe41ef9a5d0e39cdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79fa64741087f9d74b12a14770a7be2401a9b84d3517fcf58f8dbaf473740adfb726edf05c4e50b760ed5984b44474c226da4727517ee6ff338fed46b2413b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfada67f8005a78058edcdc65af4ce3ca7d90b952f2f12a3651fe972d5fef98c76c5d5c087461b36a7dd983753266ea2fc0aff911b524281d9431c1086716d2c"} 16:58:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:53 INFO - Copying logs to upload dir... 16:58:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.683123 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 16:58:53.645611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:58:53.652738) ========= 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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 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/e50efd15c9fc2266e16389c540f1852ac27b97d16ed469ef4eba4dc10687a8c8368c7aae42c6e241872879f20942418aabf181444607a6fe41ef9a5d0e39cdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79fa64741087f9d74b12a14770a7be2401a9b84d3517fcf58f8dbaf473740adfb726edf05c4e50b760ed5984b44474c226da4727517ee6ff338fed46b2413b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfada67f8005a78058edcdc65af4ce3ca7d90b952f2f12a3651fe972d5fef98c76c5d5c087461b36a7dd983753266ea2fc0aff911b524281d9431c1086716d2c"} build_url:https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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/e50efd15c9fc2266e16389c540f1852ac27b97d16ed469ef4eba4dc10687a8c8368c7aae42c6e241872879f20942418aabf181444607a6fe41ef9a5d0e39cdb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79fa64741087f9d74b12a14770a7be2401a9b84d3517fcf58f8dbaf473740adfb726edf05c4e50b760ed5984b44474c226da4727517ee6ff338fed46b2413b1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cfada67f8005a78058edcdc65af4ce3ca7d90b952f2f12a3651fe972d5fef98c76c5d5c087461b36a7dd983753266ea2fc0aff911b524281d9431c1086716d2c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:58:53.681640) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:58:53.681978) ========= 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=db0483c52d987ecb441a263b000001ad-1465515487.208792-265154084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:58:53.764385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:58:53.764694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:58:53.764971) ========= ========= Total master_lag: 0.20 =========