builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1465952810.94 results: success (0) buildid: 20160614172925 builduid: cf2c01f39d4b4b089fbd47722727ed68 revision: 071e9554e3e76a7692fd1a24b845bc42064352b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:50.938024) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:50.938587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:50.938877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:50.954030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:50.954331) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 18:06:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-06-14 18:06:51 (50.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:51.090057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:51.090371) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014822 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:51.140945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 18:06:51.141373) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 071e9554e3e76a7692fd1a24b845bc42064352b0 --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 071e9554e3e76a7692fd1a24b845bc42064352b0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 18:06:51,284 truncating revision to first 12 chars 2016-06-14 18:06:51,284 Setting DEBUG logging. 2016-06-14 18:06:51,284 attempt 1/10 2016-06-14 18:06:51,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/071e9554e3e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 18:06:52,159 unpacking tar archive at: fx-team-071e9554e3e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.221071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 18:06:52.376075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:52.376400) ========= script_repo_revision: 071e9554e3e76a7692fd1a24b845bc42064352b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:52.376795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:52.377061) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 18:06:52.385833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-14 18:06:52.386189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:52 INFO - MultiFileLogger online at 20160614 18:06:52 in /builds/slave/test 18:06:52 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 18:06:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:52 INFO - {'append_to_log': False, 18:06:52 INFO - 'base_work_dir': '/builds/slave/test', 18:06:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:06:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:52 INFO - 'branch': 'Fx-Team-Non-PGO', 18:06:52 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:52 INFO - 'config_files': ('talos/linux_config.py',), 18:06:52 INFO - 'default_actions': ('clobber', 18:06:52 INFO - 'read-buildbot-config', 18:06:52 INFO - 'download-and-extract', 18:06:52 INFO - 'populate-webroot', 18:06:52 INFO - 'create-virtualenv', 18:06:52 INFO - 'install', 18:06:52 INFO - 'run-tests'), 18:06:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:52 INFO - 'download_minidump_stackwalk': True, 18:06:52 INFO - 'download_symbols': 'ondemand', 18:06:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:06:52 INFO - 'tooltool.py': '/tools/tooltool.py', 18:06:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:06:52 INFO - '/tools/misc-python/virtualenv.py')}, 18:06:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:52 INFO - 'installer_path': 'installer.exe', 18:06:52 INFO - 'log_level': 'info', 18:06:52 INFO - 'log_name': 'talos', 18:06:52 INFO - 'log_to_console': True, 18:06:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:52 INFO - 'opt_config_files': (), 18:06:52 INFO - 'pip_index': False, 18:06:52 INFO - 'sps_profile': False, 18:06:52 INFO - 'sps_profile_interval': 0, 18:06:52 INFO - 'suite': 'dromaeojs', 18:06:52 INFO - 'system_bits': '32', 18:06:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:52 INFO - 'title': 'talos-linux64-ix-017', 18:06:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:52 INFO - 'use_talos_json': True, 18:06:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:52 INFO - 'work_dir': 'build'} 18:06:52 INFO - ##### 18:06:52 INFO - ##### Running clobber step. 18:06:52 INFO - ##### 18:06:52 INFO - Running pre-action listener: _resource_record_pre_action 18:06:52 INFO - Running main action method: clobber 18:06:52 INFO - rmtree: /builds/slave/test/build 18:06:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:53 INFO - Running post-action listener: _resource_record_post_action 18:06:53 INFO - ##### 18:06:53 INFO - ##### Finished clobber step (success) 18:06:53 INFO - ##### 18:06:53 INFO - ##### 18:06:53 INFO - ##### Running read-buildbot-config step. 18:06:53 INFO - ##### 18:06:53 INFO - Running pre-action listener: _resource_record_pre_action 18:06:53 INFO - Running main action method: read_buildbot_config 18:06:53 INFO - Using buildbot properties: 18:06:53 INFO - { 18:06:53 INFO - "project": "", 18:06:53 INFO - "product": "firefox", 18:06:53 INFO - "script_repo_revision": "production", 18:06:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:06:53 INFO - "repository": "", 18:06:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:06:53 INFO - "buildid": "20160614172925", 18:06:53 INFO - "pgo_build": "False", 18:06:53 INFO - "basedir": "/builds/slave/test", 18:06:53 INFO - "buildnumber": 1859, 18:06:53 INFO - "slavename": "talos-linux64-ix-017", 18:06:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:06:53 INFO - "platform": "ubuntu64_hw", 18:06:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:06:53 INFO - "branch": "fx-team", 18:06:53 INFO - "repo_path": "integration/fx-team", 18:06:53 INFO - "revision": "071e9554e3e76a7692fd1a24b845bc42064352b0", 18:06:53 INFO - "stage_platform": "linux64", 18:06:53 INFO - "builduid": "cf2c01f39d4b4b089fbd47722727ed68", 18:06:53 INFO - "slavebuilddir": "test" 18:06:53 INFO - } 18:06:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:06:53 INFO - Running post-action listener: _resource_record_post_action 18:06:53 INFO - ##### 18:06:53 INFO - ##### Finished read-buildbot-config step (success) 18:06:53 INFO - ##### 18:06:53 INFO - ##### 18:06:53 INFO - ##### Running download-and-extract step. 18:06:53 INFO - ##### 18:06:53 INFO - Running pre-action listener: _resource_record_pre_action 18:06:53 INFO - Running main action method: download_and_extract 18:06:53 INFO - mkdir: /builds/slave/test/build/tests 18:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:53 INFO - https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:06:53 INFO - Downloaded 1361 bytes. 18:06:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:06:53 INFO - Using the following test package requirements: 18:06:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:06:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:06:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'jsshell-linux-x86_64.zip'], 18:06:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:06:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:06:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:06:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:06:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:06:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:53 INFO - https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:54 INFO - Downloaded 22653673 bytes. 18:06:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:06:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:06:56 INFO - Return code: 0 18:06:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:56 INFO - https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:06:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:06:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:57 INFO - Downloaded 22653673 bytes. 18:06:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:06:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:06:58 INFO - Return code: 0 18:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:58 INFO - https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:06:59 INFO - Downloaded 14405384 bytes. 18:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:06:59 INFO - Return code: 0 18:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:59 INFO - https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:07:01 INFO - Downloaded 55402216 bytes. 18:07:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:07:01 INFO - mkdir: /builds/slave/test/properties 18:07:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:07:01 INFO - Writing to file /builds/slave/test/properties/build_url 18:07:01 INFO - Contents: 18:07:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:07:02 INFO - Running post-action listener: _resource_record_post_action 18:07:02 INFO - Running post-action listener: set_extra_try_arguments 18:07:02 INFO - ##### 18:07:02 INFO - ##### Finished download-and-extract step (success) 18:07:02 INFO - ##### 18:07:02 INFO - ##### 18:07:02 INFO - ##### Running populate-webroot step. 18:07:02 INFO - ##### 18:07:02 INFO - Running pre-action listener: _resource_record_pre_action 18:07:02 INFO - Running main action method: populate_webroot 18:07:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:07:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:07:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:07:02 INFO - '--tppagecycles', 18:07:02 INFO - '7'], 18:07:02 INFO - 'tests': ['tsvgm']}}, 18:07:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:07:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:07:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:07:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:07:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['damp', 'tps']}, 18:07:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['damp', 'tps']}, 18:07:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['dromaeo_dom']}, 18:07:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:07:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['basic_compositor_video']}, 18:07:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:07:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tsvgx', 18:07:02 INFO - 'tsvgr_opacity', 18:07:02 INFO - 'tart', 18:07:02 INFO - 'tscrollx', 18:07:02 INFO - 'cart']}, 18:07:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:07:02 INFO - 'tsvgr_opacity', 18:07:02 INFO - 'tart', 18:07:02 INFO - 'tscrollx', 18:07:02 INFO - 'cart']}, 18:07:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tp5o']}, 18:07:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['tp5o']}, 18:07:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s', 18:07:02 INFO - '--xperf_path', 18:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:02 INFO - 'tests': ['tp5n']}, 18:07:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--xperf_path', 18:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:02 INFO - 'tests': ['tp5n']}}, 18:07:02 INFO - 'talos.zip': {'path': '', 18:07:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:07:02 INFO - Running post-action listener: _resource_record_post_action 18:07:02 INFO - ##### 18:07:02 INFO - ##### Finished populate-webroot step (success) 18:07:02 INFO - ##### 18:07:02 INFO - ##### 18:07:02 INFO - ##### Running create-virtualenv step. 18:07:02 INFO - ##### 18:07:02 INFO - Running pre-action listener: _resource_record_pre_action 18:07:02 INFO - Running main action method: create_virtualenv 18:07:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:07:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:07:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:07:02 INFO - Using real prefix '/usr' 18:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:07:02 INFO - Installing distribute.............................................................................................................................................................................................done. 18:07:04 INFO - Installing pip.................done. 18:07:04 INFO - Return code: 0 18:07:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:04 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:07:04 INFO - Using env: {'DISPLAY': ':0', 18:07:04 INFO - 'HOME': '/home/cltbld', 18:07:04 INFO - 'LANG': 'en_US.UTF-8', 18:07:04 INFO - 'LANGUAGE': 'en_US:en', 18:07:04 INFO - 'LOGNAME': 'cltbld', 18:07:04 INFO - 'MAIL': '/var/mail/cltbld', 18:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:04 INFO - 'MOZ_NO_REMOTE': '1', 18:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:04 INFO - 'NO_EM_RESTART': '1', 18:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:04 INFO - 'PWD': '/builds/slave/test', 18:07:04 INFO - 'SHELL': '/bin/bash', 18:07:04 INFO - 'SHLVL': '1', 18:07:04 INFO - 'TERM': 'linux', 18:07:04 INFO - 'TMOUT': '86400', 18:07:04 INFO - 'USER': 'cltbld', 18:07:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:04 INFO - '_': '/tools/buildbot/bin/python'} 18:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:07:05 INFO - Cleaning up... 18:07:05 INFO - Return code: 0 18:07:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:07:05 INFO - Using env: {'DISPLAY': ':0', 18:07:05 INFO - 'HOME': '/home/cltbld', 18:07:05 INFO - 'LANG': 'en_US.UTF-8', 18:07:05 INFO - 'LANGUAGE': 'en_US:en', 18:07:05 INFO - 'LOGNAME': 'cltbld', 18:07:05 INFO - 'MAIL': '/var/mail/cltbld', 18:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:05 INFO - 'MOZ_NO_REMOTE': '1', 18:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:05 INFO - 'NO_EM_RESTART': '1', 18:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:05 INFO - 'PWD': '/builds/slave/test', 18:07:05 INFO - 'SHELL': '/bin/bash', 18:07:05 INFO - 'SHLVL': '1', 18:07:05 INFO - 'TERM': 'linux', 18:07:05 INFO - 'TMOUT': '86400', 18:07:05 INFO - 'USER': 'cltbld', 18:07:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:05 INFO - '_': '/tools/buildbot/bin/python'} 18:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:05 INFO - Downloading/unpacking psutil>=3.1.1 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:07:07 INFO - Installing collected packages: psutil 18:07:07 INFO - Running setup.py install for psutil 18:07:07 INFO - building 'psutil._psutil_linux' extension 18:07:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:07:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:07:07 INFO - building 'psutil._psutil_posix' extension 18:07:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:07:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:07:07 INFO - Successfully installed psutil 18:07:07 INFO - Cleaning up... 18:07:07 INFO - Return code: 0 18:07:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:07 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:07:07 INFO - Using env: {'DISPLAY': ':0', 18:07:07 INFO - 'HOME': '/home/cltbld', 18:07:07 INFO - 'LANG': 'en_US.UTF-8', 18:07:07 INFO - 'LANGUAGE': 'en_US:en', 18:07:07 INFO - 'LOGNAME': 'cltbld', 18:07:07 INFO - 'MAIL': '/var/mail/cltbld', 18:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:07 INFO - 'MOZ_NO_REMOTE': '1', 18:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:07 INFO - 'NO_EM_RESTART': '1', 18:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:07 INFO - 'PWD': '/builds/slave/test', 18:07:07 INFO - 'SHELL': '/bin/bash', 18:07:07 INFO - 'SHLVL': '1', 18:07:07 INFO - 'TERM': 'linux', 18:07:07 INFO - 'TMOUT': '86400', 18:07:07 INFO - 'USER': 'cltbld', 18:07:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:07 INFO - '_': '/tools/buildbot/bin/python'} 18:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:07:09 INFO - Installing collected packages: mozsystemmonitor 18:07:09 INFO - Running setup.py install for mozsystemmonitor 18:07:09 INFO - Successfully installed mozsystemmonitor 18:07:09 INFO - Cleaning up... 18:07:10 INFO - Return code: 0 18:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:07: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')]} 18:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07: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')]} 18:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:07:10 INFO - Using env: {'DISPLAY': ':0', 18:07:10 INFO - 'HOME': '/home/cltbld', 18:07:10 INFO - 'LANG': 'en_US.UTF-8', 18:07:10 INFO - 'LANGUAGE': 'en_US:en', 18:07:10 INFO - 'LOGNAME': 'cltbld', 18:07:10 INFO - 'MAIL': '/var/mail/cltbld', 18:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:10 INFO - 'MOZ_NO_REMOTE': '1', 18:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:10 INFO - 'NO_EM_RESTART': '1', 18:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:10 INFO - 'PWD': '/builds/slave/test', 18:07:10 INFO - 'SHELL': '/bin/bash', 18:07:10 INFO - 'SHLVL': '1', 18:07:10 INFO - 'TERM': 'linux', 18:07:10 INFO - 'TMOUT': '86400', 18:07:10 INFO - 'USER': 'cltbld', 18:07:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:10 INFO - '_': '/tools/buildbot/bin/python'} 18:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 18:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:07:12 INFO - warning: no files found matching '*.txt' 18:07:12 INFO - no previously-included directories found matching 'build' 18:07:12 INFO - no previously-included directories found matching 'dist' 18:07:12 INFO - no previously-included directories found matching '.git*' 18:07:12 INFO - Installing collected packages: jsonschema, functools32 18:07:12 INFO - Running setup.py install for functools32 18:07:12 INFO - warning: no files found matching '*.txt' 18:07:12 INFO - no previously-included directories found matching 'build' 18:07:12 INFO - no previously-included directories found matching 'dist' 18:07:12 INFO - no previously-included directories found matching '.git*' 18:07:12 INFO - Successfully installed jsonschema functools32 18:07:12 INFO - Cleaning up... 18:07:12 INFO - Return code: 0 18:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:12 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:07:12 INFO - Using env: {'DISPLAY': ':0', 18:07:12 INFO - 'HOME': '/home/cltbld', 18:07:12 INFO - 'LANG': 'en_US.UTF-8', 18:07:12 INFO - 'LANGUAGE': 'en_US:en', 18:07:12 INFO - 'LOGNAME': 'cltbld', 18:07:12 INFO - 'MAIL': '/var/mail/cltbld', 18:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:12 INFO - 'MOZ_NO_REMOTE': '1', 18:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:12 INFO - 'NO_EM_RESTART': '1', 18:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:12 INFO - 'PWD': '/builds/slave/test', 18:07:12 INFO - 'SHELL': '/bin/bash', 18:07:12 INFO - 'SHLVL': '1', 18:07:12 INFO - 'TERM': 'linux', 18:07:12 INFO - 'TMOUT': '86400', 18:07:12 INFO - 'USER': 'cltbld', 18:07:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:12 INFO - '_': '/tools/buildbot/bin/python'} 18:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:14 INFO - Downloading blobuploader-1.2.4.tar.gz 18:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:07:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:15 INFO - Downloading docopt-0.6.1.tar.gz 18:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:07:15 INFO - Installing collected packages: blobuploader, requests, docopt 18:07:15 INFO - Running setup.py install for blobuploader 18:07:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:07:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:07:15 INFO - Running setup.py install for requests 18:07:15 INFO - Running setup.py install for docopt 18:07:15 INFO - Successfully installed blobuploader requests docopt 18:07:15 INFO - Cleaning up... 18:07:16 INFO - Return code: 0 18:07:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07: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')]} 18:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07: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')]} 18:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:16 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:07:16 INFO - Using env: {'DISPLAY': ':0', 18:07:16 INFO - 'HOME': '/home/cltbld', 18:07:16 INFO - 'LANG': 'en_US.UTF-8', 18:07:16 INFO - 'LANGUAGE': 'en_US:en', 18:07:16 INFO - 'LOGNAME': 'cltbld', 18:07:16 INFO - 'MAIL': '/var/mail/cltbld', 18:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:16 INFO - 'MOZ_NO_REMOTE': '1', 18:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:16 INFO - 'NO_EM_RESTART': '1', 18:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:16 INFO - 'PWD': '/builds/slave/test', 18:07:16 INFO - 'SHELL': '/bin/bash', 18:07:16 INFO - 'SHLVL': '1', 18:07:16 INFO - 'TERM': 'linux', 18:07:16 INFO - 'TMOUT': '86400', 18:07:16 INFO - 'USER': 'cltbld', 18:07:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:16 INFO - '_': '/tools/buildbot/bin/python'} 18:07:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:16 INFO - Running setup.py (path:/tmp/pip-vN7GBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:16 INFO - Running setup.py (path:/tmp/pip-0C8sqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:16 INFO - Running setup.py (path:/tmp/pip-lkSqKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:16 INFO - Running setup.py (path:/tmp/pip-iKglvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:16 INFO - Running setup.py (path:/tmp/pip-6BqK6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:16 INFO - Running setup.py (path:/tmp/pip-6_pW8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:16 INFO - Running setup.py (path:/tmp/pip-RMWHsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:16 INFO - Running setup.py (path:/tmp/pip-kxc6hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:16 INFO - Running setup.py (path:/tmp/pip-Cqm6Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:16 INFO - Running setup.py (path:/tmp/pip-qf89Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:17 INFO - Running setup.py (path:/tmp/pip-my2IDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:17 INFO - Running setup.py (path:/tmp/pip-XlTkaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:17 INFO - Running setup.py (path:/tmp/pip-2kmHRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:17 INFO - Running setup.py (path:/tmp/pip-3a5dlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:17 INFO - Running setup.py (path:/tmp/pip-Cem1RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:17 INFO - Running setup.py (path:/tmp/pip-n7vp7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:17 INFO - Running setup.py (path:/tmp/pip-K2tm5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:07:17 INFO - Running setup.py install for manifestparser 18:07:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:07:17 INFO - Running setup.py install for mozcrash 18:07:17 INFO - Running setup.py install for mozdebug 18:07:17 INFO - Running setup.py install for mozdevice 18:07:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:07:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:07:17 INFO - Running setup.py install for mozfile 18:07:18 INFO - Running setup.py install for mozhttpd 18:07:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozinfo 18:07:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozInstall 18:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozleak 18:07:18 INFO - Running setup.py install for mozlog 18:07:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for moznetwork 18:07:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozprocess 18:07:18 INFO - Running setup.py install for mozprofile 18:07:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozrunner 18:07:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozscreenshot 18:07:19 INFO - Running setup.py install for moztest 18:07:19 INFO - Running setup.py install for mozversion 18:07:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:07:19 INFO - Cleaning up... 18:07:19 INFO - Return code: 0 18:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:19 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:07:19 INFO - Using env: {'DISPLAY': ':0', 18:07:19 INFO - 'HOME': '/home/cltbld', 18:07:19 INFO - 'LANG': 'en_US.UTF-8', 18:07:19 INFO - 'LANGUAGE': 'en_US:en', 18:07:19 INFO - 'LOGNAME': 'cltbld', 18:07:19 INFO - 'MAIL': '/var/mail/cltbld', 18:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:19 INFO - 'MOZ_NO_REMOTE': '1', 18:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:19 INFO - 'NO_EM_RESTART': '1', 18:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:19 INFO - 'PWD': '/builds/slave/test', 18:07:19 INFO - 'SHELL': '/bin/bash', 18:07:19 INFO - 'SHLVL': '1', 18:07:19 INFO - 'TERM': 'linux', 18:07:19 INFO - 'TMOUT': '86400', 18:07:19 INFO - 'USER': 'cltbld', 18:07:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:19 INFO - '_': '/tools/buildbot/bin/python'} 18:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:19 INFO - Running setup.py (path:/tmp/pip-x7miWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:19 INFO - Running setup.py (path:/tmp/pip-3iMB4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:19 INFO - Running setup.py (path:/tmp/pip-80OW12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:19 INFO - Running setup.py (path:/tmp/pip-GiZLYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:19 INFO - Running setup.py (path:/tmp/pip-rHyjJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:19 INFO - Running setup.py (path:/tmp/pip-cNtD7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:19 INFO - Running setup.py (path:/tmp/pip-4MJ1R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:20 INFO - Running setup.py (path:/tmp/pip-n_Xjp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:20 INFO - Running setup.py (path:/tmp/pip-CupS8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:20 INFO - Running setup.py (path:/tmp/pip-xyCG9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:20 INFO - Running setup.py (path:/tmp/pip-Flip6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:20 INFO - Running setup.py (path:/tmp/pip-O5WfOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:20 INFO - Running setup.py (path:/tmp/pip-DkEh7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:20 INFO - Running setup.py (path:/tmp/pip-oJCu3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:20 INFO - Running setup.py (path:/tmp/pip-CoPuYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:20 INFO - Running setup.py (path:/tmp/pip-Sb9zUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:20 INFO - Running setup.py (path:/tmp/pip-g8Ne1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:07:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:22 INFO - Downloading blessings-1.6.tar.gz 18:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:07:22 INFO - Installing collected packages: blessings 18:07:22 INFO - Running setup.py install for blessings 18:07:22 INFO - Successfully installed blessings 18:07:22 INFO - Cleaning up... 18:07:22 INFO - Return code: 0 18:07:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:23 INFO - Reading from file tmpfile_stdout 18:07:23 INFO - Current package versions: 18:07:23 INFO - argparse == 1.2.1 18:07:23 INFO - blessings == 1.6 18:07:23 INFO - blobuploader == 1.2.4 18:07:23 INFO - docopt == 0.6.1 18:07:23 INFO - functools32 == 3.2.3-2 18:07:23 INFO - jsonschema == 2.5.1 18:07:23 INFO - manifestparser == 1.1 18:07:23 INFO - mozInstall == 1.12 18:07:23 INFO - mozcrash == 0.17 18:07:23 INFO - mozdebug == 0.1 18:07:23 INFO - mozdevice == 0.48 18:07:23 INFO - mozfile == 1.2 18:07:23 INFO - mozhttpd == 0.7 18:07:23 INFO - mozinfo == 0.9 18:07:23 INFO - mozleak == 0.1 18:07:23 INFO - mozlog == 3.2 18:07:23 INFO - moznetwork == 0.27 18:07:23 INFO - mozprocess == 0.22 18:07:23 INFO - mozprofile == 0.28 18:07:23 INFO - mozrunner == 6.11 18:07:23 INFO - mozscreenshot == 0.1 18:07:23 INFO - mozsystemmonitor == 0.3 18:07:23 INFO - moztest == 0.7 18:07:23 INFO - mozversion == 1.4 18:07:23 INFO - psutil == 3.1.1 18:07:23 INFO - requests == 1.2.3 18:07:23 INFO - wsgiref == 0.1.2 18:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:07:23 INFO - Using env: {'DISPLAY': ':0', 18:07:23 INFO - 'HOME': '/home/cltbld', 18:07:23 INFO - 'LANG': 'en_US.UTF-8', 18:07:23 INFO - 'LANGUAGE': 'en_US:en', 18:07:23 INFO - 'LOGNAME': 'cltbld', 18:07:23 INFO - 'MAIL': '/var/mail/cltbld', 18:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:23 INFO - 'MOZ_NO_REMOTE': '1', 18:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:23 INFO - 'NO_EM_RESTART': '1', 18:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:23 INFO - 'PWD': '/builds/slave/test', 18:07:23 INFO - 'SHELL': '/bin/bash', 18:07:23 INFO - 'SHLVL': '1', 18:07:23 INFO - 'TERM': 'linux', 18:07:23 INFO - 'TMOUT': '86400', 18:07:23 INFO - 'USER': 'cltbld', 18:07:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:23 INFO - '_': '/tools/buildbot/bin/python'} 18:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:07:23 INFO - Cleaning up... 18:07:23 INFO - Return code: 0 18:07:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:07:23 INFO - Using env: {'DISPLAY': ':0', 18:07:23 INFO - 'HOME': '/home/cltbld', 18:07:23 INFO - 'LANG': 'en_US.UTF-8', 18:07:23 INFO - 'LANGUAGE': 'en_US:en', 18:07:23 INFO - 'LOGNAME': 'cltbld', 18:07:23 INFO - 'MAIL': '/var/mail/cltbld', 18:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:23 INFO - 'MOZ_NO_REMOTE': '1', 18:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:23 INFO - 'NO_EM_RESTART': '1', 18:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:23 INFO - 'PWD': '/builds/slave/test', 18:07:23 INFO - 'SHELL': '/bin/bash', 18:07:23 INFO - 'SHLVL': '1', 18:07:23 INFO - 'TERM': 'linux', 18:07:23 INFO - 'TMOUT': '86400', 18:07:23 INFO - 'USER': 'cltbld', 18:07:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:23 INFO - '_': '/tools/buildbot/bin/python'} 18:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:07:23 INFO - Cleaning up... 18:07:23 INFO - Return code: 0 18:07:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:23 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 0x7f72997b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:07:23 INFO - Using env: {'DISPLAY': ':0', 18:07:23 INFO - 'HOME': '/home/cltbld', 18:07:23 INFO - 'LANG': 'en_US.UTF-8', 18:07:23 INFO - 'LANGUAGE': 'en_US:en', 18:07:23 INFO - 'LOGNAME': 'cltbld', 18:07:23 INFO - 'MAIL': '/var/mail/cltbld', 18:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:23 INFO - 'MOZ_NO_REMOTE': '1', 18:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:23 INFO - 'NO_EM_RESTART': '1', 18:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:23 INFO - 'PWD': '/builds/slave/test', 18:07:23 INFO - 'SHELL': '/bin/bash', 18:07:23 INFO - 'SHLVL': '1', 18:07:23 INFO - 'TERM': 'linux', 18:07:23 INFO - 'TMOUT': '86400', 18:07:23 INFO - 'USER': 'cltbld', 18:07:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:23 INFO - '_': '/tools/buildbot/bin/python'} 18:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:23 INFO - Downloading/unpacking flake8 18:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:07:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:07: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 18:07: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 18:07: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 18:07: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 18:07: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 18:07: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 18:07:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:07:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:07: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 18:07: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 18:07: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 18:07: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 18:07: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 18:07: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 18:07:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:07:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:07:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:07:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:07:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:07:26 INFO - no previously-included directories found matching 'docs/_build' 18:07:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:07:26 INFO - Running setup.py install for pep8 18:07:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:07:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:07:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:07:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:07:26 INFO - no previously-included directories found matching 'docs/_build' 18:07:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:07:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:07:26 INFO - Cleaning up... 18:07:26 INFO - Return code: 0 18:07:26 INFO - Running post-action listener: _resource_record_post_action 18:07:26 INFO - Running post-action listener: _start_resource_monitoring 18:07:26 INFO - Starting resource monitoring. 18:07:26 INFO - ##### 18:07:26 INFO - ##### Finished create-virtualenv step (success) 18:07:26 INFO - ##### 18:07:26 INFO - ##### 18:07:26 INFO - ##### Running install step. 18:07:26 INFO - ##### 18:07:26 INFO - Running pre-action listener: _resource_record_pre_action 18:07:26 INFO - Running main action method: install 18:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:26 INFO - Reading from file tmpfile_stdout 18:07:26 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:07:26 INFO - Reading from file tmpfile_stdout 18:07:26 INFO - Output received: 18:07:26 INFO - Usage: mozinstall [options] installer 18:07:26 INFO - Options: 18:07:26 INFO - -h, --help show this help message and exit 18:07:26 INFO - -d DEST, --destination=DEST 18:07:26 INFO - Directory to install application into. [default: 18:07:26 INFO - "/builds/slave/test"] 18:07:26 INFO - --app=APP Application being installed. [default: firefox] 18:07:26 INFO - mkdir: /builds/slave/test/build/application 18:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:07:42 INFO - Reading from file tmpfile_stdout 18:07:42 INFO - Output received: 18:07:42 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:42 INFO - Running post-action listener: _resource_record_post_action 18:07:42 INFO - ##### 18:07:42 INFO - ##### Finished install step (success) 18:07:42 INFO - ##### 18:07:42 INFO - ##### 18:07:42 INFO - ##### Running run-tests step. 18:07:42 INFO - ##### 18:07:42 INFO - Running pre-action listener: _resource_record_pre_action 18:07:42 INFO - Running main action method: run_tests 18:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:42 INFO - Python 2.7.3 18:07:42 INFO - Return code: 0 18:07:42 INFO - grabbing minidump binary from tooltool 18:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:42 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 0x145b1c0>, '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 0x145c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:07:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:07:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:07:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:42 INFO - Return code: 0 18:07:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:07:43 INFO - Return code: 0 18:07:43 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/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:07:43 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/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:07:43 INFO - Using env: {'DISPLAY': ':0', 18:07:43 INFO - 'HOME': '/home/cltbld', 18:07:43 INFO - 'LANG': 'en_US.UTF-8', 18:07:43 INFO - 'LANGUAGE': 'en_US:en', 18:07:43 INFO - 'LOGNAME': 'cltbld', 18:07:43 INFO - 'MAIL': '/var/mail/cltbld', 18:07:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:43 INFO - 'MOZ_NO_REMOTE': '1', 18:07:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:43 INFO - 'NO_EM_RESTART': '1', 18:07:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:43 INFO - 'PWD': '/builds/slave/test', 18:07:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:43 INFO - 'SHELL': '/bin/bash', 18:07:43 INFO - 'SHLVL': '1', 18:07:43 INFO - 'TERM': 'linux', 18:07:43 INFO - 'TMOUT': '86400', 18:07:43 INFO - 'USER': 'cltbld', 18:07:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792', 18:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:43 INFO - '_': '/tools/buildbot/bin/python'} 18:07:43 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/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:07:44 INFO - mozversion application_buildid: 20160614172925 18:07:44 INFO - mozversion application_changeset: 071e9554e3e76a7692fd1a24b845bc42064352b0 18:07:44 INFO - mozversion application_display_name: Nightly 18:07:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:44 INFO - mozversion application_name: Firefox 18:07:44 INFO - mozversion application_remotingname: firefox 18:07:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:07:44 INFO - mozversion application_vendor: Mozilla 18:07:44 INFO - mozversion application_version: 50.0a1 18:07:44 INFO - mozversion platform_buildid: 20160614172925 18:07:44 INFO - mozversion platform_changeset: 071e9554e3e76a7692fd1a24b845bc42064352b0 18:07:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:07:44 INFO - mozversion platform_version: 50.0a1 18:07:44 INFO - using testdate: 1465952864 18:07:44 INFO - actual date: 1465952864 18:07:44 INFO - starting webserver on 'localhost:52997' 18:07:44 INFO - SUITE-START | Running 2 tests 18:07:44 INFO - TEST-START | dromaeo_css 18:07:44 INFO - operating with platform_type : linux_ 18:07:44 INFO - Initialising browser for dromaeo_css test... 18:07:44 INFO - TEST-INFO | started process 3763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYXAN8/profile http://localhost:52997/getInfo.html) 18:07:48 INFO - PROCESS | 3763 | __metrics Screen width/height:1600/1200 18:07:48 INFO - PROCESS | 3763 | colorDepth:24 18:07:48 INFO - PROCESS | 3763 | Browser inner width/height: 1024/697 18:07:48 INFO - PROCESS | 3763 | __metrics 18:07:49 INFO - PROCESS | 3763 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:07:49 INFO - PROCESS | 3763 | console.error: PushService: 18:07:49 INFO - PROCESS | 3763 | stateChangeProcessEnqueue: Error transitioning state 18:07:49 INFO - PROCESS | 3763 | UnknownError 18:07:50 INFO - TEST-INFO | 3763: exit 0 18:07:50 INFO - Browser initialized. 18:07:50 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:50 INFO - TEST-INFO | started process 3842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYXAN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:08:02 INFO - PROCESS | 3842 | RSS: Main: 175632384 18:08:02 INFO - PROCESS | 3842 | 18:08:53 INFO - PROCESS | 3842 | 1465952933102 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:11:05 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52997/tests/dromaeo/cssquery-ext.html) 18:11:07 INFO - PROCESS | 3842 | RSS: Main: 290361344 18:11:07 INFO - PROCESS | 3842 | 18:14:09 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-ext.html (next: http://localhost:52997/tests/dromaeo/cssquery-jquery.html) 18:14:10 INFO - PROCESS | 3842 | RSS: Main: 264380416 18:14:10 INFO - PROCESS | 3842 | 18:17:12 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52997/tests/dromaeo/cssquery-mootools.html) 18:17:13 INFO - PROCESS | 3842 | RSS: Main: 265469952 18:17:13 INFO - PROCESS | 3842 | 18:20:15 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52997/tests/dromaeo/cssquery-prototype.html) 18:20:15 INFO - PROCESS | 3842 | RSS: Main: 265822208 18:20:15 INFO - PROCESS | 3842 | 18:23:18 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52997/tests/dromaeo/cssquery-yui.html) 18:23:19 INFO - PROCESS | 3842 | RSS: Main: 235986944 18:23:19 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | Cycle 1(1): loaded http://localhost:52997/tests/dromaeo/cssquery-yui.html (next: http://localhost:52997/tests/dromaeo/cssquery-dojo.html) 18:26:22 INFO - PROCESS | 3842 | RSS: Main: 291282944 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | __start_tp_report 18:26:22 INFO - PROCESS | 3842 | _x_x_mozilla_page_load 18:26:22 INFO - PROCESS | 3842 | _x_x_mozilla_page_load_details 18:26:22 INFO - PROCESS | 3842 | |i|pagename|runs| 18:26:22 INFO - PROCESS | 3842 | |0;dojo.html;2603.583426651735;2631.407933215026;2634.288742039649;2681.4234939488006;2687.2207059952616;4565.931511027337;4652.7906244219;4771.618270538357;4808.51914808519;4850.34520339754;4695.6478264130155;4728.810847566102;4733.148033353995;4741.265103908891;4748.620110391169;4313.051128751677;4342.97828510857;4398.7580683062415;4424.3142312941545;4518.548145185471;4414.095110502355;4447.132809102226;4479.664025198123;4485.551444855505;4511.571400716926;4298.269294219975;4327.156204540116;4351.651867850596;4394.4946331172005;4404.14119246747;4350.456192975878;4374.693771436001;4388.341748737683;4434.889127771831;4476.843310484118;4384.101259241847;4407.27279998803;4416.028473735805;4443.866683999485;4452.532484089189;4626.467956185048;4672.813087476497;4725.5510726480925;4727.787249573777;4800.735959522225;5127.48725127488;5133.537981581639;5170.767315470813;5197.298364720752;5213.895722085537;5178.300929374524;5194;5222.477752224747;5238.711870847102;5245.029669511153;4650.883727906762;4787;4802.6638135330195;4839.249916262985;4871.5128487151715;5349.652272602269;5351.25082488452;5383.407825139231;5404.702741349185;5405.99989002028;5109.693418394834;5116.590672746246;5154.587632989352;5160.509751573594;5165.690058596496;5010.849674509771;5063.392392912874;5124.846254612367;5247.10799164143;5249.055170069348;5092.6435149539175;5096.796128154832;5098.107831129538;5099.770510327045;5125.820596279113;5044.218146187347;5044.470330615306;5046.091703493406;5066.392032955995;5080.949190508121;4245.766482843412;4281.850135245251;4282.100758840616;4339.240632889232;4397.450318710161;3741.7006639468777;3754;3767.868124615625;3769.1142581493327;3812.3519001769764;4382.145481631115;4382.474103107647;4382.890427739332;4387.078713470143;4430.712003719748;4977.253411988158;5138.794448222029;5145.408278047998;5150.845474635767;5200.5059519345605;4401.273789824643;4424.292113261863;4442.044960333544;4474.932876006863;4475.440569928759;4644.140833945731;4660.813567457331;4664.020555683277;4671;4715.198416269174;4624.861254162381;4795.95204047969;4835.879103022453;4890.608751299958;4894.902101957941;5202.24567437727;5214.582833373245;5225.843224703265;5235.397929238186;5281.788728450819;4887.047025829929;4901.460839307744;4901.656884018084;4906.607471402208;4950.257461380822;4870.878228044327;5054.21659642756;5100.336956195671;5126.410462796826;5126.846194614168;5204.063268611686;5209.71346575942;5212.713300768494;5224.373075230997;5227.085260079547;5067.189249720174;5069.366329208849;5071.112555302881;5074.797008119782;5093.847184584469;4845.854624361275;4946.975265123651;4970.850874473772;5022.447530771686;5033.647644664985;4885.438174609823;4914.70511769295;4919.458859525521;4968.130577149057;4969.726665033458;4816.494268101799;5053.74731263428;5060.3927528696795;5099.413567439644;5110.3356563646485;4790.233562629963;4824.986752781955;4848.5636292733825;4850.6119510438375;4865.781039853286 18:26:22 INFO - PROCESS | 3842 | |1;ext.html;543.9455861182769;578.0317967404596;583.2243116654848;591.2491136256951;598.0789584040576;26924.326891827688;27442.86278568607;39945.2010959781;40896.59103408965;40899.386509202384;36138.8193059035;40550;40550;40553.79723101388;40555;7884.093329267136;8027.478213916077;8028.3978701597325;8030.9196908031045;8033.196680331949;7503.924960750404;7832.099308579529;7849.64676589552;7856.057273127232;7861.4103942204565;7882.369410447151;7930.762077137695;7939.245771651684;7939.603019849013;7951.880721789178;7833.804154896145;7891.368690504746;7894.486858354188;7899.802504937394;7924.920750792476;7926.167752385974;7990.680372785082;7993.280604745601;7994.880076798794;7996.560189189592;38018.80990595057;38453.42319865204;38473.42289865654;38505.80747096246;38537;3125.49992001281;3226.322472280824;3527;3841.327767640652;3886.7667939923695;27581.172564822886;29498.852505737334;29591.112266632037;29907;30875;3490.406630872758;3552.7335449841107;3559.2525569630407;3591.982040089809;3631.1103779574173;241023;241293.99999999825;241401;241698;242932;30759.69240307613;31626;52916;53356.466435335926;53501.1974820378;33517.83241083779;33836.66163338385;33848;33848;33869;12263.632091037283;12370.75258494825;12385;12387.132900697045;12397.93801030989;10423.270371074104;10434.42610656406;10440.269181157399;10444.63443779464;10449.68650940473;7800.219978002267;7859.4891332063235;7883.132855385903;7970.601469926481;7974.641141148662;3111.3932783107075;3131.6711745266875;3173.4129186100645;3174.6349169845303;3175.682431756852;834.4367551902442;877.6577134917387;907.9182873541413;966.2318456826839;978.7357413498459;25208.74791252101;26368.340791479983;26701.465970680478;27219.319517012234;27246.727532724817;933.2627224492575;949.9382540134869;956.6077908057802;974.2644303550774;1036.9377837329785;14039.578812635636;14718.779218311734;15020;15682.947763428476;15823.920880395524;392667;394263;395459;395580;396677;48991.510084899404;49378.75310623424;49421;49456.75271623691;49563.25655115176;1086.8478413022183;1156.0578128824814;1156.5142640091183;1197.455157903152;1201.819727040951;27581;28210.166339187886;28304.716952830207;28826.567601486415;29048;40728.185436290514;41034.794826026875;41413.378799317434;41555.58444415638;41556;300290;304907;305727;306273;307620;21757.564848703252;24279.150229741874;24781.876090619433;24905.62641560342;24914.750852491245;39986.20027599374;40030.39954400744;40141.59858401379;40728.389074163315;40970.385444218955;32402;34373.82813085918;34633;35286.647133528335;35395.46906796349;34413.13967150741;34675.306493870485;34749;34838.303233934676;35002.474962875065;34001;34477.482837757954;34573.30853382969;34581.654183457846;34685.65314346824;30026;31050.534241985937;31274.843625781727;31337.843310784214;31449.21376965594;23117;24247.42391744531;24261.150859719826;24788;24831.503369932863 18:26:22 INFO - PROCESS | 3842 | |2;jquery.html;357.6441440766436;368.84324162231053;368.9428138638512;370.3648243262805;385.7608282864624;16575;17265.13674316284;17313.39403120891;17776.46670599881;17811.554711132227;16200.189990500457;16737.748933766004;17309.7403538947;17318.48044558662;17422.431981121696;5008.398992120941;5141.1003074462005;5157.974210128963;5191.402988656315;5204.531592156705;3709.2210635766387;3912.921741565167;5043.293938848564;5565.554755619561;5938.554608404387;5951.88096238075;5982.371850955652;5987.670678112702;5992.910106348409;5993.310769261547;5808.709564521778;5924.318703349127;5935.317438494585;5948.672822994734;6086.360932102132;3282.556854824592;4851.345068415754;5202.06362854686;5208.401033881114;5209.947900521022;20256.696149557767;20840.687389689167;20858.687119693066;20959.790402095936;20979.055942482624;1998.4404366777326;2044.5604195098126;2216.8115710164657;2527.6082207257905;2533.4679717259396;13017.479300827956;13024.088313818036;13062.673433164151;13250.138740981805;13726.588202353945;1767.6287979524316;1790.8925464472172;1804.0979510244877;1811.9275228990825;1821.9089045547803;65334.34665653378;66632.3336766631;66827;67448.32551674469;67976.6601166996;9406.670766523139;9587.664431744855;9831.262655300881;10016.256958470889;10145.137663298703;13101.475940962446;13165.473381064841;13200.405981730844;13210.867891321155;13220.272884991226;7370.226126256773;7430.851382972311;7433.739819106306;7479.401647868158;7526.32263096324;7270.200277969419;7304.780856574312;7338.266173382725;7424.925750742532;7434.776956691199;6061.575689701766;6071.2714474263375;6217.409346112112;6222.595531290452;6304.117423560705;1593.1715507935808;1661.7258152404718;1730.1522254095655;1755.5611097225694;1762.3919747687028;773.8258891749311;822.8683410654266;865.5585651317873;922.5894476957824;993.1508560180941;16972.575685607713;17192;17695;17724.55688607795;18066.27734890616;862.9956850215834;864.1229152410309;914.277720600718;915.3409545127497;918.7978644698155;9858.704238872846;10262.948685256675;10404.11565016967;10414.947925260476;10476.214283928735;387775;396533;403205;404596;404935;68928;69414.65292673504;69554.65222673854;69705.65147174231;71911.6404417985;887.4054383563029;895.4985208283382;901.4411065139524;908.8091500784909;909.3270979475272;14666.926665366605;15633.530994070195;15691.293891774669;15719.528414147593;16245.593860153118;33221.16947076342;33859.83070084634;34336.48495272623;35107.99999999898;35114.824425877705;44689.55310446854;46189.76905115453;50129.74935125447;51555.74222128865;54305.45694543004;6510.544261901621;6999.160100787938;7065.293470652894;7535.886961695469;7619.504732192389;10978.890211098107;11563.132765042486;11608.709782255512;11861.352026845494;12163.81754273669;10139.64511242103;10203.540840662337;10345.586176552853;10479.423631700025;10532.684019479428;10097.495125243562;10325.586976520855;10526.210534209811;10657.946710266398;10742.24804263694;10214.795704086026;10399.168066554506;10606.787864242826;10700.464976751287;10880.564777408816;6543.6400997943665;6589;6980.057692211486;7020.438364930896;7127.322904324081;9922.305438619227;9954.950225248827;10053.849192262269;10329.845052324072;10727.731806704895 18:26:22 INFO - PROCESS | 3842 | |3;mootools.html;1195.0678470792784;1316.2431601828944;1372.9794053089201;1408.9859101408983;1655.6192075822553;6722.159730033746;7483.401327893769;7681.884771728429;7683.846323073535;7975.561344126071;7790.571518566477;7802.960985195066;7853.764387068397;7865.646045927932;7876.5667888266125;2163.4266919266406;2173.652215645497;2178.0743184146672;2189.419803752007;2198.692183094368;2137.3801597536694;2143.099898042818;2147.935561933137;2154.8168405685456;2171.8262538996923;2113.0174468871974;2121.087932189158;2126.3514628038442;2127.4681329667583;2130.754963179231;2087.2381580723004;2087.759907610629;2089.028601700209;2099.958000839975;2104.71586335845;1974.6445639784833;2063.1850419084526;2087.885166315852;2089.561192149635;2102.8002339777695;7629.504082234637;7727.111382191064;7808.687652493893;7817.022872140982;7830.647620857075;4465.68740188187;4581.541845815392;4597.310403439477;4607.10161518504;4611.792469338888;2854.557543580748;3004.9248768780735;3057.449659061368;3062.555929390226;3063.188255112375;954.5609019850807;969.1907257440046;969.961201551937;1000.9549570269355;1002.7944271424414;10503.212259080523;10527;10568.313059651098;10657.040866321991;10662.147028237723;3956.9802150989062;3980.044789250559;4034.4755181826176;4035.3543433050572;4045;8266.380021498291;8336.208060234268;8361.16388361159;8362.331013518904;8390.496570205685;4391.033972526039;4420.977895110504;4421.270490369053;4480.215962206601;4489.618382437464;3677.558692956862;3717.8326975286177;4090.2637525245145;4119.196756632428;4179.832806687698;3390.7456940729544;3415.214500664861;3491.17957280039;3506.3162683276514;3508.4211105167874;999.1457304005116;1012.4128005756644;1021.8160731068331;1026.343140390151;1029.6705054382526;832.6419639555049;838.5597561280376;844.2106630300566;862.4782006885869;889.5418859287472;5022.84931452057;5113.386393632788;5116.30929824469;5205.47945205484;5336.519713225828;379.11287587046445;389.03713309558617;389.5481241759545;389.7622450305312;391.2566124363675;3605.4411566206754;3620.1311685195365;3646.9817650911577;3655.3968595181495;3761.664609063798;9073.637054517878;9346.252299815998;9420.340576159602;9484.668036618685;9542.045795420541;9362.95318523403;9388.953055234817;9425.575849086808;9447.196988256075;9452.95273523628;7060.576365418091;7186.38915692172;7272.709091636275;7364.410847132217;7378.40972722181;5157.406898206755;5167.379914410295;5236.554892834151;5264.078786212474;5360.490753378423;8824.338174637056;9022.188003079755;9026.548672566214;9035.367524273237;9125.361224714206;8669.133086691281;9131.406458580172;9195.448273103368;9200.079992000747;9216;5867.9413205869105;6035.215421995113;6036.9698151508965;6082.087686847009;6514.3811337922825;6998.895016574857;7491.10106787189;7495.725726626596;7496.700131994659;7508.812279693051;6320.873582528416;6417.871642567029;6445.065465507569;6464.838379040561;6519.250286217146;6193.1329613853195;6242.875142497034;6292.8426789328805;6340.207474065742;6418.807435776934;6361.650109244036;6385.553011289165;6472.741090356333;6473.2232132144445;6506.869862602627;4513.593776560126;4563.680542362135;4602;4638.257878739386;4700.741459219776;4489.820407183676;4537.773111344485;4576.633869290516;4605.424321959755;4670.206064968896 18:26:22 INFO - PROCESS | 3842 | |4;prototype.html;280.16650464867024;284.7693368371619;285.33659242261746;285.6335262351419;290.8095197645543;4619.514950930155;4716.457607375149;4725.480197178312;4735.763211839411;4801.423829140508;4563.224251877181;4678.7426691531955;4697.2954056891485;4717.363155973942;4803.183458812002;3497.720182385403;3506.6493350664987;3674.6692797648207;3724.4413337999313;3734.7198960077967;3644.344018076745;3665.7433979621305;3669.7706268400116;3686.1153323202507;3699.7420876901847;3641.198936234024;3642.471841582969;3664.2228519168184;3671.320805650963;3714.962850371489;3670.7981061041633;3697.038769919827;3704.1850792825535;3711.758735682172;3740.4576336431064;3130.3739252149435;3223.8065716057113;3225.822579758112;3226.1934516370907;3231.87072517099;4571.58855702985;4577.22187228172;4595.954800113917;4622.237330840408;4631.513691062423;3973.9866334084913;4127.575986284727;4188.518320393163;4191.3293872980485;4200.1179752252065;4936.284238785392;4956.900861982776;4972.154733695281;4980.086649310158;4994.800207991676;3456.3087382523345;3460.1003739028033;3468.479728040789;3472.131967008248;3474.2530355973336;5057.6366716133725;5200.817971370984;5200.973995130038;5204.75085979366;5248.895022099575;3497.5453191085503;3502.5446691930397;3509.6841284284537;3511.5786105667485;3520.3135388598976;3588.174719814457;3588.6411358863907;3591.3894637911617;3596.4605309203307;3600.855965761393;3913.178232571135;4070.9185816283507;4135.81388837497;4155.937660935028;4167.91664166715;4770.95229047712;4980.7509624518625;4997.800087996512;5010.899782004412;5036.722980236049;1179.8201798201799;1208.9939550302192;1209.3227792436264;1210.6549633354452;1212.5271144253747;745.9962700186464;759.4873460414199;773.9380849532024;781.9960900195576;783.5533745764859;3930.8034598269974;3935.114599215211;3941.881743547698;3944.3097457944746;3992.7404718693774;4512.849223448;4578.88552786183;4579.801695186329;4593.379893714306;4630.884227894329;3970.7021973352116;3983.880483585497;4033.3095217875316;4033.9798301008896;4039.757614543078;2381.9047238110284;2474.542209691177;2490.5392502387117;2499.7750202481866;2503.2865633294787;4344.413504176959;4359.14996575671;4364.585364390377;4393.340998850134;4439.66702497314;4699.992005116728;4700.341952126705;4702.27114797207;4704.506026867198;4742.928856067162;4055.8986025349604;4295.37717031035;4335.943160072142;4340.283853164319;4379.299312110047;4561.566651168134;4584.4871192505725;4608.631309495299;4681.344611754289;4692;4551.704139230939;4577.313402989578;4587.747673877969;4620.306953956799;4635.9304610431545;4322.9135417290845;4393.143337049245;4410.404595379583;4524.389207456951;4888.584470320063;3546.0780197149443;3559;3570.4822800694274;3580.2481478889727;3590.946135807913;4996.525330093636;5241.637174334624;5244.659097158673;5247.107991641354;5263.7894484220205;4938.209886418156;5019.9960007997815;5026.974865125651;5033.3456650636645;5061.266116413173;4985.277134815359;4986.47641997585;4992.975035124801;4995.925061124013;5052.797888084436;4784.904301914012;4857.927131092966;4884.194107972145;4892.192788189909;4925.6305777066145;5014.52362025607;5046.596272298134;5062.746862656926;5063.696178229318;5066.392032956069;4888.388951381077;4953.504649535018;4957.652964292465;4968.143317592327;4988.326575912351 18:26:22 INFO - PROCESS | 3842 | |5;yui.html;619.1208483952787;645.6707079389513;648.575183254968;737.1375490675908;758.1092216645441;12041.698957526056;12736.108472406935;12827.615171544845;12974.545890893809;13246.470141194364;12597;12738.93630531846;12749.362531873392;12778.16941898776;12783.041271904598;621.8072397556772;762.3824701991405;762.9885551716715;786.2805532937384;789.3921680306161;796.7171654062811;798.5408390175672;801.0987638906231;801.1027649033091;801.4029547986758;839.6221700234888;839.8446287436843;840.3949156607233;840.4915026409026;841.2933136165619;645.9192600924885;806.1092492795435;828.0394742099136;829.9792505187419;837.3636036612157;603.4870360193844;603.8007457539002;603.9607425517371;604.0456079394546;604.1119554255238;13097.34513274342;13144.474221031147;13209.207447553177;13216.20702757828;13335.466581336736;12305.323207223599;12571.434285457177;12588.559400421032;12745.87254127456;12859.871401285962;10791.730206744816;10853.891461085446;10930.726731831768;11029.393383363911;11206.383648899307;3931.115499012728;3967.3255546556866;3993.201359728037;4061.2486689962157;4114.321137012389;58304.708476457345;58335;58411;59273;59500.10749838756;8995.268522518034;8999.415038022507;9158;9256;9371.718848434557;16616.086115263777;16621.41825036118;16692.582685432717;16698;17144.142792860308;6512.34876512345;6740.090087838177;6990.405815505637;7030.121234845645;7106.502544821917;3659.652333028358;3789.8484060637265;3832.2527107213828;3861.864834730827;3883.669888059547;2984.0749367696085;3085.4908940025093;3088.382323535302;3090.0884239149054;3093.474109401407;484.5881001149066;496.8410108765233;513.9511746384087;518.5100080423963;534.0547231400477;434.9543297953669;460.00179610245846;467.35738359755334;474.3477718137561;562.6608671362131;7465.738699145612;7929.920700793034;7962.800929976797;7978.60106994648;8191.303739182236;548.2160510470067;573.2948473377769;592.1413949772847;623.1182876230174;628.7610707931049;3693.612170722089;3754.2116155607628;3841.154945911895;3855.151866589346;3855.9228815423535;71519.28480715126;74109;85150.57424712837;86605.56697216474;89384.10615893888;48011.75994120077;62978.68510657417;64722.35277647257;65721.34278657248;75618.62190689011;45358.54641453609;52024.21963670548;62810.371896281365;67738.32261677418;68891;8463.830723385621;8500.149985001697;8731.869021964549;8829.205371516595;8934.803437302999;40396.1920761589;40458.79770601128;40988;41941.58058419377;42029;39170.80414597909;55485.445145549646;62507.37492625198;62932.685336574854;64044.3595564057;10567.89432105669;10922.726931826768;11003.669889903316;11084.889151108708;11085.44572771342;12542.811857821958;12683.936580317408;12990.870091298966;13001.2849293286;14189.858101419266;12490.437930292977;12707;12846.293453860128;12919.483220671444;13163.67090822737;11830.940845295718;11901.583444579399;12092.214006089576;12333.383330833243;12515.499380025061;12363.814542782045;12474.18917770342;12523.4364453598;12757.234565926074;12976.935115324362;10035.69892903214;10162.187025038127;10264.384136951807;10439;11060.225784195029;9925.801483970135;10282.280240383101;10413.843792343272;10422.635207767691;10693.679189624323 18:26:22 INFO - PROCESS | 3842 | __end_tp_report 18:26:22 INFO - PROCESS | 3842 | __start_cc_report 18:26:22 INFO - PROCESS | 3842 | _x_x_mozilla_cycle_collect,1062 18:26:22 INFO - PROCESS | 3842 | __end_cc_report 18:26:22 INFO - PROCESS | 3842 | __startTimestamp1465953982659__endTimestamp 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | ------- Summary: start ------- 18:26:22 INFO - PROCESS | 3842 | Number of tests: 6 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#0] dojo.html Cycles:165 Average:4746.16 Median:4850.61 stddev:517.31 (10.7%) stddev-sans-first:490.83 18:26:22 INFO - PROCESS | 3842 | Values: 2603.6 2631.4 2634.3 2681.4 2687.2 4565.9 4652.8 4771.6 4808.5 4850.3 4695.6 4728.8 4733.1 4741.3 4748.6 4313.1 4343.0 4398.8 4424.3 4518.5 4414.1 4447.1 4479.7 4485.6 4511.6 4298.3 4327.2 4351.7 4394.5 4404.1 4350.5 4374.7 4388.3 4434.9 4476.8 4384.1 4407.3 4416.0 4443.9 4452.5 4626.5 4672.8 4725.6 4727.8 4800.7 5127.5 5133.5 5170.8 5197.3 5213.9 5178.3 5194.0 5222.5 5238.7 5245.0 4650.9 4787.0 4802.7 4839.2 4871.5 5349.7 5351.3 5383.4 5404.7 5406.0 5109.7 5116.6 5154.6 5160.5 5165.7 5010.8 5063.4 5124.8 5247.1 5249.1 5092.6 5096.8 5098.1 5099.8 5125.8 5044.2 5044.5 5046.1 5066.4 5080.9 4245.8 4281.9 4282.1 4339.2 4397.5 3741.7 3754.0 3767.9 3769.1 3812.4 4382.1 4382.5 4382.9 4387.1 4430.7 4977.3 5138.8 5145.4 5150.8 5200.5 4401.3 4424.3 4442.0 4474.9 4475.4 4644.1 4660.8 4664.0 4671.0 4715.2 4624.9 4796.0 4835.9 4890.6 4894.9 5202.2 5214.6 5225.8 5235.4 5281.8 4887.0 4901.5 4901.7 4906.6 4950.3 4870.9 5054.2 5100.3 5126.4 5126.8 5204.1 5209.7 5212.7 5224.4 5227.1 5067.2 5069.4 5071.1 5074.8 5093.8 4845.9 4947.0 4970.9 5022.4 5033.6 4885.4 4914.7 4919.5 4968.1 4969.7 4816.5 5053.7 5060.4 5099.4 5110.3 4790.2 4825.0 4848.6 4850.6 4865.8 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#1] ext.html Cycles:180 Average:45297.47 Median:19264.74 stddev:84538.70 (438.8%) stddev-sans-first:84709.08 18:26:22 INFO - PROCESS | 3842 | Values: 543.9 578.0 583.2 591.2 598.1 26924.3 27442.9 39945.2 40896.6 40899.4 36138.8 40550.0 40550.0 40553.8 40555.0 7884.1 8027.5 8028.4 8030.9 8033.2 7503.9 7832.1 7849.6 7856.1 7861.4 7882.4 7930.8 7939.2 7939.6 7951.9 7833.8 7891.4 7894.5 7899.8 7924.9 7926.2 7990.7 7993.3 7994.9 7996.6 38018.8 38453.4 38473.4 38505.8 38537.0 3125.5 3226.3 3527.0 3841.3 3886.8 27581.2 29498.9 29591.1 29907.0 30875.0 3490.4 3552.7 3559.3 3592.0 3631.1 241023.0 241294.0 241401.0 241698.0 242932.0 30759.7 31626.0 52916.0 53356.5 53501.2 33517.8 33836.7 33848.0 33848.0 33869.0 12263.6 12370.8 12385.0 12387.1 12397.9 10423.3 10434.4 10440.3 10444.6 10449.7 7800.2 7859.5 7883.1 7970.6 7974.6 3111.4 3131.7 3173.4 3174.6 3175.7 834.4 877.7 907.9 966.2 978.7 25208.7 26368.3 26701.5 27219.3 27246.7 933.3 949.9 956.6 974.3 1036.9 14039.6 14718.8 15020.0 15682.9 15823.9 392667.0 394263.0 395459.0 395580.0 396677.0 48991.5 49378.8 49421.0 49456.8 49563.3 1086.8 1156.1 1156.5 1197.5 1201.8 27581.0 28210.2 28304.7 28826.6 29048.0 40728.2 41034.8 41413.4 41555.6 41556.0 300290.0 304907.0 305727.0 306273.0 307620.0 21757.6 24279.2 24781.9 24905.6 24914.8 39986.2 40030.4 40141.6 40728.4 40970.4 32402.0 34373.8 34633.0 35286.6 35395.5 34413.1 34675.3 34749.0 34838.3 35002.5 34001.0 34477.5 34573.3 34581.7 34685.7 30026.0 31050.5 31274.8 31337.8 31449.2 23117.0 24247.4 24261.2 24788.0 24831.5 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#2] jquery.html Cycles:180 Average:24394.82 Median:194080.38 stddev:65635.64 (33.8%) stddev-sans-first:65794.95 18:26:22 INFO - PROCESS | 3842 | Values: 357.6 368.8 368.9 370.4 385.8 16575.0 17265.1 17313.4 17776.5 17811.6 16200.2 16737.7 17309.7 17318.5 17422.4 5008.4 5141.1 5158.0 5191.4 5204.5 3709.2 3912.9 5043.3 5565.6 5938.6 5951.9 5982.4 5987.7 5992.9 5993.3 5808.7 5924.3 5935.3 5948.7 6086.4 3282.6 4851.3 5202.1 5208.4 5209.9 20256.7 20840.7 20858.7 20959.8 20979.1 1998.4 2044.6 2216.8 2527.6 2533.5 13017.5 13024.1 13062.7 13250.1 13726.6 1767.6 1790.9 1804.1 1811.9 1821.9 65334.3 66632.3 66827.0 67448.3 67976.7 9406.7 9587.7 9831.3 10016.3 10145.1 13101.5 13165.5 13200.4 13210.9 13220.3 7370.2 7430.9 7433.7 7479.4 7526.3 7270.2 7304.8 7338.3 7424.9 7434.8 6061.6 6071.3 6217.4 6222.6 6304.1 1593.2 1661.7 1730.2 1755.6 1762.4 773.8 822.9 865.6 922.6 993.2 16972.6 17192.0 17695.0 17724.6 18066.3 863.0 864.1 914.3 915.3 918.8 9858.7 10262.9 10404.1 10414.9 10476.2 387775.0 396533.0 403205.0 404596.0 404935.0 68928.0 69414.7 69554.7 69705.7 71911.6 887.4 895.5 901.4 908.8 909.3 14666.9 15633.5 15691.3 15719.5 16245.6 33221.2 33859.8 34336.5 35108.0 35114.8 44689.6 46189.8 50129.7 51555.7 54305.5 6510.5 6999.2 7065.3 7535.9 7619.5 10978.9 11563.1 11608.7 11861.4 12163.8 10139.6 10203.5 10345.6 10479.4 10532.7 10097.5 10325.6 10526.2 10657.9 10742.2 10214.8 10399.2 10606.8 10700.5 10880.6 6543.6 6589.0 6980.1 7020.4 7127.3 9922.3 9955.0 10053.8 10329.8 10727.7 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#3] mootools.html Cycles:180 Average:5021.40 Median:4861.80 stddev:2846.50 (58.5%) stddev-sans-first:2839.96 18:26:22 INFO - PROCESS | 3842 | Values: 1195.1 1316.2 1373.0 1409.0 1655.6 6722.2 7483.4 7681.9 7683.8 7975.6 7790.6 7803.0 7853.8 7865.6 7876.6 2163.4 2173.7 2178.1 2189.4 2198.7 2137.4 2143.1 2147.9 2154.8 2171.8 2113.0 2121.1 2126.4 2127.5 2130.8 2087.2 2087.8 2089.0 2100.0 2104.7 1974.6 2063.2 2087.9 2089.6 2102.8 7629.5 7727.1 7808.7 7817.0 7830.6 4465.7 4581.5 4597.3 4607.1 4611.8 2854.6 3004.9 3057.4 3062.6 3063.2 954.6 969.2 970.0 1001.0 1002.8 10503.2 10527.0 10568.3 10657.0 10662.1 3957.0 3980.0 4034.5 4035.4 4045.0 8266.4 8336.2 8361.2 8362.3 8390.5 4391.0 4421.0 4421.3 4480.2 4489.6 3677.6 3717.8 4090.3 4119.2 4179.8 3390.7 3415.2 3491.2 3506.3 3508.4 999.1 1012.4 1021.8 1026.3 1029.7 832.6 838.6 844.2 862.5 889.5 5022.8 5113.4 5116.3 5205.5 5336.5 379.1 389.0 389.5 389.8 391.3 3605.4 3620.1 3647.0 3655.4 3761.7 9073.6 9346.3 9420.3 9484.7 9542.0 9363.0 9389.0 9425.6 9447.2 9453.0 7060.6 7186.4 7272.7 7364.4 7378.4 5157.4 5167.4 5236.6 5264.1 5360.5 8824.3 9022.2 9026.5 9035.4 9125.4 8669.1 9131.4 9195.4 9200.1 9216.0 5867.9 6035.2 6037.0 6082.1 6514.4 6998.9 7491.1 7495.7 7496.7 7508.8 6320.9 6417.9 6445.1 6464.8 6519.3 6193.1 6242.9 6292.8 6340.2 6418.8 6361.7 6385.6 6472.7 6473.2 6506.9 4513.6 4563.7 4602.0 4638.3 4700.7 4489.8 4537.8 4576.6 4605.4 4670.2 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#4] prototype.html Cycles:180 Average:3995.02 Median:4401.87 stddev:1174.98 (26.7%) stddev-sans-first:1144.71 18:26:22 INFO - PROCESS | 3842 | Values: 280.2 284.8 285.3 285.6 290.8 4619.5 4716.5 4725.5 4735.8 4801.4 4563.2 4678.7 4697.3 4717.4 4803.2 3497.7 3506.6 3674.7 3724.4 3734.7 3644.3 3665.7 3669.8 3686.1 3699.7 3641.2 3642.5 3664.2 3671.3 3715.0 3670.8 3697.0 3704.2 3711.8 3740.5 3130.4 3223.8 3225.8 3226.2 3231.9 4571.6 4577.2 4596.0 4622.2 4631.5 3974.0 4127.6 4188.5 4191.3 4200.1 4936.3 4956.9 4972.2 4980.1 4994.8 3456.3 3460.1 3468.5 3472.1 3474.3 5057.6 5200.8 5201.0 5204.8 5248.9 3497.5 3502.5 3509.7 3511.6 3520.3 3588.2 3588.6 3591.4 3596.5 3600.9 3913.2 4070.9 4135.8 4155.9 4167.9 4771.0 4980.8 4997.8 5010.9 5036.7 1179.8 1209.0 1209.3 1210.7 1212.5 746.0 759.5 773.9 782.0 783.6 3930.8 3935.1 3941.9 3944.3 3992.7 4512.8 4578.9 4579.8 4593.4 4630.9 3970.7 3983.9 4033.3 4034.0 4039.8 2381.9 2474.5 2490.5 2499.8 2503.3 4344.4 4359.1 4364.6 4393.3 4439.7 4700.0 4700.3 4702.3 4704.5 4742.9 4055.9 4295.4 4335.9 4340.3 4379.3 4561.6 4584.5 4608.6 4681.3 4692.0 4551.7 4577.3 4587.7 4620.3 4635.9 4322.9 4393.1 4410.4 4524.4 4888.6 3546.1 3559.0 3570.5 3580.2 3590.9 4996.5 5241.6 5244.7 5247.1 5263.8 4938.2 5020.0 5027.0 5033.3 5061.3 4985.3 4986.5 4993.0 4995.9 5052.8 4784.9 4857.9 4884.2 4892.2 4925.6 5014.5 5046.6 5062.7 5063.7 5066.4 4888.4 4953.5 4957.7 4968.1 4988.3 18:26:22 INFO - PROCESS | 3842 | 18:26:22 INFO - PROCESS | 3842 | [#5] yui.html Cycles:180 Average:15988.99 Median:22896.75 stddev:21143.55 (92.3%) stddev-sans-first:21171.36 18:26:22 INFO - PROCESS | 3842 | Values: 619.1 645.7 648.6 737.1 758.1 12041.7 12736.1 12827.6 12974.5 13246.5 12597.0 12738.9 12749.4 12778.2 12783.0 621.8 762.4 763.0 786.3 789.4 796.7 798.5 801.1 801.1 801.4 839.6 839.8 840.4 840.5 841.3 645.9 806.1 828.0 830.0 837.4 603.5 603.8 604.0 604.0 604.1 13097.3 13144.5 13209.2 13216.2 13335.5 12305.3 12571.4 12588.6 12745.9 12859.9 10791.7 10853.9 10930.7 11029.4 11206.4 3931.1 3967.3 3993.2 4061.2 4114.3 58304.7 58335.0 58411.0 59273.0 59500.1 8995.3 8999.4 9158.0 9256.0 9371.7 16616.1 16621.4 16692.6 16698.0 17144.1 6512.3 6740.1 6990.4 7030.1 7106.5 3659.7 3789.8 3832.3 3861.9 3883.7 2984.1 3085.5 3088.4 3090.1 3093.5 484.6 496.8 514.0 518.5 534.1 435.0 460.0 467.4 474.3 562.7 7465.7 7929.9 7962.8 7978.6 8191.3 548.2 573.3 592.1 623.1 628.8 3693.6 3754.2 3841.2 3855.2 3855.9 71519.3 74109.0 85150.6 86605.6 89384.1 48011.8 62978.7 64722.4 65721.3 75618.6 45358.5 52024.2 62810.4 67738.3 68891.0 8463.8 8500.1 8731.9 8829.2 8934.8 40396.2 40458.8 40988.0 41941.6 42029.0 39170.8 55485.4 62507.4 62932.7 64044.4 10567.9 10922.7 11003.7 11084.9 11085.4 12542.8 12683.9 12990.9 13001.3 14189.9 12490.4 12707.0 12846.3 12919.5 13163.7 11830.9 11901.6 12092.2 12333.4 12515.5 12363.8 12474.2 12523.4 12757.2 12976.9 10035.7 10162.2 10264.4 10439.0 11060.2 9925.8 10282.3 10413.8 10422.6 10693.7 18:26:22 INFO - PROCESS | 3842 | -------- Summary: end -------- 18:26:22 INFO - PROCESS | 3842 | 18:26:23 INFO - TEST-INFO | 3842: exit 0 18:26:23 INFO - TEST-OK | dromaeo_css | took 1119428ms 18:26:23 INFO - TEST-START | kraken 18:26:23 INFO - operating with platform_type : linux_ 18:26:23 INFO - Initialising browser for kraken test... 18:26:23 INFO - TEST-INFO | started process 4023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAKALSN/profile http://localhost:52997/getInfo.html) 18:26:27 INFO - PROCESS | 4023 | __metrics Screen width/height:1600/1200 18:26:27 INFO - PROCESS | 4023 | colorDepth:24 18:26:27 INFO - PROCESS | 4023 | Browser inner width/height: 1024/697 18:26:27 INFO - PROCESS | 4023 | __metrics 18:26:28 INFO - PROCESS | 4023 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:26:28 INFO - PROCESS | 4023 | console.error: PushService: 18:26:28 INFO - PROCESS | 4023 | stateChangeProcessEnqueue: Error transitioning state 18:26:28 INFO - PROCESS | 4023 | UnknownError 18:26:29 INFO - TEST-INFO | 4023: exit 0 18:26:29 INFO - Browser initialized. 18:26:29 INFO - Running cycle 1/1 for kraken test... 18:26:29 INFO - TEST-INFO | started process 4103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAKALSN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:41 INFO - PROCESS | 4103 | RSS: Main: 175558656 18:26:41 INFO - PROCESS | 4103 | 18:26:44 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52997/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:45 INFO - PROCESS | 4103 | RSS: Main: 233025536 18:26:45 INFO - PROCESS | 4103 | 18:26:48 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52997/tests/kraken/driver.html?testName=audio-dft) 18:26:48 INFO - PROCESS | 4103 | RSS: Main: 220655616 18:26:48 INFO - PROCESS | 4103 | 18:26:51 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52997/tests/kraken/driver.html?testName=audio-fft) 18:26:52 INFO - PROCESS | 4103 | RSS: Main: 288710656 18:26:52 INFO - PROCESS | 4103 | 18:26:54 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52997/tests/kraken/driver.html?testName=audio-oscillator) 18:26:55 INFO - PROCESS | 4103 | RSS: Main: 199172096 18:26:55 INFO - PROCESS | 4103 | 18:26:57 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:58 INFO - PROCESS | 4103 | RSS: Main: 202264576 18:26:58 INFO - PROCESS | 4103 | 18:27:01 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52997/tests/kraken/driver.html?testName=imaging-darkroom) 18:27:02 INFO - PROCESS | 4103 | RSS: Main: 238993408 18:27:02 INFO - PROCESS | 4103 | 18:27:05 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52997/tests/kraken/driver.html?testName=imaging-desaturate) 18:27:06 INFO - PROCESS | 4103 | RSS: Main: 236113920 18:27:06 INFO - PROCESS | 4103 | 18:27:09 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52997/tests/kraken/driver.html?testName=json-parse-financial) 18:27:10 INFO - PROCESS | 4103 | RSS: Main: 237760512 18:27:10 INFO - PROCESS | 4103 | 18:27:11 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:27:12 INFO - PROCESS | 4103 | RSS: Main: 225624064 18:27:12 INFO - PROCESS | 4103 | 18:27:14 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:27:14 INFO - PROCESS | 4103 | RSS: Main: 231632896 18:27:14 INFO - PROCESS | 4103 | 18:27:17 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:27:17 INFO - PROCESS | 4103 | RSS: Main: 238321664 18:27:17 INFO - PROCESS | 4103 | 18:27:20 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:27:21 INFO - PROCESS | 4103 | RSS: Main: 241528832 18:27:21 INFO - PROCESS | 4103 | 18:27:24 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:27:24 INFO - PROCESS | 4103 | RSS: Main: 241397760 18:27:24 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:52997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52997/tests/kraken/driver.html?testName=ai-astar) 18:27:26 INFO - PROCESS | 4103 | RSS: Main: 284286976 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | __start_tp_report 18:27:26 INFO - PROCESS | 4103 | _x_x_mozilla_page_load 18:27:26 INFO - PROCESS | 4103 | _x_x_mozilla_page_load_details 18:27:26 INFO - PROCESS | 4103 | |i|pagename|runs| 18:27:26 INFO - PROCESS | 4103 | |0;ai-astar;112;108;112;113;111;113;112;112;112;112 18:27:26 INFO - PROCESS | 4103 | |1;audio-beat-detection;153;131;131;187;137;159;159;132;190;130 18:27:26 INFO - PROCESS | 4103 | |2;audio-dft;162;164;162;163;162;161;162;161;161;160 18:27:26 INFO - PROCESS | 4103 | |3;audio-fft;76;76;78;113;76;76;77;76;103;75 18:27:26 INFO - PROCESS | 4103 | |4;audio-oscillator;86;85;119;86;85;85;133;85;85;136 18:27:26 INFO - PROCESS | 4103 | |5;imaging-gaussian-blur;116;118;117;117;117;117;116;118;117;117 18:27:26 INFO - PROCESS | 4103 | |6;imaging-darkroom;174;177;175;174;175;174;173;177;175;174 18:27:26 INFO - PROCESS | 4103 | |7;imaging-desaturate;95;94;94;94;95;95;95;95;95;94 18:27:26 INFO - PROCESS | 4103 | |8;json-parse-financial;63;62;63;64;63;64;63;62;62;62 18:27:26 INFO - PROCESS | 4103 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;67;66;66 18:27:26 INFO - PROCESS | 4103 | |10;stanford-crypto-aes;89;84;84;83;84;86;85;86;120;84 18:27:26 INFO - PROCESS | 4103 | |11;stanford-crypto-ccm;143;143;129;133;127;136;128;131;147;143 18:27:26 INFO - PROCESS | 4103 | |12;stanford-crypto-pbkdf2;170;172;171;170;168;173;166;169;171;166 18:27:26 INFO - PROCESS | 4103 | |13;stanford-crypto-sha256-iterative;68;67;68;70;66;66;67;65;66;67 18:27:26 INFO - PROCESS | 4103 | __end_tp_report 18:27:26 INFO - PROCESS | 4103 | __start_cc_report 18:27:26 INFO - PROCESS | 4103 | _x_x_mozilla_cycle_collect,1926 18:27:26 INFO - PROCESS | 4103 | __end_cc_report 18:27:26 INFO - PROCESS | 4103 | __startTimestamp1465954046826__endTimestamp 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | ------- Summary: start ------- 18:27:26 INFO - PROCESS | 4103 | Number of tests: 14 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.50 18:27:26 INFO - PROCESS | 4103 | Values: 112.0 108.0 112.0 113.0 111.0 113.0 112.0 112.0 112.0 112.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.00 stddev:22.97 (14.7%) stddev-sans-first:24.35 18:27:26 INFO - PROCESS | 4103 | Values: 153.0 131.0 131.0 187.0 137.0 159.0 159.0 132.0 190.0 130.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 18:27:26 INFO - PROCESS | 4103 | Values: 162.0 164.0 162.0 163.0 162.0 161.0 162.0 161.0 161.0 160.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.62 (17.9%) stddev-sans-first:14.23 18:27:26 INFO - PROCESS | 4103 | Values: 76.0 76.0 78.0 113.0 76.0 76.0 77.0 76.0 103.0 75.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:85.00 stddev:21.71 (25.5%) stddev-sans-first:22.55 18:27:26 INFO - PROCESS | 4103 | Values: 86.0 85.0 119.0 86.0 85.0 85.0 133.0 85.0 85.0 136.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:27:26 INFO - PROCESS | 4103 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#6] imaging-darkroom Cycles:10 Average:174.80 Median:175.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 18:27:26 INFO - PROCESS | 4103 | Values: 174.0 177.0 175.0 174.0 175.0 174.0 173.0 177.0 175.0 174.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:27:26 INFO - PROCESS | 4103 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 18:27:26 INFO - PROCESS | 4103 | Values: 63.0 62.0 63.0 64.0 63.0 64.0 63.0 62.0 62.0 62.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 18:27:26 INFO - PROCESS | 4103 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:84.50 stddev:11.20 (13.3%) stddev-sans-first:11.88 18:27:26 INFO - PROCESS | 4103 | Values: 89.0 84.0 84.0 83.0 84.0 86.0 85.0 86.0 120.0 84.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:139.50 stddev:7.42 (5.3%) stddev-sans-first:7.43 18:27:26 INFO - PROCESS | 4103 | Values: 143.0 143.0 129.0 133.0 127.0 136.0 128.0 131.0 147.0 143.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:2.37 (1.4%) stddev-sans-first:2.51 18:27:26 INFO - PROCESS | 4103 | Values: 170.0 172.0 171.0 170.0 168.0 173.0 166.0 169.0 171.0 166.0 18:27:26 INFO - PROCESS | 4103 | 18:27:26 INFO - PROCESS | 4103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 18:27:26 INFO - PROCESS | 4103 | Values: 68.0 67.0 68.0 70.0 66.0 66.0 67.0 65.0 66.0 67.0 18:27:26 INFO - PROCESS | 4103 | -------- Summary: end -------- 18:27:26 INFO - PROCESS | 4103 | 18:27:27 INFO - TEST-INFO | 4103: exit 0 18:27:27 INFO - TEST-OK | kraken | took 64391ms 18:27:27 INFO - SUITE-END | took 1183s 18:27:27 INFO - Completed test suite (00:19:43) 18:27:27 INFO - javascript benchmark 18:27:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.583426651735, 2631.407933215026, 2634.288742039649, 2681.4234939488006, 2687.2207059952616, 4565.931511027337, 4652.7906244219, 4771.618270538357, 4808.51914808519, 4850.34520339754, 4695.6478264130155, 4728.810847566102, 4733.148033353995, 4741.265103908891, 4748.620110391169, 4313.051128751677, 4342.97828510857, 4398.7580683062415, 4424.3142312941545, 4518.548145185471, 4414.095110502355, 4447.132809102226, 4479.664025198123, 4485.551444855505, 4511.571400716926, 4298.269294219975, 4327.156204540116, 4351.651867850596, 4394.4946331172005, 4404.14119246747, 4350.456192975878, 4374.693771436001, 4388.341748737683, 4434.889127771831, 4476.843310484118, 4384.101259241847, 4407.27279998803, 4416.028473735805, 4443.866683999485, 4452.532484089189, 4626.467956185048, 4672.813087476497, 4725.5510726480925, 4727.787249573777, 4800.735959522225, 5127.48725127488, 5133.537981581639, 5170.767315470813, 5197.298364720752, 5213.895722085537, 5178.300929374524, 5194.0, 5222.477752224747, 5238.711870847102, 5245.029669511153, 4650.883727906762, 4787.0, 4802.6638135330195, 4839.249916262985, 4871.5128487151715, 5349.652272602269, 5351.25082488452, 5383.407825139231, 5404.702741349185, 5405.99989002028, 5109.693418394834, 5116.590672746246, 5154.587632989352, 5160.509751573594, 5165.690058596496, 5010.849674509771, 5063.392392912874, 5124.846254612367, 5247.10799164143, 5249.055170069348, 5092.6435149539175, 5096.796128154832, 5098.107831129538, 5099.770510327045, 5125.820596279113, 5044.218146187347, 5044.470330615306, 5046.091703493406, 5066.392032955995, 5080.949190508121, 4245.766482843412, 4281.850135245251, 4282.100758840616, 4339.240632889232, 4397.450318710161, 3741.7006639468777, 3754.0, 3767.868124615625, 3769.1142581493327, 3812.3519001769764, 4382.145481631115, 4382.474103107647, 4382.890427739332, 4387.078713470143, 4430.712003719748, 4977.253411988158, 5138.794448222029, 5145.408278047998, 5150.845474635767, 5200.5059519345605, 4401.273789824643, 4424.292113261863, 4442.044960333544, 4474.932876006863, 4475.440569928759, 4644.140833945731, 4660.813567457331, 4664.020555683277, 4671.0, 4715.198416269174, 4624.861254162381, 4795.95204047969, 4835.879103022453, 4890.608751299958, 4894.902101957941, 5202.24567437727, 5214.582833373245, 5225.843224703265, 5235.397929238186, 5281.788728450819, 4887.047025829929, 4901.460839307744, 4901.656884018084, 4906.607471402208, 4950.257461380822, 4870.878228044327, 5054.21659642756, 5100.336956195671, 5126.410462796826, 5126.846194614168, 5204.063268611686, 5209.71346575942, 5212.713300768494, 5224.373075230997, 5227.085260079547, 5067.189249720174, 5069.366329208849, 5071.112555302881, 5074.797008119782, 5093.847184584469, 4845.854624361275, 4946.975265123651, 4970.850874473772, 5022.447530771686, 5033.647644664985, 4885.438174609823, 4914.70511769295, 4919.458859525521, 4968.130577149057, 4969.726665033458, 4816.494268101799, 5053.74731263428, 5060.3927528696795, 5099.413567439644, 5110.3356563646485, 4790.233562629963, 4824.986752781955, 4848.5636292733825, 4850.6119510438375, 4865.781039853286], "value": 4712.034410779472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9455861182769, 578.0317967404596, 583.2243116654848, 591.2491136256951, 598.0789584040576, 26924.326891827688, 27442.86278568607, 39945.2010959781, 40896.59103408965, 40899.386509202384, 36138.8193059035, 40550.0, 40550.0, 40553.79723101388, 40555.0, 7884.093329267136, 8027.478213916077, 8028.3978701597325, 8030.9196908031045, 8033.196680331949, 7503.924960750404, 7832.099308579529, 7849.64676589552, 7856.057273127232, 7861.4103942204565, 7882.369410447151, 7930.762077137695, 7939.245771651684, 7939.603019849013, 7951.880721789178, 7833.804154896145, 7891.368690504746, 7894.486858354188, 7899.802504937394, 7924.920750792476, 7926.167752385974, 7990.680372785082, 7993.280604745601, 7994.880076798794, 7996.560189189592, 38018.80990595057, 38453.42319865204, 38473.42289865654, 38505.80747096246, 38537.0, 3125.49992001281, 3226.322472280824, 3527.0, 3841.327767640652, 3886.7667939923695, 27581.172564822886, 29498.852505737334, 29591.112266632037, 29907.0, 30875.0, 3490.406630872758, 3552.7335449841107, 3559.2525569630407, 3591.982040089809, 3631.1103779574173, 241023.0, 241293.99999999825, 241401.0, 241698.0, 242932.0, 30759.69240307613, 31626.0, 52916.0, 53356.466435335926, 53501.1974820378, 33517.83241083779, 33836.66163338385, 33848.0, 33848.0, 33869.0, 12263.632091037283, 12370.75258494825, 12385.0, 12387.132900697045, 12397.93801030989, 10423.270371074104, 10434.42610656406, 10440.269181157399, 10444.63443779464, 10449.68650940473, 7800.219978002267, 7859.4891332063235, 7883.132855385903, 7970.601469926481, 7974.641141148662, 3111.3932783107075, 3131.6711745266875, 3173.4129186100645, 3174.6349169845303, 3175.682431756852, 834.4367551902442, 877.6577134917387, 907.9182873541413, 966.2318456826839, 978.7357413498459, 25208.74791252101, 26368.340791479983, 26701.465970680478, 27219.319517012234, 27246.727532724817, 933.2627224492575, 949.9382540134869, 956.6077908057802, 974.2644303550774, 1036.9377837329785, 14039.578812635636, 14718.779218311734, 15020.0, 15682.947763428476, 15823.920880395524, 392667.0, 394263.0, 395459.0, 395580.0, 396677.0, 48991.510084899404, 49378.75310623424, 49421.0, 49456.75271623691, 49563.25655115176, 1086.8478413022183, 1156.0578128824814, 1156.5142640091183, 1197.455157903152, 1201.819727040951, 27581.0, 28210.166339187886, 28304.716952830207, 28826.567601486415, 29048.0, 40728.185436290514, 41034.794826026875, 41413.378799317434, 41555.58444415638, 41556.0, 300290.0, 304907.0, 305727.0, 306273.0, 307620.0, 21757.564848703252, 24279.150229741874, 24781.876090619433, 24905.62641560342, 24914.750852491245, 39986.20027599374, 40030.39954400744, 40141.59858401379, 40728.389074163315, 40970.385444218955, 32402.0, 34373.82813085918, 34633.0, 35286.647133528335, 35395.46906796349, 34413.13967150741, 34675.306493870485, 34749.0, 34838.303233934676, 35002.474962875065, 34001.0, 34477.482837757954, 34573.30853382969, 34581.654183457846, 34685.65314346824, 30026.0, 31050.534241985937, 31274.843625781727, 31337.843310784214, 31449.21376965594, 23117.0, 24247.42391744531, 24261.150859719826, 24788.0, 24831.503369932863], "value": 16216.109629109724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6441440766436, 368.84324162231053, 368.9428138638512, 370.3648243262805, 385.7608282864624, 16575.0, 17265.13674316284, 17313.39403120891, 17776.46670599881, 17811.554711132227, 16200.189990500457, 16737.748933766004, 17309.7403538947, 17318.48044558662, 17422.431981121696, 5008.398992120941, 5141.1003074462005, 5157.974210128963, 5191.402988656315, 5204.531592156705, 3709.2210635766387, 3912.921741565167, 5043.293938848564, 5565.554755619561, 5938.554608404387, 5951.88096238075, 5982.371850955652, 5987.670678112702, 5992.910106348409, 5993.310769261547, 5808.709564521778, 5924.318703349127, 5935.317438494585, 5948.672822994734, 6086.360932102132, 3282.556854824592, 4851.345068415754, 5202.06362854686, 5208.401033881114, 5209.947900521022, 20256.696149557767, 20840.687389689167, 20858.687119693066, 20959.790402095936, 20979.055942482624, 1998.4404366777326, 2044.5604195098126, 2216.8115710164657, 2527.6082207257905, 2533.4679717259396, 13017.479300827956, 13024.088313818036, 13062.673433164151, 13250.138740981805, 13726.588202353945, 1767.6287979524316, 1790.8925464472172, 1804.0979510244877, 1811.9275228990825, 1821.9089045547803, 65334.34665653378, 66632.3336766631, 66827.0, 67448.32551674469, 67976.6601166996, 9406.670766523139, 9587.664431744855, 9831.262655300881, 10016.256958470889, 10145.137663298703, 13101.475940962446, 13165.473381064841, 13200.405981730844, 13210.867891321155, 13220.272884991226, 7370.226126256773, 7430.851382972311, 7433.739819106306, 7479.401647868158, 7526.32263096324, 7270.200277969419, 7304.780856574312, 7338.266173382725, 7424.925750742532, 7434.776956691199, 6061.575689701766, 6071.2714474263375, 6217.409346112112, 6222.595531290452, 6304.117423560705, 1593.1715507935808, 1661.7258152404718, 1730.1522254095655, 1755.5611097225694, 1762.3919747687028, 773.8258891749311, 822.8683410654266, 865.5585651317873, 922.5894476957824, 993.1508560180941, 16972.575685607713, 17192.0, 17695.0, 17724.55688607795, 18066.27734890616, 862.9956850215834, 864.1229152410309, 914.277720600718, 915.3409545127497, 918.7978644698155, 9858.704238872846, 10262.948685256675, 10404.11565016967, 10414.947925260476, 10476.214283928735, 387775.0, 396533.0, 403205.0, 404596.0, 404935.0, 68928.0, 69414.65292673504, 69554.65222673854, 69705.65147174231, 71911.6404417985, 887.4054383563029, 895.4985208283382, 901.4411065139524, 908.8091500784909, 909.3270979475272, 14666.926665366605, 15633.530994070195, 15691.293891774669, 15719.528414147593, 16245.593860153118, 33221.16947076342, 33859.83070084634, 34336.48495272623, 35107.99999999898, 35114.824425877705, 44689.55310446854, 46189.76905115453, 50129.74935125447, 51555.74222128865, 54305.45694543004, 6510.544261901621, 6999.160100787938, 7065.293470652894, 7535.886961695469, 7619.504732192389, 10978.890211098107, 11563.132765042486, 11608.709782255512, 11861.352026845494, 12163.81754273669, 10139.64511242103, 10203.540840662337, 10345.586176552853, 10479.423631700025, 10532.684019479428, 10097.495125243562, 10325.586976520855, 10526.210534209811, 10657.946710266398, 10742.24804263694, 10214.795704086026, 10399.168066554506, 10606.787864242826, 10700.464976751287, 10880.564777408816, 6543.6400997943665, 6589.0, 6980.057692211486, 7020.438364930896, 7127.322904324081, 9922.305438619227, 9954.950225248827, 10053.849192262269, 10329.845052324072, 10727.731806704895], "value": 8362.012356652278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1195.0678470792784, 1316.2431601828944, 1372.9794053089201, 1408.9859101408983, 1655.6192075822553, 6722.159730033746, 7483.401327893769, 7681.884771728429, 7683.846323073535, 7975.561344126071, 7790.571518566477, 7802.960985195066, 7853.764387068397, 7865.646045927932, 7876.5667888266125, 2163.4266919266406, 2173.652215645497, 2178.0743184146672, 2189.419803752007, 2198.692183094368, 2137.3801597536694, 2143.099898042818, 2147.935561933137, 2154.8168405685456, 2171.8262538996923, 2113.0174468871974, 2121.087932189158, 2126.3514628038442, 2127.4681329667583, 2130.754963179231, 2087.2381580723004, 2087.759907610629, 2089.028601700209, 2099.958000839975, 2104.71586335845, 1974.6445639784833, 2063.1850419084526, 2087.885166315852, 2089.561192149635, 2102.8002339777695, 7629.504082234637, 7727.111382191064, 7808.687652493893, 7817.022872140982, 7830.647620857075, 4465.68740188187, 4581.541845815392, 4597.310403439477, 4607.10161518504, 4611.792469338888, 2854.557543580748, 3004.9248768780735, 3057.449659061368, 3062.555929390226, 3063.188255112375, 954.5609019850807, 969.1907257440046, 969.961201551937, 1000.9549570269355, 1002.7944271424414, 10503.212259080523, 10527.0, 10568.313059651098, 10657.040866321991, 10662.147028237723, 3956.9802150989062, 3980.044789250559, 4034.4755181826176, 4035.3543433050572, 4045.0, 8266.380021498291, 8336.208060234268, 8361.16388361159, 8362.331013518904, 8390.496570205685, 4391.033972526039, 4420.977895110504, 4421.270490369053, 4480.215962206601, 4489.618382437464, 3677.558692956862, 3717.8326975286177, 4090.2637525245145, 4119.196756632428, 4179.832806687698, 3390.7456940729544, 3415.214500664861, 3491.17957280039, 3506.3162683276514, 3508.4211105167874, 999.1457304005116, 1012.4128005756644, 1021.8160731068331, 1026.343140390151, 1029.6705054382526, 832.6419639555049, 838.5597561280376, 844.2106630300566, 862.4782006885869, 889.5418859287472, 5022.84931452057, 5113.386393632788, 5116.30929824469, 5205.47945205484, 5336.519713225828, 379.11287587046445, 389.03713309558617, 389.5481241759545, 389.7622450305312, 391.2566124363675, 3605.4411566206754, 3620.1311685195365, 3646.9817650911577, 3655.3968595181495, 3761.664609063798, 9073.637054517878, 9346.252299815998, 9420.340576159602, 9484.668036618685, 9542.045795420541, 9362.95318523403, 9388.953055234817, 9425.575849086808, 9447.196988256075, 9452.95273523628, 7060.576365418091, 7186.38915692172, 7272.709091636275, 7364.410847132217, 7378.40972722181, 5157.406898206755, 5167.379914410295, 5236.554892834151, 5264.078786212474, 5360.490753378423, 8824.338174637056, 9022.188003079755, 9026.548672566214, 9035.367524273237, 9125.361224714206, 8669.133086691281, 9131.406458580172, 9195.448273103368, 9200.079992000747, 9216.0, 5867.9413205869105, 6035.215421995113, 6036.9698151508965, 6082.087686847009, 6514.3811337922825, 6998.895016574857, 7491.10106787189, 7495.725726626596, 7496.700131994659, 7508.812279693051, 6320.873582528416, 6417.871642567029, 6445.065465507569, 6464.838379040561, 6519.250286217146, 6193.1329613853195, 6242.875142497034, 6292.8426789328805, 6340.207474065742, 6418.807435776934, 6361.650109244036, 6385.553011289165, 6472.741090356333, 6473.2232132144445, 6506.869862602627, 4513.593776560126, 4563.680542362135, 4602.0, 4638.257878739386, 4700.741459219776, 4489.820407183676, 4537.773111344485, 4576.633869290516, 4605.424321959755, 4670.206064968896], "value": 3965.2624569607074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.16650464867024, 284.7693368371619, 285.33659242261746, 285.6335262351419, 290.8095197645543, 4619.514950930155, 4716.457607375149, 4725.480197178312, 4735.763211839411, 4801.423829140508, 4563.224251877181, 4678.7426691531955, 4697.2954056891485, 4717.363155973942, 4803.183458812002, 3497.720182385403, 3506.6493350664987, 3674.6692797648207, 3724.4413337999313, 3734.7198960077967, 3644.344018076745, 3665.7433979621305, 3669.7706268400116, 3686.1153323202507, 3699.7420876901847, 3641.198936234024, 3642.471841582969, 3664.2228519168184, 3671.320805650963, 3714.962850371489, 3670.7981061041633, 3697.038769919827, 3704.1850792825535, 3711.758735682172, 3740.4576336431064, 3130.3739252149435, 3223.8065716057113, 3225.822579758112, 3226.1934516370907, 3231.87072517099, 4571.58855702985, 4577.22187228172, 4595.954800113917, 4622.237330840408, 4631.513691062423, 3973.9866334084913, 4127.575986284727, 4188.518320393163, 4191.3293872980485, 4200.1179752252065, 4936.284238785392, 4956.900861982776, 4972.154733695281, 4980.086649310158, 4994.800207991676, 3456.3087382523345, 3460.1003739028033, 3468.479728040789, 3472.131967008248, 3474.2530355973336, 5057.6366716133725, 5200.817971370984, 5200.973995130038, 5204.75085979366, 5248.895022099575, 3497.5453191085503, 3502.5446691930397, 3509.6841284284537, 3511.5786105667485, 3520.3135388598976, 3588.174719814457, 3588.6411358863907, 3591.3894637911617, 3596.4605309203307, 3600.855965761393, 3913.178232571135, 4070.9185816283507, 4135.81388837497, 4155.937660935028, 4167.91664166715, 4770.95229047712, 4980.7509624518625, 4997.800087996512, 5010.899782004412, 5036.722980236049, 1179.8201798201799, 1208.9939550302192, 1209.3227792436264, 1210.6549633354452, 1212.5271144253747, 745.9962700186464, 759.4873460414199, 773.9380849532024, 781.9960900195576, 783.5533745764859, 3930.8034598269974, 3935.114599215211, 3941.881743547698, 3944.3097457944746, 3992.7404718693774, 4512.849223448, 4578.88552786183, 4579.801695186329, 4593.379893714306, 4630.884227894329, 3970.7021973352116, 3983.880483585497, 4033.3095217875316, 4033.9798301008896, 4039.757614543078, 2381.9047238110284, 2474.542209691177, 2490.5392502387117, 2499.7750202481866, 2503.2865633294787, 4344.413504176959, 4359.14996575671, 4364.585364390377, 4393.340998850134, 4439.66702497314, 4699.992005116728, 4700.341952126705, 4702.27114797207, 4704.506026867198, 4742.928856067162, 4055.8986025349604, 4295.37717031035, 4335.943160072142, 4340.283853164319, 4379.299312110047, 4561.566651168134, 4584.4871192505725, 4608.631309495299, 4681.344611754289, 4692.0, 4551.704139230939, 4577.313402989578, 4587.747673877969, 4620.306953956799, 4635.9304610431545, 4322.9135417290845, 4393.143337049245, 4410.404595379583, 4524.389207456951, 4888.584470320063, 3546.0780197149443, 3559.0, 3570.4822800694274, 3580.2481478889727, 3590.946135807913, 4996.525330093636, 5241.637174334624, 5244.659097158673, 5247.107991641354, 5263.7894484220205, 4938.209886418156, 5019.9960007997815, 5026.974865125651, 5033.3456650636645, 5061.266116413173, 4985.277134815359, 4986.47641997585, 4992.975035124801, 4995.925061124013, 5052.797888084436, 4784.904301914012, 4857.927131092966, 4884.194107972145, 4892.192788189909, 4925.6305777066145, 5014.52362025607, 5046.596272298134, 5062.746862656926, 5063.696178229318, 5066.392032956069, 4888.388951381077, 4953.504649535018, 4957.652964292465, 4968.143317592327, 4988.326575912351], "value": 3617.9576858739365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.1208483952787, 645.6707079389513, 648.575183254968, 737.1375490675908, 758.1092216645441, 12041.698957526056, 12736.108472406935, 12827.615171544845, 12974.545890893809, 13246.470141194364, 12597.0, 12738.93630531846, 12749.362531873392, 12778.16941898776, 12783.041271904598, 621.8072397556772, 762.3824701991405, 762.9885551716715, 786.2805532937384, 789.3921680306161, 796.7171654062811, 798.5408390175672, 801.0987638906231, 801.1027649033091, 801.4029547986758, 839.6221700234888, 839.8446287436843, 840.3949156607233, 840.4915026409026, 841.2933136165619, 645.9192600924885, 806.1092492795435, 828.0394742099136, 829.9792505187419, 837.3636036612157, 603.4870360193844, 603.8007457539002, 603.9607425517371, 604.0456079394546, 604.1119554255238, 13097.34513274342, 13144.474221031147, 13209.207447553177, 13216.20702757828, 13335.466581336736, 12305.323207223599, 12571.434285457177, 12588.559400421032, 12745.87254127456, 12859.871401285962, 10791.730206744816, 10853.891461085446, 10930.726731831768, 11029.393383363911, 11206.383648899307, 3931.115499012728, 3967.3255546556866, 3993.201359728037, 4061.2486689962157, 4114.321137012389, 58304.708476457345, 58335.0, 58411.0, 59273.0, 59500.10749838756, 8995.268522518034, 8999.415038022507, 9158.0, 9256.0, 9371.718848434557, 16616.086115263777, 16621.41825036118, 16692.582685432717, 16698.0, 17144.142792860308, 6512.34876512345, 6740.090087838177, 6990.405815505637, 7030.121234845645, 7106.502544821917, 3659.652333028358, 3789.8484060637265, 3832.2527107213828, 3861.864834730827, 3883.669888059547, 2984.0749367696085, 3085.4908940025093, 3088.382323535302, 3090.0884239149054, 3093.474109401407, 484.5881001149066, 496.8410108765233, 513.9511746384087, 518.5100080423963, 534.0547231400477, 434.9543297953669, 460.00179610245846, 467.35738359755334, 474.3477718137561, 562.6608671362131, 7465.738699145612, 7929.920700793034, 7962.800929976797, 7978.60106994648, 8191.303739182236, 548.2160510470067, 573.2948473377769, 592.1413949772847, 623.1182876230174, 628.7610707931049, 3693.612170722089, 3754.2116155607628, 3841.154945911895, 3855.151866589346, 3855.9228815423535, 71519.28480715126, 74109.0, 85150.57424712837, 86605.56697216474, 89384.10615893888, 48011.75994120077, 62978.68510657417, 64722.35277647257, 65721.34278657248, 75618.62190689011, 45358.54641453609, 52024.21963670548, 62810.371896281365, 67738.32261677418, 68891.0, 8463.830723385621, 8500.149985001697, 8731.869021964549, 8829.205371516595, 8934.803437302999, 40396.1920761589, 40458.79770601128, 40988.0, 41941.58058419377, 42029.0, 39170.80414597909, 55485.445145549646, 62507.37492625198, 62932.685336574854, 64044.3595564057, 10567.89432105669, 10922.726931826768, 11003.669889903316, 11084.889151108708, 11085.44572771342, 12542.811857821958, 12683.936580317408, 12990.870091298966, 13001.2849293286, 14189.858101419266, 12490.437930292977, 12707.0, 12846.293453860128, 12919.483220671444, 13163.67090822737, 11830.940845295718, 11901.583444579399, 12092.214006089576, 12333.383330833243, 12515.499380025061, 12363.814542782045, 12474.18917770342, 12523.4364453598, 12757.234565926074, 12976.935115324362, 10035.69892903214, 10162.187025038127, 10264.384136951807, 10439.0, 11060.225784195029, 9925.801483970135, 10282.280240383101, 10413.843792343272, 10422.635207767691, 10693.679189624323], "value": 6417.369696420932, "unit": "score"}], "name": "dromaeo_css", "value": 6236.4117509327625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 113.0, 111.0, 113.0, 112.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 131.0, 187.0, 137.0, 159.0, 159.0, 132.0, 190.0, 130.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 113.0, 76.0, 76.0, 77.0, 76.0, 103.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 119.0, 86.0, 85.0, 85.0, 133.0, 85.0, 85.0, 136.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 175.0, 174.0, 175.0, 174.0, 173.0, 177.0, 175.0, 174.0], "value": 174.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 62.0, 62.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 84.0, 83.0, 84.0, 86.0, 85.0, 86.0, 120.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 129.0, 133.0, 127.0, 136.0, 128.0, 131.0, 147.0, 143.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 171.0, 170.0, 168.0, 173.0, 166.0, 169.0, 171.0, 166.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 70.0, 66.0, 66.0, 67.0, 65.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1581.8, "alertThreshold": 2.0}]} 18:27:28 INFO - Return code: 0 18:27:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:27:28 INFO - # TBPL SUCCESS # 18:27:28 INFO - Running post-action listener: _resource_record_post_action 18:27:28 INFO - ##### 18:27:28 INFO - ##### Finished run-tests step (success) 18:27:28 INFO - ##### 18:27:28 INFO - Running post-run listener: _resource_record_post_run 18:27:28 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548200448; Read time: 16; Write time: 452128 18:27:28 INFO - TinderboxPrint: CPU usage
13.2% 18:27:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:27:28 INFO - TinderboxPrint: I/O write bytes / time
548,200,448 / 452,128 18:27:28 INFO - TinderboxPrint: CPU idle
8,316.7 (86.8%) 18:27:28 INFO - TinderboxPrint: CPU user
1,220.8 (12.7%) 18:27:28 INFO - TinderboxPrint: Swap in / out
0 / 0 18:27:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253087744; Read time: 0; Write time: 245316 18:27:28 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294961152; Read time: 16; Write time: 206792 18:27:28 INFO - Running post-run listener: _upload_blobber_files 18:27:28 INFO - Blob upload gear active. 18:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:27:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:27:28 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'] 18:27:28 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 18:27:29 INFO - (blobuploader) - INFO - Open directory for files ... 18:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:29 INFO - (blobuploader) - INFO - Done attempting. 18:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:30 INFO - (blobuploader) - INFO - Done attempting. 18:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:35 INFO - (blobuploader) - INFO - Done attempting. 18:27:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:35 INFO - Return code: 0 18:27:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4844d24d1eb2d56316751352ae1e92e6e1c1df4bac93ec71bf7d4e1de088342afbd154079f052613685bed7d824f2760d0abad23721cea23b80a12c7bdd8dc73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c820351a71240f45da84647a164c08c5bb8772f3963532cf183a1c2e3e827a12d3632cc720735b431501906ab557c18a4df20bd225306f57265e81369da201c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aae5a9c7b013f647de8dd646ef49d53390d6078e846be98668874a8d0b0b80b01c99b577bea3317bc2bf170cad751024855c1e5012a20fd7ca9e0e5c42282421"} 18:27:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:35 INFO - Contents: 18:27:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4844d24d1eb2d56316751352ae1e92e6e1c1df4bac93ec71bf7d4e1de088342afbd154079f052613685bed7d824f2760d0abad23721cea23b80a12c7bdd8dc73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c820351a71240f45da84647a164c08c5bb8772f3963532cf183a1c2e3e827a12d3632cc720735b431501906ab557c18a4df20bd225306f57265e81369da201c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aae5a9c7b013f647de8dd646ef49d53390d6078e846be98668874a8d0b0b80b01c99b577bea3317bc2bf170cad751024855c1e5012a20fd7ca9e0e5c42282421"} 18:27:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:35 INFO - Copying logs to upload dir... 18:27:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.829047 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-14 18:27:35.233139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:27:35.236968) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 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/4844d24d1eb2d56316751352ae1e92e6e1c1df4bac93ec71bf7d4e1de088342afbd154079f052613685bed7d824f2760d0abad23721cea23b80a12c7bdd8dc73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c820351a71240f45da84647a164c08c5bb8772f3963532cf183a1c2e3e827a12d3632cc720735b431501906ab557c18a4df20bd225306f57265e81369da201c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aae5a9c7b013f647de8dd646ef49d53390d6078e846be98668874a8d0b0b80b01c99b577bea3317bc2bf170cad751024855c1e5012a20fd7ca9e0e5c42282421"} build_url:https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/Q1i0hytxRvO49n2Lq05SNA/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/4844d24d1eb2d56316751352ae1e92e6e1c1df4bac93ec71bf7d4e1de088342afbd154079f052613685bed7d824f2760d0abad23721cea23b80a12c7bdd8dc73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c820351a71240f45da84647a164c08c5bb8772f3963532cf183a1c2e3e827a12d3632cc720735b431501906ab557c18a4df20bd225306f57265e81369da201c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aae5a9c7b013f647de8dd646ef49d53390d6078e846be98668874a8d0b0b80b01c99b577bea3317bc2bf170cad751024855c1e5012a20fd7ca9e0e5c42282421"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 18:27:35.265150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:27:35.265475) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1465952810.382874-377836792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 18:27:35.348949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:27:35.349265) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 18:27:35.349555) ========= ========= Total master_lag: 0.18 =========