builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1466695740.73 results: success (0) buildid: 20160623053004 builduid: ec09f4010edb4e879ae2822395415733 revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:00.725717) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:00.726254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:00.726585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.074651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.075427) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 08:29:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-23 08:29:01 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.337608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.429806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.430555) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020399 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.481613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:01.482007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 08:29:01,844 truncating revision to first 12 chars 2016-06-23 08:29:01,844 Setting DEBUG logging. 2016-06-23 08:29:01,844 attempt 1/10 2016-06-23 08:29:01,844 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:29:02,241 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:02.222335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:02.222710) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:02.223167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:02.223495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:29:02.234538) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-23 08:29:02.234870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:29:02 INFO - MultiFileLogger online at 20160623 08:29:02 in /builds/slave/test 08:29:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:29:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:29:02 INFO - {'append_to_log': False, 08:29:02 INFO - 'base_work_dir': '/builds/slave/test', 08:29:02 INFO - 'blob_upload_branch': 'Fx-Team', 08:29:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:29:02 INFO - 'branch': 'Fx-Team', 08:29:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:29:02 INFO - 'config_files': ('talos/linux_config.py',), 08:29:02 INFO - 'default_actions': ('clobber', 08:29:02 INFO - 'read-buildbot-config', 08:29:02 INFO - 'download-and-extract', 08:29:02 INFO - 'populate-webroot', 08:29:02 INFO - 'create-virtualenv', 08:29:02 INFO - 'install', 08:29:02 INFO - 'run-tests'), 08:29:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:29:02 INFO - 'download_minidump_stackwalk': True, 08:29:02 INFO - 'download_symbols': 'ondemand', 08:29:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:29:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:29:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:29:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:29:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:29:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:29:02 INFO - 'installer_path': 'installer.exe', 08:29:02 INFO - 'log_level': 'info', 08:29:02 INFO - 'log_name': 'talos', 08:29:02 INFO - 'log_to_console': True, 08:29:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:29:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:29:02 INFO - 'opt_config_files': (), 08:29:02 INFO - 'pip_index': False, 08:29:02 INFO - 'sps_profile': False, 08:29:02 INFO - 'sps_profile_interval': 0, 08:29:02 INFO - 'suite': 'dromaeojs-e10s', 08:29:02 INFO - 'system_bits': '32', 08:29:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:29:02 INFO - 'title': 'talos-linux64-ix-005', 08:29:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:29:02 INFO - 'use_talos_json': True, 08:29:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:29:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:29:02 INFO - 'work_dir': 'build'} 08:29:02 INFO - ##### 08:29:02 INFO - ##### Running clobber step. 08:29:02 INFO - ##### 08:29:02 INFO - Running pre-action listener: _resource_record_pre_action 08:29:02 INFO - Running main action method: clobber 08:29:02 INFO - rmtree: /builds/slave/test/build 08:29:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:29:03 INFO - Running post-action listener: _resource_record_post_action 08:29:03 INFO - ##### 08:29:03 INFO - ##### Finished clobber step (success) 08:29:03 INFO - ##### 08:29:03 INFO - ##### 08:29:03 INFO - ##### Running read-buildbot-config step. 08:29:03 INFO - ##### 08:29:03 INFO - Running pre-action listener: _resource_record_pre_action 08:29:03 INFO - Running main action method: read_buildbot_config 08:29:03 INFO - Using buildbot properties: 08:29:03 INFO - { 08:29:03 INFO - "project": "", 08:29:03 INFO - "product": "firefox", 08:29:03 INFO - "script_repo_revision": "production", 08:29:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:29:03 INFO - "repository": "", 08:29:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:29:03 INFO - "buildid": "20160623053004", 08:29:03 INFO - "pgo_build": "True", 08:29:03 INFO - "basedir": "/builds/slave/test", 08:29:03 INFO - "buildnumber": 567, 08:29:03 INFO - "slavename": "talos-linux64-ix-005", 08:29:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:29:03 INFO - "platform": "ubuntu64_hw", 08:29:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:29:03 INFO - "branch": "fx-team", 08:29:03 INFO - "repo_path": "integration/fx-team", 08:29:03 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 08:29:03 INFO - "stage_platform": "linux64-pgo", 08:29:03 INFO - "builduid": "ec09f4010edb4e879ae2822395415733", 08:29:03 INFO - "slavebuilddir": "test" 08:29:03 INFO - } 08:29:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:29:03 INFO - Running post-action listener: _resource_record_post_action 08:29:03 INFO - ##### 08:29:03 INFO - ##### Finished read-buildbot-config step (success) 08:29:03 INFO - ##### 08:29:03 INFO - ##### 08:29:03 INFO - ##### Running download-and-extract step. 08:29:03 INFO - ##### 08:29:03 INFO - Running pre-action listener: _resource_record_pre_action 08:29:03 INFO - Running main action method: download_and_extract 08:29:03 INFO - mkdir: /builds/slave/test/build/tests 08:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:03 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:29:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:29:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:29:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:04 INFO - Downloaded 1361 bytes. 08:29:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:29:04 INFO - Using the following test package requirements: 08:29:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:29:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:29:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'jsshell-linux-x86_64.zip'], 08:29:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:29:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:29:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:29:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:29:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:29:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:29:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:29:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:29: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')]} 08:29:04 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:29:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:29:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:29:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:05 INFO - Downloaded 24276007 bytes. 08:29:05 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'] 08:29:05 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 08:29:06 INFO - Return code: 0 08:29:06 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 08:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:06 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:29:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:29:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:29:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:08 INFO - Downloaded 24276007 bytes. 08:29:08 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'] 08:29:08 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 08:29:10 INFO - Return code: 0 08:29: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')]} 08:29:10 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:29:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:29:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:11 INFO - Downloaded 14405384 bytes. 08:29:11 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'] 08:29:11 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 08:29:11 INFO - Return code: 0 08:29:11 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')]} 08:29:11 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:29:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:29:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:29:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:29:12 INFO - Downloaded 60160978 bytes. 08:29:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:29:12 INFO - mkdir: /builds/slave/test/properties 08:29:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:12 INFO - Contents: 08:29:12 INFO - build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:29:13 INFO - Running post-action listener: _resource_record_post_action 08:29:13 INFO - Running post-action listener: set_extra_try_arguments 08:29:13 INFO - ##### 08:29:13 INFO - ##### Finished download-and-extract step (success) 08:29:13 INFO - ##### 08:29:13 INFO - ##### 08:29:13 INFO - ##### Running populate-webroot step. 08:29:13 INFO - ##### 08:29:13 INFO - Running pre-action listener: _resource_record_pre_action 08:29:13 INFO - Running main action method: populate_webroot 08:29:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:13 INFO - '--tppagecycles', 08:29:13 INFO - '7'], 08:29:13 INFO - 'tests': ['tsvgm']}}, 08:29:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['damp', 'tps']}, 08:29:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'tests': ['damp', 'tps']}, 08:29:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['dromaeo_dom']}, 08:29:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['basic_compositor_video']}, 08:29:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['a11yr', 08:29:13 INFO - 'ts_paint', 08:29:13 INFO - 'tpaint', 08:29:13 INFO - 'sessionrestore', 08:29:13 INFO - 'sessionrestore_no_auto_restore', 08:29:13 INFO - 'tabpaint']}, 08:29:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['tsvgx', 08:29:13 INFO - 'tsvgr_opacity', 08:29:13 INFO - 'tart', 08:29:13 INFO - 'tscrollx', 08:29:13 INFO - 'cart']}, 08:29:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:13 INFO - 'tsvgr_opacity', 08:29:13 INFO - 'tart', 08:29:13 INFO - 'tscrollx', 08:29:13 INFO - 'cart']}, 08:29:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'talos_options': ['--disable-e10s'], 08:29:13 INFO - 'tests': ['tp5o']}, 08:29:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'tests': ['tp5o']}, 08:29:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'talos_options': ['--disable-e10s', 08:29:13 INFO - '--xperf_path', 08:29:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:13 INFO - 'tests': ['tp5n']}, 08:29:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:29:13 INFO - 'talos_options': ['--xperf_path', 08:29:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:13 INFO - 'tests': ['tp5n']}}, 08:29:13 INFO - 'talos.zip': {'path': '', 08:29:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:13 INFO - Running post-action listener: _resource_record_post_action 08:29:13 INFO - ##### 08:29:13 INFO - ##### Finished populate-webroot step (success) 08:29:13 INFO - ##### 08:29:13 INFO - ##### 08:29:13 INFO - ##### Running create-virtualenv step. 08:29:13 INFO - ##### 08:29:13 INFO - Running pre-action listener: _resource_record_pre_action 08:29:13 INFO - Running main action method: create_virtualenv 08:29:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:13 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 08:29:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:13 INFO - Using real prefix '/usr' 08:29:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:16 INFO - Installing pip.................done. 08:29:16 INFO - Return code: 0 08:29:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:16 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:16 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 08:29:16 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 08:29:16 INFO - Using env: {'DISPLAY': ':0', 08:29:16 INFO - 'HOME': '/home/cltbld', 08:29:16 INFO - 'LANG': 'en_US.UTF-8', 08:29:16 INFO - 'LANGUAGE': 'en_US:en', 08:29:16 INFO - 'LOGNAME': 'cltbld', 08:29:16 INFO - 'MAIL': '/var/mail/cltbld', 08:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:16 INFO - 'MOZ_NO_REMOTE': '1', 08:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:16 INFO - 'NO_EM_RESTART': '1', 08:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:16 INFO - 'PWD': '/builds/slave/test', 08:29:16 INFO - 'SHELL': '/bin/bash', 08:29:16 INFO - 'SHLVL': '1', 08:29:16 INFO - 'TERM': 'linux', 08:29:16 INFO - 'TMOUT': '86400', 08:29:16 INFO - 'USER': 'cltbld', 08:29:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:16 INFO - '_': '/tools/buildbot/bin/python'} 08:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:16 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 08:29:16 INFO - Cleaning up... 08:29:16 INFO - Return code: 0 08:29:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:16 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:16 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 08:29:16 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 08:29:16 INFO - Using env: {'DISPLAY': ':0', 08:29:16 INFO - 'HOME': '/home/cltbld', 08:29:16 INFO - 'LANG': 'en_US.UTF-8', 08:29:16 INFO - 'LANGUAGE': 'en_US:en', 08:29:16 INFO - 'LOGNAME': 'cltbld', 08:29:16 INFO - 'MAIL': '/var/mail/cltbld', 08:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:16 INFO - 'MOZ_NO_REMOTE': '1', 08:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:16 INFO - 'NO_EM_RESTART': '1', 08:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:16 INFO - 'PWD': '/builds/slave/test', 08:29:16 INFO - 'SHELL': '/bin/bash', 08:29:16 INFO - 'SHLVL': '1', 08:29:16 INFO - 'TERM': 'linux', 08:29:16 INFO - 'TMOUT': '86400', 08:29:16 INFO - 'USER': 'cltbld', 08:29:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:16 INFO - '_': '/tools/buildbot/bin/python'} 08:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:16 INFO - Downloading/unpacking psutil>=3.1.1 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:18 INFO - Installing collected packages: psutil 08:29:18 INFO - Running setup.py install for psutil 08:29:18 INFO - building 'psutil._psutil_linux' extension 08:29:18 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 08:29:18 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 08:29:18 INFO - building 'psutil._psutil_posix' extension 08:29:18 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 08:29:18 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 08:29:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:19 INFO - Successfully installed psutil 08:29:19 INFO - Cleaning up... 08:29:19 INFO - Return code: 0 08:29:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:19 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:19 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 08:29:19 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 08:29:19 INFO - Using env: {'DISPLAY': ':0', 08:29:19 INFO - 'HOME': '/home/cltbld', 08:29:19 INFO - 'LANG': 'en_US.UTF-8', 08:29:19 INFO - 'LANGUAGE': 'en_US:en', 08:29:19 INFO - 'LOGNAME': 'cltbld', 08:29:19 INFO - 'MAIL': '/var/mail/cltbld', 08:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:19 INFO - 'MOZ_NO_REMOTE': '1', 08:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:19 INFO - 'NO_EM_RESTART': '1', 08:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:19 INFO - 'PWD': '/builds/slave/test', 08:29:19 INFO - 'SHELL': '/bin/bash', 08:29:19 INFO - 'SHLVL': '1', 08:29:19 INFO - 'TERM': 'linux', 08:29:19 INFO - 'TMOUT': '86400', 08:29:19 INFO - 'USER': 'cltbld', 08:29:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:19 INFO - '_': '/tools/buildbot/bin/python'} 08:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:19 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 08:29:19 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 08:29:19 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 08:29:19 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 08:29:19 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 08:29:19 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 08:29:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:21 INFO - Installing collected packages: mozsystemmonitor 08:29:21 INFO - Running setup.py install for mozsystemmonitor 08:29:21 INFO - Successfully installed mozsystemmonitor 08:29:21 INFO - Cleaning up... 08:29:21 INFO - Return code: 0 08:29:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29:21 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')]} 08:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:21 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')]} 08:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:21 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:21 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 08:29:21 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 08:29:21 INFO - Using env: {'DISPLAY': ':0', 08:29:21 INFO - 'HOME': '/home/cltbld', 08:29:21 INFO - 'LANG': 'en_US.UTF-8', 08:29:21 INFO - 'LANGUAGE': 'en_US:en', 08:29:21 INFO - 'LOGNAME': 'cltbld', 08:29:21 INFO - 'MAIL': '/var/mail/cltbld', 08:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:21 INFO - 'MOZ_NO_REMOTE': '1', 08:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:21 INFO - 'NO_EM_RESTART': '1', 08:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:21 INFO - 'PWD': '/builds/slave/test', 08:29:21 INFO - 'SHELL': '/bin/bash', 08:29:21 INFO - 'SHLVL': '1', 08:29:21 INFO - 'TERM': 'linux', 08:29:21 INFO - 'TMOUT': '86400', 08:29:21 INFO - 'USER': 'cltbld', 08:29:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:21 INFO - '_': '/tools/buildbot/bin/python'} 08:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 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 08:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:23 INFO - warning: no files found matching '*.txt' 08:29:23 INFO - no previously-included directories found matching 'build' 08:29:23 INFO - no previously-included directories found matching 'dist' 08:29:23 INFO - no previously-included directories found matching '.git*' 08:29:23 INFO - Installing collected packages: jsonschema, functools32 08:29:24 INFO - Running setup.py install for functools32 08:29:24 INFO - warning: no files found matching '*.txt' 08:29:24 INFO - no previously-included directories found matching 'build' 08:29:24 INFO - no previously-included directories found matching 'dist' 08:29:24 INFO - no previously-included directories found matching '.git*' 08:29:24 INFO - Successfully installed jsonschema functools32 08:29:24 INFO - Cleaning up... 08:29:24 INFO - Return code: 0 08:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:24 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:24 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 08:29:24 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 08:29:24 INFO - Using env: {'DISPLAY': ':0', 08:29:24 INFO - 'HOME': '/home/cltbld', 08:29:24 INFO - 'LANG': 'en_US.UTF-8', 08:29:24 INFO - 'LANGUAGE': 'en_US:en', 08:29:24 INFO - 'LOGNAME': 'cltbld', 08:29:24 INFO - 'MAIL': '/var/mail/cltbld', 08:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:24 INFO - 'MOZ_NO_REMOTE': '1', 08:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:24 INFO - 'NO_EM_RESTART': '1', 08:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:24 INFO - 'PWD': '/builds/slave/test', 08:29:24 INFO - 'SHELL': '/bin/bash', 08:29:24 INFO - 'SHLVL': '1', 08:29:24 INFO - 'TERM': 'linux', 08:29:24 INFO - 'TMOUT': '86400', 08:29:24 INFO - 'USER': 'cltbld', 08:29:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:24 INFO - '_': '/tools/buildbot/bin/python'} 08:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:24 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 08:29:24 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 08:29:24 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 08:29:24 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 08:29:24 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 08:29:24 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 08:29:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:27 INFO - Downloading docopt-0.6.1.tar.gz 08:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:27 INFO - Running setup.py install for blobuploader 08:29:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:27 INFO - Running setup.py install for requests 08:29:27 INFO - Running setup.py install for docopt 08:29:27 INFO - Successfully installed blobuploader requests docopt 08:29:27 INFO - Cleaning up... 08:29:27 INFO - Return code: 0 08:29:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:27 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:27 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 08:29:27 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 08:29:27 INFO - Using env: {'DISPLAY': ':0', 08:29:27 INFO - 'HOME': '/home/cltbld', 08:29:27 INFO - 'LANG': 'en_US.UTF-8', 08:29:27 INFO - 'LANGUAGE': 'en_US:en', 08:29:27 INFO - 'LOGNAME': 'cltbld', 08:29:27 INFO - 'MAIL': '/var/mail/cltbld', 08:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:27 INFO - 'MOZ_NO_REMOTE': '1', 08:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:27 INFO - 'NO_EM_RESTART': '1', 08:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:27 INFO - 'PWD': '/builds/slave/test', 08:29:27 INFO - 'SHELL': '/bin/bash', 08:29:27 INFO - 'SHLVL': '1', 08:29:27 INFO - 'TERM': 'linux', 08:29:27 INFO - 'TMOUT': '86400', 08:29:27 INFO - 'USER': 'cltbld', 08:29:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:27 INFO - '_': '/tools/buildbot/bin/python'} 08:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:28 INFO - Running setup.py (path:/tmp/pip-d4tdsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:28 INFO - Running setup.py (path:/tmp/pip-bY0xLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:28 INFO - Running setup.py (path:/tmp/pip-hyjdOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:28 INFO - Running setup.py (path:/tmp/pip-T5_o6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:28 INFO - Running setup.py (path:/tmp/pip-qgYzDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:28 INFO - Running setup.py (path:/tmp/pip-_LGFT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:28 INFO - Running setup.py (path:/tmp/pip-qyRpbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:28 INFO - Running setup.py (path:/tmp/pip-c9wSA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:28 INFO - Running setup.py (path:/tmp/pip-F21ozV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:28 INFO - Running setup.py (path:/tmp/pip-P6k4QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:28 INFO - Running setup.py (path:/tmp/pip-OTjDmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:28 INFO - Running setup.py (path:/tmp/pip-omnhAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:28 INFO - Running setup.py (path:/tmp/pip-Bp9qD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:28 INFO - Running setup.py (path:/tmp/pip-UHgLdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:29 INFO - Running setup.py (path:/tmp/pip-wvMl9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:29 INFO - Running setup.py (path:/tmp/pip-uNQyap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:29 INFO - Running setup.py (path:/tmp/pip-IKVl9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:29 INFO - Running setup.py install for manifestparser 08:29:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:29 INFO - Running setup.py install for mozcrash 08:29:29 INFO - Running setup.py install for mozdebug 08:29:29 INFO - Running setup.py install for mozdevice 08:29:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:29 INFO - Running setup.py install for mozfile 08:29:29 INFO - Running setup.py install for mozhttpd 08:29:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:29 INFO - Running setup.py install for mozinfo 08:29:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:29 INFO - Running setup.py install for mozInstall 08:29:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Running setup.py install for mozleak 08:29:30 INFO - Running setup.py install for mozlog 08:29:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Running setup.py install for moznetwork 08:29:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Running setup.py install for mozprocess 08:29:30 INFO - Running setup.py install for mozprofile 08:29:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Running setup.py install for mozrunner 08:29:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:30 INFO - Running setup.py install for mozscreenshot 08:29:30 INFO - Running setup.py install for moztest 08:29:30 INFO - Running setup.py install for mozversion 08:29:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:31 INFO - Cleaning up... 08:29:31 INFO - Return code: 0 08:29:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:31 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:31 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 08:29:31 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 08:29:31 INFO - Using env: {'DISPLAY': ':0', 08:29:31 INFO - 'HOME': '/home/cltbld', 08:29:31 INFO - 'LANG': 'en_US.UTF-8', 08:29:31 INFO - 'LANGUAGE': 'en_US:en', 08:29:31 INFO - 'LOGNAME': 'cltbld', 08:29:31 INFO - 'MAIL': '/var/mail/cltbld', 08:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:31 INFO - 'MOZ_NO_REMOTE': '1', 08:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:31 INFO - 'NO_EM_RESTART': '1', 08:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:31 INFO - 'PWD': '/builds/slave/test', 08:29:31 INFO - 'SHELL': '/bin/bash', 08:29:31 INFO - 'SHLVL': '1', 08:29:31 INFO - 'TERM': 'linux', 08:29:31 INFO - 'TMOUT': '86400', 08:29:31 INFO - 'USER': 'cltbld', 08:29:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:31 INFO - '_': '/tools/buildbot/bin/python'} 08:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:31 INFO - Running setup.py (path:/tmp/pip-GuSVPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:31 INFO - Running setup.py (path:/tmp/pip-ICaDZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:31 INFO - Running setup.py (path:/tmp/pip-ISF9T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:31 INFO - Running setup.py (path:/tmp/pip-eujWOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:31 INFO - Running setup.py (path:/tmp/pip-ZAuvlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:31 INFO - Running setup.py (path:/tmp/pip-LE7LQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:31 INFO - Running setup.py (path:/tmp/pip-5yZKWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:31 INFO - Running setup.py (path:/tmp/pip-wpRlHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:31 INFO - Running setup.py (path:/tmp/pip-lTTfPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:31 INFO - Running setup.py (path:/tmp/pip-6ozTEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:31 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)) 08:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:31 INFO - Running setup.py (path:/tmp/pip-2vjXI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:32 INFO - Running setup.py (path:/tmp/pip-4j35Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:32 INFO - Running setup.py (path:/tmp/pip-qNWAtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:32 INFO - Running setup.py (path:/tmp/pip-SKrNBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:32 INFO - Running setup.py (path:/tmp/pip-d5HtOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:32 INFO - Running setup.py (path:/tmp/pip-w4IAUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:32 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)) 08:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:32 INFO - Running setup.py (path:/tmp/pip-EfuTeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:32 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)) 08:29:32 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)) 08:29:32 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)) 08:29:32 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)) 08:29:32 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)) 08:29:32 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)) 08:29:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:34 INFO - Downloading blessings-1.6.tar.gz 08:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:34 INFO - Installing collected packages: blessings 08:29:34 INFO - Running setup.py install for blessings 08:29:34 INFO - Successfully installed blessings 08:29:34 INFO - Cleaning up... 08:29:34 INFO - Return code: 0 08:29:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:34 INFO - Reading from file tmpfile_stdout 08:29:34 INFO - Current package versions: 08:29:34 INFO - argparse == 1.2.1 08:29:34 INFO - blessings == 1.6 08:29:34 INFO - blobuploader == 1.2.4 08:29:34 INFO - docopt == 0.6.1 08:29:34 INFO - functools32 == 3.2.3-2 08:29:34 INFO - jsonschema == 2.5.1 08:29:34 INFO - manifestparser == 1.1 08:29:34 INFO - mozInstall == 1.12 08:29:34 INFO - mozcrash == 0.17 08:29:34 INFO - mozdebug == 0.1 08:29:34 INFO - mozdevice == 0.48 08:29:34 INFO - mozfile == 1.2 08:29:34 INFO - mozhttpd == 0.7 08:29:34 INFO - mozinfo == 0.9 08:29:34 INFO - mozleak == 0.1 08:29:34 INFO - mozlog == 3.2 08:29:34 INFO - moznetwork == 0.27 08:29:34 INFO - mozprocess == 0.22 08:29:34 INFO - mozprofile == 0.28 08:29:34 INFO - mozrunner == 6.11 08:29:34 INFO - mozscreenshot == 0.1 08:29:34 INFO - mozsystemmonitor == 0.3 08:29:34 INFO - moztest == 0.7 08:29:34 INFO - mozversion == 1.4 08:29:34 INFO - psutil == 3.1.1 08:29:34 INFO - requests == 1.2.3 08:29:34 INFO - wsgiref == 0.1.2 08:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:34 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')]} 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 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')]} 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:34 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:34 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 08:29:34 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 08:29:34 INFO - Using env: {'DISPLAY': ':0', 08:29:34 INFO - 'HOME': '/home/cltbld', 08:29:34 INFO - 'LANG': 'en_US.UTF-8', 08:29:34 INFO - 'LANGUAGE': 'en_US:en', 08:29:34 INFO - 'LOGNAME': 'cltbld', 08:29:34 INFO - 'MAIL': '/var/mail/cltbld', 08:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:34 INFO - 'MOZ_NO_REMOTE': '1', 08:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:34 INFO - 'NO_EM_RESTART': '1', 08:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:34 INFO - 'PWD': '/builds/slave/test', 08:29:34 INFO - 'SHELL': '/bin/bash', 08:29:34 INFO - 'SHLVL': '1', 08:29:34 INFO - 'TERM': 'linux', 08:29:34 INFO - 'TMOUT': '86400', 08:29:34 INFO - 'USER': 'cltbld', 08:29:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:34 INFO - '_': '/tools/buildbot/bin/python'} 08:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 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)) 08:29:35 INFO - Cleaning up... 08:29:35 INFO - Return code: 0 08:29:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:35 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')]} 08:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:35 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')]} 08:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:35 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:35 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 08:29:35 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 08:29:35 INFO - Using env: {'DISPLAY': ':0', 08:29:35 INFO - 'HOME': '/home/cltbld', 08:29:35 INFO - 'LANG': 'en_US.UTF-8', 08:29:35 INFO - 'LANGUAGE': 'en_US:en', 08:29:35 INFO - 'LOGNAME': 'cltbld', 08:29:35 INFO - 'MAIL': '/var/mail/cltbld', 08:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:35 INFO - 'MOZ_NO_REMOTE': '1', 08:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:35 INFO - 'NO_EM_RESTART': '1', 08:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:35 INFO - 'PWD': '/builds/slave/test', 08:29:35 INFO - 'SHELL': '/bin/bash', 08:29:35 INFO - 'SHLVL': '1', 08:29:35 INFO - 'TERM': 'linux', 08:29:35 INFO - 'TMOUT': '86400', 08:29:35 INFO - 'USER': 'cltbld', 08:29:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:35 INFO - '_': '/tools/buildbot/bin/python'} 08:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:35 INFO - Cleaning up... 08:29:35 INFO - Return code: 0 08:29:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:29:35 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')]} 08:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:35 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')]} 08:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:35 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 0x7f54b2598f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', '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 08:29:35 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 08:29:35 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 08:29:35 INFO - Using env: {'DISPLAY': ':0', 08:29:35 INFO - 'HOME': '/home/cltbld', 08:29:35 INFO - 'LANG': 'en_US.UTF-8', 08:29:35 INFO - 'LANGUAGE': 'en_US:en', 08:29:35 INFO - 'LOGNAME': 'cltbld', 08:29:35 INFO - 'MAIL': '/var/mail/cltbld', 08:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:35 INFO - 'MOZ_NO_REMOTE': '1', 08:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:35 INFO - 'NO_EM_RESTART': '1', 08:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:35 INFO - 'PWD': '/builds/slave/test', 08:29:35 INFO - 'SHELL': '/bin/bash', 08:29:35 INFO - 'SHLVL': '1', 08:29:35 INFO - 'TERM': 'linux', 08:29:35 INFO - 'TMOUT': '86400', 08:29:35 INFO - 'USER': 'cltbld', 08:29:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:35 INFO - '_': '/tools/buildbot/bin/python'} 08:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:35 INFO - Downloading/unpacking flake8 08:29:35 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 08:29:35 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 08:29:35 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 08:29:35 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 08:29:35 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 08:29:35 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 08:29:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:29:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:29:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 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 08:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:29:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:38 INFO - no previously-included directories found matching 'docs/_build' 08:29:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:29:38 INFO - Running setup.py install for pep8 08:29:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:29:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:29:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:29:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:29:38 INFO - no previously-included directories found matching 'docs/_build' 08:29:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:29:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:29:38 INFO - Cleaning up... 08:29:38 INFO - Return code: 0 08:29:38 INFO - Running post-action listener: _resource_record_post_action 08:29:38 INFO - Running post-action listener: _start_resource_monitoring 08:29:38 INFO - Starting resource monitoring. 08:29:38 INFO - ##### 08:29:38 INFO - ##### Finished create-virtualenv step (success) 08:29:38 INFO - ##### 08:29:38 INFO - ##### 08:29:38 INFO - ##### Running install step. 08:29:38 INFO - ##### 08:29:38 INFO - Running pre-action listener: _resource_record_pre_action 08:29:38 INFO - Running main action method: install 08:29:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:38 INFO - Reading from file tmpfile_stdout 08:29:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:38 INFO - Reading from file tmpfile_stdout 08:29:38 INFO - Output received: 08:29:38 INFO - Usage: mozinstall [options] installer 08:29:38 INFO - Options: 08:29:38 INFO - -h, --help show this help message and exit 08:29:38 INFO - -d DEST, --destination=DEST 08:29:38 INFO - Directory to install application into. [default: 08:29:38 INFO - "/builds/slave/test"] 08:29:38 INFO - --app=APP Application being installed. [default: firefox] 08:29:38 INFO - mkdir: /builds/slave/test/build/application 08:29:38 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'] 08:29:38 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 08:29:55 INFO - Reading from file tmpfile_stdout 08:29:55 INFO - Output received: 08:29:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:55 INFO - Running post-action listener: _resource_record_post_action 08:29:55 INFO - ##### 08:29:55 INFO - ##### Finished install step (success) 08:29:55 INFO - ##### 08:29:55 INFO - ##### 08:29:55 INFO - ##### Running run-tests step. 08:29:55 INFO - ##### 08:29:55 INFO - Running pre-action listener: _resource_record_pre_action 08:29:55 INFO - Running main action method: run_tests 08:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:55 INFO - Python 2.7.3 08:29:55 INFO - Return code: 0 08:29:55 INFO - grabbing minidump binary from tooltool 08:29:55 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')]} 08:29:55 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 0x1cbd1c0>, '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 0x1cbe0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:55 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 08:29:55 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 08:29:55 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 08:29:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:55 INFO - Return code: 0 08:29:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:29:56 INFO - Return code: 0 08:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:29:56 INFO - Using env: {'DISPLAY': ':0', 08:29:56 INFO - 'HOME': '/home/cltbld', 08:29:56 INFO - 'LANG': 'en_US.UTF-8', 08:29:56 INFO - 'LANGUAGE': 'en_US:en', 08:29:56 INFO - 'LOGNAME': 'cltbld', 08:29:56 INFO - 'MAIL': '/var/mail/cltbld', 08:29:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:56 INFO - 'MOZ_NO_REMOTE': '1', 08:29:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:56 INFO - 'NO_EM_RESTART': '1', 08:29:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:56 INFO - 'PWD': '/builds/slave/test', 08:29:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:56 INFO - 'SHELL': '/bin/bash', 08:29:56 INFO - 'SHLVL': '1', 08:29:56 INFO - 'TERM': 'linux', 08:29:56 INFO - 'TMOUT': '86400', 08:29:56 INFO - 'USER': 'cltbld', 08:29:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667', 08:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:56 INFO - '_': '/tools/buildbot/bin/python'} 08:29:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:29:57 INFO - mozversion application_buildid: 20160623053004 08:29:57 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:29:57 INFO - mozversion application_display_name: Nightly 08:29:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:57 INFO - mozversion application_name: Firefox 08:29:57 INFO - mozversion application_remotingname: firefox 08:29:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:29:57 INFO - mozversion application_vendor: Mozilla 08:29:57 INFO - mozversion application_version: 50.0a1 08:29:57 INFO - mozversion platform_buildid: 20160623053004 08:29:57 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:29:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:29:57 INFO - mozversion platform_version: 50.0a1 08:29:57 INFO - using testdate: 1466695797 08:29:57 INFO - actual date: 1466695797 08:29:57 INFO - starting webserver on 'localhost:33160' 08:29:57 INFO - SUITE-START | Running 2 tests 08:29:57 INFO - TEST-START | dromaeo_css 08:29:57 INFO - operating with platform_type : linux_ 08:29:57 INFO - Initialising browser for dromaeo_css test... 08:29:57 INFO - TEST-INFO | started process 25778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIOwuM/profile http://localhost:33160/getInfo.html) 08:30:01 INFO - PROCESS | 25778 | __metrics Screen width/height:1600/1200 08:30:01 INFO - PROCESS | 25778 | colorDepth:24 08:30:01 INFO - PROCESS | 25778 | Browser inner width/height: 1024/697 08:30:01 INFO - PROCESS | 25778 | __metrics 08:30:02 ERROR - PROCESS | 25778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:30:03 INFO - TEST-INFO | 25778: exit 0 08:30:03 INFO - Browser initialized. 08:30:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:03 INFO - TEST-INFO | started process 25895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwIOwuM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:15 INFO - PROCESS | 25895 | RSS: Main: 185036800 08:30:15 INFO - PROCESS | 25895 | 08:31:04 INFO - PROCESS | 25895 | 1466695864682 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] 08:33:12 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33160/tests/dromaeo/cssquery-ext.html) 08:33:13 INFO - PROCESS | 25895 | RSS: Main: 189202432 08:33:13 INFO - PROCESS | 25895 | 08:36:15 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-ext.html (next: http://localhost:33160/tests/dromaeo/cssquery-jquery.html) 08:36:16 INFO - PROCESS | 25895 | RSS: Main: 188403712 08:36:16 INFO - PROCESS | 25895 | 08:39:18 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33160/tests/dromaeo/cssquery-mootools.html) 08:39:18 INFO - PROCESS | 25895 | RSS: Main: 189456384 08:39:18 INFO - PROCESS | 25895 | 08:42:20 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33160/tests/dromaeo/cssquery-prototype.html) 08:42:21 INFO - PROCESS | 25895 | RSS: Main: 187179008 08:42:21 INFO - PROCESS | 25895 | 08:45:23 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33160/tests/dromaeo/cssquery-yui.html) 08:45:24 INFO - PROCESS | 25895 | RSS: Main: 189026304 08:45:24 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | Cycle 1(1): loaded http://localhost:33160/tests/dromaeo/cssquery-yui.html (next: http://localhost:33160/tests/dromaeo/cssquery-dojo.html) 08:48:26 INFO - PROCESS | 25895 | RSS: Main: 190050304 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | __start_tp_report 08:48:26 INFO - PROCESS | 25895 | _x_x_mozilla_page_load 08:48:26 INFO - PROCESS | 25895 | _x_x_mozilla_page_load_details 08:48:26 INFO - PROCESS | 25895 | |i|pagename|runs| 08:48:26 INFO - PROCESS | 25895 | |0;dojo.html;3082.737967272782;3139.058282515245;3160.9209769755767;3164.224764932592;3182.236263296808;5299.841004769858;5376.758045887935;5400.108982017967;5438.782448702047;5462.972685136579;5233.921491177635;5309;5328.200769884519;5389.757460914258;5409.9459005409935;4762.452317983433;4790.7604619769045;4805.207140821778;4917.459079501252;4969.602431805465;4790.449098353699;4918.065567542173;4996.675216110941;5023.799048038074;5048.6465947383695;4795.760211989422;4804.615630749532;4869.561739443449;4876.171050921352;4881.633877459205;4846.61227101831;4862.465128835825;4870.172070747982;4886.169351210303;4905.386826646669;4848.951510484885;4849.709017458928;4859.951400485986;4863.610911127137;4891.144049791273;5196.76614552346;5209.1404918188455;5212.113940630102;5247.921281180786;5300.01949639318;5566.777328906839;5601.6358936668985;5609.5792815539;5613.10190369543;5616.775328986836;5574.136008918624;5670;5689.772409103631;5693.259876216107;5729.885402291972;5287.259783630295;5319.627626066177;5339.305890234284;5358.062339090644;5363.570914326844;5772.278465191851;5786.537077033827;5811.389804070512;5812.738426770806;5820.3888591698105;5424.321959755031;5581.609287349846;5582.106862901916;5585.553155747531;5603.8879222416135;5734.053881109654;5780.768769249183;5796.913046304308;5799.710014499343;5853.209816674695;5553.8333849984565;5618.719064046782;5621.5221706155435;5702.258706368229;5774.018416869142;5527.613067085346;5649.71751412436;5712.571557133231;5713.971430142906;5714.7428365723645;4359.2807186813825;4391.077873646506;4391.8682439526865;4415.602595766396;4417.160739459492;3872.206197729515;3895.902602434905;3903.1413089120347;3907.902302442405;3928.3518219494035;5266.947330526646;5412.052890744104;5417.8103766367985;5444.700541470257;5495.422980587061;5746.195532625436;5759.596828221985;5781.566382521328;5791.768329266866;5816.738246778905;5427.402985671573;5472.261244731911;5475.753591088331;5476.342838859283;5481.588880833874;4880.951190488121;4911.484294149134;4954;4970.030843985461;5014.448410674823;5845.327787304429;5845.3277873045145;5849.912251316234;5850;5851.151583020438;5689.402612725604;5691.8292451226525;5695.202671626059;5696.373398926197;5697.572682048946;5700;5752.108423194411;5792.913106303493;5831.125331200354;5868.677222752619;5552.944470555242;5560.694161821139;5566.359868615161;5570.275864137636;5576.665400076008;5549.028919939075;5591.245181900392;5646.124850648156;5647.858803529944;5660.320761508646;5379.1662292344745;5557.249771280987;5558.749856256397;5566.165075238747;5580;5515.806946756844;5520.337559492726;5520.861978450571;5555.0834112371;5583.246261754611;5475.09660905962;5491.697956612425;5494.532964698045;5495.313085864267;5518.724063796713;5465.316835395575;5542.140968149944;5607.130894711163;5656.123300888369;5675.489205971482;5517.034518959246;5535.031369510239;5535.474129957647;5537.280153580009;5552.7778888845605 08:48:26 INFO - PROCESS | 25895 | |1;ext.html;569.2656473149638;590.2356448399325;601.80742162508;616.3189675408674;634.876199141167;29741.405171896575;32367.51448728271;32853.835730821374;32976.67023329766;33005.33989320212;35971.10072248195;36338.81830590843;36435.453468198;36453.635463645354;36454;8479.618417171212;8670.263027642657;8672.392932494728;8673.566321683922;8679.045305016474;8574.528400937947;8677.045524992245;8680.956595217014;8681.696140635078;8686.86969695455;8669.393142480028;8704.608292626846;8724.214820666139;8740.606672699743;8749.825003499926;8671.176238257356;8698.304135669132;8734.995475520333;8735.95632021839;8746.125387461234;8304.418690691655;8327.084020757711;8354.498730076215;8358.122397148272;8366.498010119412;30204.24489387783;34251.143721406916;34255.31489370199;34457.13857153566;34484;2931.692172321897;2953.143588359373;2993.4611769881412;3083.337082527245;3137.466630672768;25925.870370648026;26015.869920650464;26134.085307014164;26449.73550264492;27689.67723873128;4064.329385651364;4106.187261725728;4169.082801783603;4214.2414365414215;4277.935830962538;292594;294253;294890;295604;295977;29299.853500732785;30039.849800750857;30071;30162.396752064837;30173.69826301709;31463.37073258522;31549.842250789057;31580.36839263202;31592;31630.209244768605;13210.07529472947;13356.933215333862;13456.394462249222;13506.257155856521;13516.12145210558;11518.596849110409;11617.825732614017;11632.825507617392;11641.47613357401;11649.708757280967;7453.068366454193;7457.701691932262;7533.1336896257635;7546.245375462519;7598.20218877021;2694.8383097014244;2728.863556822151;2736.3855325358136;2755.338718707496;2781.235160330885;775.2789905387931;791.1376599506566;804.1998211779317;828.2669837194127;864.6022829498376;27997.60011999392;28027.859860700974;28216.29459263535;28387.858060709565;28733.28166795847;986.8421052631544;1008.5864795433984;1025.7230547752065;1033.9247182929819;1034.5137785240925;15076.698466030617;15809.920950395175;16260.918695406448;16365.181740912907;16407.917960410123;518431;522976;524884;525357;526575;46571;47384;47387.526124739;47503.762481187376;47605.28592071122;1178.4932479034098;1191.7676053169723;1204.5121725701106;1210.098476634895;1211.2490256041488;27907.162785116478;28246.576301355086;28822.71177288284;28866.567001494575;29239.85380073086;40635.796821015705;40957.79521102375;41222.79388603038;41298.1740365185;41342.79328603458;477232;481932;484418;484476;484999;24739.134130305352;24831.25506234816;24973.250802475955;25056.62415063812;25144.74855251424;36972.07569810669;38613.22773544457;39658.2068358637;39684.801575991936;39733.80133099316;33634.66365336315;34197.487037694955;34456.65543344535;34758.65241347554;34800.129996750285;33206.335873282886;33280.16799579933;33287.66712332846;33825;33843.66156338405;30878.38243235168;33576.49635255522;33703.66296337005;37069.81465092657;37632.247355053296;31187;32424.83787581047;32453.51319730159;32745.18137046593;32795.83602081974;25384.238472845846;25442.618360724235;25691;25874.482510350063;25932 08:48:26 INFO - PROCESS | 25895 | |2;jquery.html;364.9854005839768;367.60849695074745;368.19916681218353;376.6515972725232;385.5431313893037;16115.838841611596;17316.567085822844;18285.90857045713;18318.26726930921;18369.908150459247;15395.076295422283;15873.92063039686;16208.83791162088;16250;16278.26747796349;5382.8923421531545;5569.359523654771;5636.323641163066;5650.26546548948;5656.151577263402;4009.2582872168596;5413.26920865684;5856.238688970449;6229.750809967596;6247.375262473739;6191;6223.5332350073695;6224.439800417961;6250.062490626419;6271.15339429178;6074.848128796772;6244.344343843876;6251.468625166866;6253.218347706536;6278.121063051177;5509.311336082989;5529.336479622471;5548.722563871831;6522.77170299042;6951.061606683134;24290.635640465407;24298.392540186636;24694.5061098777;24748.25755227328;24769;2273.7498875123724;2327.8254130940077;2330.0330362899376;2483.453640199153;2538.4796116796015;15065.945383823137;15087.849121508754;15139.621509462242;15152.545423637308;15712.685746285124;1942.2522328903333;1981.8612697111207;2035.3486884197064;2111.0711287033655;2117.841161912863;96314;97711.51144244305;98210.99999999929;100514;101075.49462252716;16128.75806862898;16345;16615.833841661428;16698.749518757228;16715.91642041782;28634.570481442377;28640.427191456056;28734;28981.42037159287;28994.27514312117;8698.391112622183;9235.584398702074;9286.72139835806;9435.622575096919;9458.817647794025;7620.390368770485;7649.9617501912135;7704.499207551491;7717.498362606412;7819.921800781919;7955.5624440655165;8117.715879944174;8121.837563248702;8177.550234737147;8271.67653175489;1434.5409468969829;1478.645125169973;1504.593759684879;1545.4127431576153;3223.435898717715;795.7572940253278;810.9918900811034;812.9918700812916;834.5034704350901;876.1370050500252;17299.481015569552;17550.210240539207;17675.823241767674;18197.818021819876;18257.81742182561;870.8040690844635;875.7591662292793;894.4856707393145;915.5285028210477;933.9912894074383;9897.60409583623;9960.452175130438;10136.442495662663;10197.796044079078;10255;539103;543466;549098;556925;558571;94767.52616236874;97668;97684.02315976891;97903.51048244713;98152;887.2015186332223;912;923.5059243304934;927.967521136757;937.1752857485506;16506;16558.172091395623;16629.168541573115;16776.483019168812;16880.324787008383;42033.528826490925;42431.15137697167;43118.13763724645;43741.56258437375;44516;60486.39513604984;60682.08976865439;62157;62407.37592624016;62870.68564657147;7853.882191767242;8095.595220238847;8315.293200078062;8391.58042097905;8412.579371031301;9077.409968352036;11804.40977951082;12233;13008.21950682962;13377;11550.249233799776;11614.5354185835;11653.825192622287;11897.762044759229;11904.821427678418;11692.70768230767;11755.412229388325;11922.403879806148;12002.459889304828;12060.457279422271;11887.643370698894;11892.76214475723;12006.159568830099;12033.518659253532;12267.509299627915;8109.59452027408;8246.216609422096;8275.08974012846;8332.791680208044;8354.87467687973;8323.35032919172;11770.705732356759;11800.527978881091;11911.52353905834;12053.397330133634 08:48:26 INFO - PROCESS | 25895 | |3;mootools.html;1161.8199179127237;1173.7183076061742;1194.3132698698248;1357.3688234970743;1407.669197738532;7272.127344718628;8004.599770011498;8032.638531266092;8591.527465989377;8637.179467950542;8165.91834081659;8426.199511046456;8442.155784421555;8464.449810762297;8480.872786908201;2236.0720301075035;2258.2322010516423;2275.8179345652306;2277.3281881844814;2282.0073268128335;2208.7791220877943;2240.2383189715492;2262.875541845198;2270;2271.1256166375897;2223.444138965259;2232.2521955145044;2232.9106835726634;2244.5959727249087;2247.8538894971857;2221.9000144993515;2222.511047569532;2225.94435139122;2226.510167763098;2237.3847192022163;2187.803097721197;2207.5253820428684;2209.0832304593573;2212.7344718633867;2212.8451008429415;8348.081711011784;8424.578771061484;8431.957840210822;8466.026406963216;8525.957370213171;4825.10735513931;4994.026164897847;5012.498750124958;5022.748862556894;5033.421156567005;3120.422721796452;3215.5980502437196;3249.431349513826;3266.183454136466;3321.8173000484962;1068.1294744782977;1075.639660713662;1080.4597701149426;1084.7559299157706;1085.6634443322596;11376.431178441046;11752.529898804038;11781.352025638587;11967.64097077089;11989.22070065443;4129;4175.415441838145;4248.086661367821;4253.2769429197115;4285.228658841438;8976.8653470198;8977.416467929565;8998.64005439775;9022.368434209542;9072.773180670536;4810.95189048105;4876.853694389174;4894.559489645949;4898.093852637274;4905.779239934212;3822.7897465639103;4399.890002749957;4508.639308855284;4579.542045795394;4617.3074038893765;3369.275605744777;3428.5371474850576;3463.480477928331;3493.7729047611824;3568.286342731464;1089.145021158387;1092.983605245922;1105.2318638546133;1105.8175401058895;1119.1326721790515;674.8043067510465;820.9081921044996;878.1043335797578;893.1202765276198;901.2204443156753;5799.797007104731;5895.64626122434;5896.734646940898;5907.1434641976675;6099.573029887954;820.5527987246965;862.4820316243331;871.4466313890598;902.4765635931144;903.5482258870564;3751.3247615429486;3809.676177524886;3883.184531248413;3987.142764305688;4027.395890616431;9859.753506162404;9937.552810123418;9956.502174891226;9961.950190249003;10079.9496002521;9819.36174148678;9892.950535247277;9986.900130998742;10415.16678665705;10430.113440357503;7599.810004749926;7692.538447693044;7768.300852923151;7789.454738168387;7894.131645518988;5526.889462210814;5786.594938354443;5787.276590426197;5884.676342801187;5954.791582294599;9580.56887440053;9710.223182145553;9805.558749856416;9839.901600983898;9892.653757118467;9849.261305402268;9870.851937220803;9907.900920990698;9970.950145249228;10028.147607453448;6608.603483790988;7216.8917466237;7257.782266532013;7397.741079062207;7526.774196774106;8123.593820309079;8141.470804397695;8142.67429302845;8224.958875205586;8268.710595129141;7204.423646108404;7323.9267607323245;7370.189279179179;7426.368758655359;7499.625018748931;6991.895121573282;7093.751718689821;7186.6047367395295;7282.235365286569;7294.781156565312;6666.26671066192;6706.865862682816;6713.127293452016;6723.663816809042;6726.8654626908165;4920.901581968269;4988.5260900214425;4994.350734404504;5020.397552293748;5106.7446627669215;5074.416442109205;5118.283440318284;5186.066508028591;5201.973990130025;5217 08:48:26 INFO - PROCESS | 25895 | |4;prototype.html;292.28682015881236;301.90188188838636;303.7934204740776;304.50061898486473;309.48470796124457;5402.270693456382;5475.589330800196;5659.236003139575;5701.629394089381;5714.942735593912;5532.502074813266;5570.359408668004;5571.4428557144265;5575.358833734122;5582.637128586639;4273.551277115905;4274.230638485072;4282.635975942041;4290.292101803198;4295.52749197588;4152.190322887038;4309.676774241929;4312.374705667692;4314.741115533078;4332.436783218177;4248.851290204843;4257.787110644455;4266.381374700666;4279.609127033711;4303.8063287152;4299.462567179103;4299.763513006767;4310.159518893817;4314.590113939171;4326.8269269229195;3683.4106542953;3786.7917264550438;3797.7531460455257;3803.2013277211818;3812.80935953204;5420.972895135538;5439.456054394568;5442.455754424565;5460.890782184334;5475.0966090595;4903.607711383116;4921.286413470062;4925.408950925876;4932.53140951609;4938.135826230396;5637.943620563783;5831.766729330821;5863.120531920204;5875.500582450497;5890.676012819294;4126.442930204414;4130.669546436308;4148.108156746284;4150.439690641755;4155.812988415529;6054.848628784272;6055.848603784896;6073.1497590337385;6096.451319381233;6120.663363515005;3898.9805050975133;4127.2570937231585;4191.7484950903045;4231.449911511484;4260.914781704349;4107.630313271819;4122.752634841919;4143.399207115011;4149.128682976609;4156.9792151039055;4826.58973987215;4832.710037397767;4851.272309153655;4859.611231101503;4887.218045112765;5328.280682107943;5889.764409423575;5989.940100599026;5999.9100013498955;6007.429294217042;1391.2053451048034;1406.374163497234;1410.379433049455;1418.4113592858848;1420.8650178233052;859.6475445067492;882.9404714342814;888.5201990924828;900.5767289373983;902.278177458031;4984.601231901439;5004.649674522749;5014.07239660664;5034.823781167642;5093.567046800989;5286.805975520193;5298.629095963245;5315;5317.308749862493;5339.919901201485;4728.976355118271;5053.772580233898;5110.642255042111;5123.87190320245;5136.844210052708;2821.7742580593504;2891.7831162662883;2892.4648939945755;2903.0114371655063;2903.535434330497;5358.946410535845;5498.257735205696;5498.890022199534;5528.55771538276;5556.777728890799;5316.787328506894;5414.105063227838;5443.727813609304;5469.945300547023;5471.4528547145765;5475.342958844964;5494.670319780746;5501.624593851537;5510.779568817283;5547.643675576218;5252.632315737862;5256.185291279858;5310.8141215057285;5343.9198412024625;5367.275417818701;5582.972085139549;6030.396960303934;6068.666223357758;6085.208922840003;6108;6295.779647712308;6313.800377928179;6317.431431171217;6368.331325210786;6369.617822930639;4074.4295798588814;4121.319982202903;4142.79286035691;4184.870085077073;4189.97905010473;5836.212111364912;5939.227900372924;6226.906596401148;6232;6232.75068997235;5920.3062606514795;5935.673537955454;5939.881202375842;5958.497431079044;5982.162497250475;5884.676342801187;5886.705664716833;5888.970555147197;5951.434613711691;5955.523558115254;5634.380218176079;5713.228714123707;5806.506446952057;5847.158145184253;5855.560832937462;5898.587098903035;5947.672877991752;5977.760889564369;6004.889095517343;6029.668368239789;5621.943780562142;5844.649321040752;5869.765209391577;5876.26856945851;5930.970345148246 08:48:26 INFO - PROCESS | 25895 | |5;yui.html;574.5834270154139;579.736220019891;602.1269159718407;625.9687015649217;626.3423405424303;13448.327583620816;14456.20490873003;14496.63758406039;14649.780253296209;15095.924520377383;14170.858291417082;14265.643358916006;14266.714665706706;14351.28243587819;14354.784678229835;582.0628787651877;591.1664552980299;595.9135925290831;602.6745557399021;604.2265899648457;594.049520766774;597.4354235247692;599.1791245992974;599.733118762151;600.372610621899;621.0125899819286;621.0683974038942;626.3767551286477;626.3923993726079;627.2817623820722;623.2863371439698;624.8125562331282;626.2141013028665;626.8746250749869;627.8179327994899;449.65152007194683;450.9368688383629;452.0506935435592;453.6212262760599;454.3366684640429;13207.207567545978;13255.337233138305;13261.734765304736;13279.336033198302;13336.133151345131;12591.937040314831;13014.674633134153;13101.803472947913;13241.867581324159;13401;11267.098632109411;11580.247283926603;11595.304281743123;11615;11642.941785291105;3757.210985693008;3793.2223894101644;3806.923861522782;3823.847046118152;3921.19615478829;80054.59972700158;80502;81141.18858811396;81151;81901.59049204775;9681.66114186;10086.697399078039;10165.898341016644;10203.897961020442;10245.897541024644;17130.571735706708;17180.22688978999;17189.398371056952;17416.129193540273;17534.736978945326;7685.884711729329;7695.307422332017;7701.422393320523;7713.190115037953;7784.2994130527395;4476.320265793978;4593.150267200579;4630.81914111906;4736.692115012514;4778.689385189951;3110.1136176189675;3215.839208039589;3224.3228921926657;3230.6930841570015;3232.4181647303712;535.74552087758;546.5163330452499;547.9342478902557;555.2559570175903;556.8607848037991;546.2870953405765;566.7138095261867;573.3807487913044;620.3238470067648;670.3196255800367;8572.571371431404;9036.45781253127;9057.230135438429;9092.8636070459;9201.515590790583;628.8553632664513;632.6583644831832;636.153747064476;640.9839754006094;655.7180412422704;4356.760378179167;4413.183561041217;4447.288433850633;4452.30989196675;4455.26488129455;111625;117947;118332;120861;123922;89399;89459.55270223737;91825.54087229521;101675;101712;56604.15093773515;57371;62357;69078.3092169082;88293;9419.481928493999;9484.857727134236;9520.428774273565;9760.85358719634;9842.803143937224;51049;51121.233181501564;52460.213096802814;52494.21258681199;53003.20495192498;69016.65491672509;75643.62178189073;76521;78280;79107.20892790999;11435.142364322543;11695;11706.473208705458;11799.82300265514;12120.03039756835;13575.913926885627;13805.930970345084;13833.792493112813;13895.096818706752;14032.158070515394;12970.935145324212;13227.735445290848;13241.404136813673;13435.596932092052;13597.728045439233;12642.747145057232;12735.55425560101;13023.479060837839;13046;13301.66745831362;13000;13076.934615326862;13081.411336490071;13087.214767114003;13173.341332933507;10270.383776973405;10426.42654653971;10724.702491863618;10872.945635271773;10943.726406839893;10812.189085818753;11120;11283.210175287652;11288.153388495732;11295 08:48:26 INFO - PROCESS | 25895 | __end_tp_report 08:48:26 INFO - PROCESS | 25895 | __start_cc_report 08:48:26 INFO - PROCESS | 25895 | _x_x_mozilla_cycle_collect,354 08:48:26 INFO - PROCESS | 25895 | __end_cc_report 08:48:26 INFO - PROCESS | 25895 | __startTimestamp1466696906616__endTimestamp 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | ------- Summary: start ------- 08:48:26 INFO - PROCESS | 25895 | Number of tests: 6 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#0] dojo.html Cycles:165 Average:5292.97 Median:5515.81 stddev:579.09 (10.5%) stddev-sans-first:554.30 08:48:26 INFO - PROCESS | 25895 | Values: 3082.7 3139.1 3160.9 3164.2 3182.2 5299.8 5376.8 5400.1 5438.8 5463.0 5233.9 5309.0 5328.2 5389.8 5409.9 4762.5 4790.8 4805.2 4917.5 4969.6 4790.4 4918.1 4996.7 5023.8 5048.6 4795.8 4804.6 4869.6 4876.2 4881.6 4846.6 4862.5 4870.2 4886.2 4905.4 4849.0 4849.7 4860.0 4863.6 4891.1 5196.8 5209.1 5212.1 5247.9 5300.0 5566.8 5601.6 5609.6 5613.1 5616.8 5574.1 5670.0 5689.8 5693.3 5729.9 5287.3 5319.6 5339.3 5358.1 5363.6 5772.3 5786.5 5811.4 5812.7 5820.4 5424.3 5581.6 5582.1 5585.6 5603.9 5734.1 5780.8 5796.9 5799.7 5853.2 5553.8 5618.7 5621.5 5702.3 5774.0 5527.6 5649.7 5712.6 5714.0 5714.7 4359.3 4391.1 4391.9 4415.6 4417.2 3872.2 3895.9 3903.1 3907.9 3928.4 5266.9 5412.1 5417.8 5444.7 5495.4 5746.2 5759.6 5781.6 5791.8 5816.7 5427.4 5472.3 5475.8 5476.3 5481.6 4881.0 4911.5 4954.0 4970.0 5014.4 5845.3 5845.3 5849.9 5850.0 5851.2 5689.4 5691.8 5695.2 5696.4 5697.6 5700.0 5752.1 5792.9 5831.1 5868.7 5552.9 5560.7 5566.4 5570.3 5576.7 5549.0 5591.2 5646.1 5647.9 5660.3 5379.2 5557.2 5558.7 5566.2 5580.0 5515.8 5520.3 5520.9 5555.1 5583.2 5475.1 5491.7 5494.5 5495.3 5518.7 5465.3 5542.1 5607.1 5656.1 5675.5 5517.0 5535.0 5535.5 5537.3 5552.8 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#1] ext.html Cycles:180 Average:54601.31 Median:33669.16 stddev:118961.93 (353.3%) stddev-sans-first:119226.48 08:48:26 INFO - PROCESS | 25895 | Values: 569.3 590.2 601.8 616.3 634.9 29741.4 32367.5 32853.8 32976.7 33005.3 35971.1 36338.8 36435.5 36453.6 36454.0 8479.6 8670.3 8672.4 8673.6 8679.0 8574.5 8677.0 8681.0 8681.7 8686.9 8669.4 8704.6 8724.2 8740.6 8749.8 8671.2 8698.3 8735.0 8736.0 8746.1 8304.4 8327.1 8354.5 8358.1 8366.5 30204.2 34251.1 34255.3 34457.1 34484.0 2931.7 2953.1 2993.5 3083.3 3137.5 25925.9 26015.9 26134.1 26449.7 27689.7 4064.3 4106.2 4169.1 4214.2 4277.9 292594.0 294253.0 294890.0 295604.0 295977.0 29299.9 30039.8 30071.0 30162.4 30173.7 31463.4 31549.8 31580.4 31592.0 31630.2 13210.1 13356.9 13456.4 13506.3 13516.1 11518.6 11617.8 11632.8 11641.5 11649.7 7453.1 7457.7 7533.1 7546.2 7598.2 2694.8 2728.9 2736.4 2755.3 2781.2 775.3 791.1 804.2 828.3 864.6 27997.6 28027.9 28216.3 28387.9 28733.3 986.8 1008.6 1025.7 1033.9 1034.5 15076.7 15809.9 16260.9 16365.2 16407.9 518431.0 522976.0 524884.0 525357.0 526575.0 46571.0 47384.0 47387.5 47503.8 47605.3 1178.5 1191.8 1204.5 1210.1 1211.2 27907.2 28246.6 28822.7 28866.6 29239.9 40635.8 40957.8 41222.8 41298.2 41342.8 477232.0 481932.0 484418.0 484476.0 484999.0 24739.1 24831.3 24973.3 25056.6 25144.7 36972.1 38613.2 39658.2 39684.8 39733.8 33634.7 34197.5 34456.7 34758.7 34800.1 33206.3 33280.2 33287.7 33825.0 33843.7 30878.4 33576.5 33703.7 37069.8 37632.2 31187.0 32424.8 32453.5 32745.2 32795.8 25384.2 25442.6 25691.0 25874.5 25932.0 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#2] jquery.html Cycles:180 Average:32021.02 Median:42774.64 stddev:90674.85 (212.0%) stddev-sans-first:90898.06 08:48:26 INFO - PROCESS | 25895 | Values: 365.0 367.6 368.2 376.7 385.5 16115.8 17316.6 18285.9 18318.3 18369.9 15395.1 15873.9 16208.8 16250.0 16278.3 5382.9 5569.4 5636.3 5650.3 5656.2 4009.3 5413.3 5856.2 6229.8 6247.4 6191.0 6223.5 6224.4 6250.1 6271.2 6074.8 6244.3 6251.5 6253.2 6278.1 5509.3 5529.3 5548.7 6522.8 6951.1 24290.6 24298.4 24694.5 24748.3 24769.0 2273.7 2327.8 2330.0 2483.5 2538.5 15065.9 15087.8 15139.6 15152.5 15712.7 1942.3 1981.9 2035.3 2111.1 2117.8 96314.0 97711.5 98211.0 100514.0 101075.5 16128.8 16345.0 16615.8 16698.7 16715.9 28634.6 28640.4 28734.0 28981.4 28994.3 8698.4 9235.6 9286.7 9435.6 9458.8 7620.4 7650.0 7704.5 7717.5 7819.9 7955.6 8117.7 8121.8 8177.6 8271.7 1434.5 1478.6 1504.6 1545.4 3223.4 795.8 811.0 813.0 834.5 876.1 17299.5 17550.2 17675.8 18197.8 18257.8 870.8 875.8 894.5 915.5 934.0 9897.6 9960.5 10136.4 10197.8 10255.0 539103.0 543466.0 549098.0 556925.0 558571.0 94767.5 97668.0 97684.0 97903.5 98152.0 887.2 912.0 923.5 928.0 937.2 16506.0 16558.2 16629.2 16776.5 16880.3 42033.5 42431.2 43118.1 43741.6 44516.0 60486.4 60682.1 62157.0 62407.4 62870.7 7853.9 8095.6 8315.3 8391.6 8412.6 9077.4 11804.4 12233.0 13008.2 13377.0 11550.2 11614.5 11653.8 11897.8 11904.8 11692.7 11755.4 11922.4 12002.5 12060.5 11887.6 11892.8 12006.2 12033.5 12267.5 8109.6 8246.2 8275.1 8332.8 8354.9 8323.4 11770.7 11800.5 11911.5 12053.4 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#3] mootools.html Cycles:180 Average:5475.36 Median:5152.17 stddev:3114.56 (60.5%) stddev-sans-first:3106.42 08:48:26 INFO - PROCESS | 25895 | Values: 1161.8 1173.7 1194.3 1357.4 1407.7 7272.1 8004.6 8032.6 8591.5 8637.2 8165.9 8426.2 8442.2 8464.4 8480.9 2236.1 2258.2 2275.8 2277.3 2282.0 2208.8 2240.2 2262.9 2270.0 2271.1 2223.4 2232.3 2232.9 2244.6 2247.9 2221.9 2222.5 2225.9 2226.5 2237.4 2187.8 2207.5 2209.1 2212.7 2212.8 8348.1 8424.6 8432.0 8466.0 8526.0 4825.1 4994.0 5012.5 5022.7 5033.4 3120.4 3215.6 3249.4 3266.2 3321.8 1068.1 1075.6 1080.5 1084.8 1085.7 11376.4 11752.5 11781.4 11967.6 11989.2 4129.0 4175.4 4248.1 4253.3 4285.2 8976.9 8977.4 8998.6 9022.4 9072.8 4811.0 4876.9 4894.6 4898.1 4905.8 3822.8 4399.9 4508.6 4579.5 4617.3 3369.3 3428.5 3463.5 3493.8 3568.3 1089.1 1093.0 1105.2 1105.8 1119.1 674.8 820.9 878.1 893.1 901.2 5799.8 5895.6 5896.7 5907.1 6099.6 820.6 862.5 871.4 902.5 903.5 3751.3 3809.7 3883.2 3987.1 4027.4 9859.8 9937.6 9956.5 9962.0 10079.9 9819.4 9893.0 9986.9 10415.2 10430.1 7599.8 7692.5 7768.3 7789.5 7894.1 5526.9 5786.6 5787.3 5884.7 5954.8 9580.6 9710.2 9805.6 9839.9 9892.7 9849.3 9870.9 9907.9 9971.0 10028.1 6608.6 7216.9 7257.8 7397.7 7526.8 8123.6 8141.5 8142.7 8225.0 8268.7 7204.4 7323.9 7370.2 7426.4 7499.6 6991.9 7093.8 7186.6 7282.2 7294.8 6666.3 6706.9 6713.1 6723.7 6726.9 4920.9 4988.5 4994.4 5020.4 5106.7 5074.4 5118.3 5186.1 5202.0 5217.0 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#4] prototype.html Cycles:180 Average:4778.33 Median:5351.43 stddev:1433.05 (26.8%) stddev-sans-first:1396.95 08:48:26 INFO - PROCESS | 25895 | Values: 292.3 301.9 303.8 304.5 309.5 5402.3 5475.6 5659.2 5701.6 5714.9 5532.5 5570.4 5571.4 5575.4 5582.6 4273.6 4274.2 4282.6 4290.3 4295.5 4152.2 4309.7 4312.4 4314.7 4332.4 4248.9 4257.8 4266.4 4279.6 4303.8 4299.5 4299.8 4310.2 4314.6 4326.8 3683.4 3786.8 3797.8 3803.2 3812.8 5421.0 5439.5 5442.5 5460.9 5475.1 4903.6 4921.3 4925.4 4932.5 4938.1 5637.9 5831.8 5863.1 5875.5 5890.7 4126.4 4130.7 4148.1 4150.4 4155.8 6054.8 6055.8 6073.1 6096.5 6120.7 3899.0 4127.3 4191.7 4231.4 4260.9 4107.6 4122.8 4143.4 4149.1 4157.0 4826.6 4832.7 4851.3 4859.6 4887.2 5328.3 5889.8 5989.9 5999.9 6007.4 1391.2 1406.4 1410.4 1418.4 1420.9 859.6 882.9 888.5 900.6 902.3 4984.6 5004.6 5014.1 5034.8 5093.6 5286.8 5298.6 5315.0 5317.3 5339.9 4729.0 5053.8 5110.6 5123.9 5136.8 2821.8 2891.8 2892.5 2903.0 2903.5 5358.9 5498.3 5498.9 5528.6 5556.8 5316.8 5414.1 5443.7 5469.9 5471.5 5475.3 5494.7 5501.6 5510.8 5547.6 5252.6 5256.2 5310.8 5343.9 5367.3 5583.0 6030.4 6068.7 6085.2 6108.0 6295.8 6313.8 6317.4 6368.3 6369.6 4074.4 4121.3 4142.8 4184.9 4190.0 5836.2 5939.2 6226.9 6232.0 6232.8 5920.3 5935.7 5939.9 5958.5 5982.2 5884.7 5886.7 5889.0 5951.4 5955.5 5634.4 5713.2 5806.5 5847.2 5855.6 5898.6 5947.7 5977.8 6004.9 6029.7 5621.9 5844.6 5869.8 5876.3 5931.0 08:48:26 INFO - PROCESS | 25895 | 08:48:26 INFO - PROCESS | 25895 | [#5] yui.html Cycles:180 Average:19920.53 Median:4465.79 stddev:29463.66 (659.8%) stddev-sans-first:29510.50 08:48:26 INFO - PROCESS | 25895 | Values: 574.6 579.7 602.1 626.0 626.3 13448.3 14456.2 14496.6 14649.8 15095.9 14170.9 14265.6 14266.7 14351.3 14354.8 582.1 591.2 595.9 602.7 604.2 594.0 597.4 599.2 599.7 600.4 621.0 621.1 626.4 626.4 627.3 623.3 624.8 626.2 626.9 627.8 449.7 450.9 452.1 453.6 454.3 13207.2 13255.3 13261.7 13279.3 13336.1 12591.9 13014.7 13101.8 13241.9 13401.0 11267.1 11580.2 11595.3 11615.0 11642.9 3757.2 3793.2 3806.9 3823.8 3921.2 80054.6 80502.0 81141.2 81151.0 81901.6 9681.7 10086.7 10165.9 10203.9 10245.9 17130.6 17180.2 17189.4 17416.1 17534.7 7685.9 7695.3 7701.4 7713.2 7784.3 4476.3 4593.2 4630.8 4736.7 4778.7 3110.1 3215.8 3224.3 3230.7 3232.4 535.7 546.5 547.9 555.3 556.9 546.3 566.7 573.4 620.3 670.3 8572.6 9036.5 9057.2 9092.9 9201.5 628.9 632.7 636.2 641.0 655.7 4356.8 4413.2 4447.3 4452.3 4455.3 111625.0 117947.0 118332.0 120861.0 123922.0 89399.0 89459.6 91825.5 101675.0 101712.0 56604.2 57371.0 62357.0 69078.3 88293.0 9419.5 9484.9 9520.4 9760.9 9842.8 51049.0 51121.2 52460.2 52494.2 53003.2 69016.7 75643.6 76521.0 78280.0 79107.2 11435.1 11695.0 11706.5 11799.8 12120.0 13575.9 13805.9 13833.8 13895.1 14032.2 12970.9 13227.7 13241.4 13435.6 13597.7 12642.7 12735.6 13023.5 13046.0 13301.7 13000.0 13076.9 13081.4 13087.2 13173.3 10270.4 10426.4 10724.7 10872.9 10943.7 10812.2 11120.0 11283.2 11288.2 11295.0 08:48:26 INFO - PROCESS | 25895 | -------- Summary: end -------- 08:48:26 INFO - PROCESS | 25895 | 08:48:27 INFO - TEST-INFO | 25895: exit 0 08:48:27 INFO - TEST-OK | dromaeo_css | took 1110304ms 08:48:27 INFO - TEST-START | kraken 08:48:27 INFO - operating with platform_type : linux_ 08:48:27 INFO - Initialising browser for kraken test... 08:48:27 INFO - TEST-INFO | started process 26128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvt7oq/profile http://localhost:33160/getInfo.html) 08:48:31 INFO - PROCESS | 26128 | __metrics Screen width/height:1600/1200 08:48:31 INFO - PROCESS | 26128 | colorDepth:24 08:48:31 INFO - PROCESS | 26128 | Browser inner width/height: 1024/697 08:48:31 INFO - PROCESS | 26128 | __metrics 08:48:32 ERROR - PROCESS | 26128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:48:33 INFO - TEST-INFO | 26128: exit 0 08:48:33 INFO - Browser initialized. 08:48:33 INFO - Running cycle 1/1 for kraken test... 08:48:33 INFO - TEST-INFO | started process 26248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvt7oq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:45 INFO - PROCESS | 26248 | RSS: Main: 185331712 08:48:45 INFO - PROCESS | 26248 | 08:48:47 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33160/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:48 INFO - PROCESS | 26248 | RSS: Main: 190963712 08:48:48 INFO - PROCESS | 26248 | 08:48:51 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33160/tests/kraken/driver.html?testName=audio-dft) 08:48:51 INFO - PROCESS | 26248 | RSS: Main: 190099456 08:48:51 INFO - PROCESS | 26248 | 08:48:54 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33160/tests/kraken/driver.html?testName=audio-fft) 08:48:55 INFO - PROCESS | 26248 | RSS: Main: 185098240 08:48:55 INFO - PROCESS | 26248 | 08:48:57 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33160/tests/kraken/driver.html?testName=audio-oscillator) 08:48:58 INFO - PROCESS | 26248 | RSS: Main: 185696256 08:48:58 INFO - PROCESS | 26248 | 08:49:00 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:01 INFO - PROCESS | 26248 | RSS: Main: 185864192 08:49:01 INFO - PROCESS | 26248 | 08:49:04 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33160/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:04 INFO - PROCESS | 26248 | RSS: Main: 186613760 08:49:04 INFO - PROCESS | 26248 | 08:49:08 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33160/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:09 INFO - PROCESS | 26248 | RSS: Main: 183820288 08:49:09 INFO - PROCESS | 26248 | 08:49:11 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33160/tests/kraken/driver.html?testName=json-parse-financial) 08:49:12 INFO - PROCESS | 26248 | RSS: Main: 185950208 08:49:12 INFO - PROCESS | 26248 | 08:49:14 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:14 INFO - PROCESS | 26248 | RSS: Main: 185991168 08:49:14 INFO - PROCESS | 26248 | 08:49:16 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:17 INFO - PROCESS | 26248 | RSS: Main: 186077184 08:49:17 INFO - PROCESS | 26248 | 08:49:19 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:19 INFO - PROCESS | 26248 | RSS: Main: 186126336 08:49:19 INFO - PROCESS | 26248 | 08:49:22 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:23 INFO - PROCESS | 26248 | RSS: Main: 186630144 08:49:23 INFO - PROCESS | 26248 | 08:49:25 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:26 INFO - PROCESS | 26248 | RSS: Main: 186155008 08:49:26 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | Cycle 1(1): loaded http://localhost:33160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33160/tests/kraken/driver.html?testName=ai-astar) 08:49:28 INFO - PROCESS | 26248 | RSS: Main: 187371520 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | __start_tp_report 08:49:28 INFO - PROCESS | 26248 | _x_x_mozilla_page_load 08:49:28 INFO - PROCESS | 26248 | _x_x_mozilla_page_load_details 08:49:28 INFO - PROCESS | 26248 | |i|pagename|runs| 08:49:28 INFO - PROCESS | 26248 | |0;ai-astar;101;109;108;110;111;111;112;111;111;111 08:49:28 INFO - PROCESS | 26248 | |1;audio-beat-detection;165;131;156;181;140;161;156;128;188;128 08:49:28 INFO - PROCESS | 26248 | |2;audio-dft;163;161;163;163;165;175;163;166;163;163 08:49:28 INFO - PROCESS | 26248 | |3;audio-fft;76;76;76;161;77;76;74;77;170;76 08:49:28 INFO - PROCESS | 26248 | |4;audio-oscillator;85;86;136;84;84;85;140;85;85;160 08:49:28 INFO - PROCESS | 26248 | |5;imaging-gaussian-blur;117;117;119;118;118;118;118;117;118;117 08:49:28 INFO - PROCESS | 26248 | |6;imaging-darkroom;147;148;155;150;148;148;149;146;148;147 08:49:28 INFO - PROCESS | 26248 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 08:49:28 INFO - PROCESS | 26248 | |8;json-parse-financial;58;56;56;55;57;54;56;55;55;54 08:49:28 INFO - PROCESS | 26248 | |9;json-stringify-tinderbox;62;63;62;62;62;61;62;62;62;64 08:49:28 INFO - PROCESS | 26248 | |10;stanford-crypto-aes;84;80;78;81;79;81;80;81;90;86 08:49:28 INFO - PROCESS | 26248 | |11;stanford-crypto-ccm;130;125;127;121;128;147;122;122;137;127 08:49:28 INFO - PROCESS | 26248 | |12;stanford-crypto-pbkdf2;168;165;163;159;160;158;160;157;161;162 08:49:28 INFO - PROCESS | 26248 | |13;stanford-crypto-sha256-iterative;62;63;65;63;66;64;62;63;64;62 08:49:28 INFO - PROCESS | 26248 | __end_tp_report 08:49:28 INFO - PROCESS | 26248 | __start_cc_report 08:49:28 INFO - PROCESS | 26248 | _x_x_mozilla_cycle_collect,885 08:49:28 INFO - PROCESS | 26248 | __end_cc_report 08:49:28 INFO - PROCESS | 26248 | __startTimestamp1466696968414__endTimestamp 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | ------- Summary: start ------- 08:49:28 INFO - PROCESS | 26248 | Number of tests: 14 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.21 (2.9%) stddev-sans-first:1.24 08:49:28 INFO - PROCESS | 26248 | Values: 101.0 109.0 108.0 110.0 111.0 111.0 112.0 111.0 111.0 111.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:158.50 stddev:21.44 (13.5%) stddev-sans-first:22.32 08:49:28 INFO - PROCESS | 26248 | Values: 165.0 131.0 156.0 181.0 140.0 161.0 156.0 128.0 188.0 128.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:3.92 (2.4%) stddev-sans-first:4.12 08:49:28 INFO - PROCESS | 26248 | Values: 163.0 161.0 163.0 163.0 165.0 175.0 163.0 166.0 163.0 163.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.80 (49.7%) stddev-sans-first:39.54 08:49:28 INFO - PROCESS | 26248 | Values: 76.0 76.0 76.0 161.0 77.0 76.0 74.0 77.0 170.0 76.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:29.84 (35.1%) stddev-sans-first:30.93 08:49:28 INFO - PROCESS | 26248 | Values: 85.0 86.0 136.0 84.0 84.0 85.0 140.0 85.0 85.0 160.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:49:28 INFO - PROCESS | 26248 | Values: 117.0 117.0 119.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:2.50 (1.7%) stddev-sans-first:2.59 08:49:28 INFO - PROCESS | 26248 | Values: 147.0 148.0 155.0 150.0 148.0 148.0 149.0 146.0 148.0 147.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:49:28 INFO - PROCESS | 26248 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.00 08:49:28 INFO - PROCESS | 26248 | Values: 58.0 56.0 56.0 55.0 57.0 54.0 56.0 55.0 55.0 54.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 08:49:28 INFO - PROCESS | 26248 | Values: 62.0 63.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 64.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.65 (4.5%) stddev-sans-first:3.80 08:49:28 INFO - PROCESS | 26248 | Values: 84.0 80.0 78.0 81.0 79.0 81.0 80.0 81.0 90.0 86.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.50 stddev:7.99 (6.3%) stddev-sans-first:8.46 08:49:28 INFO - PROCESS | 26248 | Values: 130.0 125.0 127.0 121.0 128.0 147.0 122.0 122.0 137.0 127.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:3.33 (2.1%) stddev-sans-first:2.51 08:49:28 INFO - PROCESS | 26248 | Values: 168.0 165.0 163.0 159.0 160.0 158.0 160.0 157.0 161.0 162.0 08:49:28 INFO - PROCESS | 26248 | 08:49:28 INFO - PROCESS | 26248 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.33 08:49:28 INFO - PROCESS | 26248 | Values: 62.0 63.0 65.0 63.0 66.0 64.0 62.0 63.0 64.0 62.0 08:49:28 INFO - PROCESS | 26248 | -------- Summary: end -------- 08:49:28 INFO - PROCESS | 26248 | 08:49:29 INFO - TEST-INFO | 26248: exit 0 08:49:29 INFO - TEST-OK | kraken | took 61990ms 08:49:29 INFO - SUITE-END | took 1172s 08:49:29 INFO - Completed test suite (00:19:32) 08:49:29 INFO - javascript benchmark 08:49:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6891.874848850823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.737967272782, 3139.058282515245, 3160.9209769755767, 3164.224764932592, 3182.236263296808, 5299.841004769858, 5376.758045887935, 5400.108982017967, 5438.782448702047, 5462.972685136579, 5233.921491177635, 5309.0, 5328.200769884519, 5389.757460914258, 5409.9459005409935, 4762.452317983433, 4790.7604619769045, 4805.207140821778, 4917.459079501252, 4969.602431805465, 4790.449098353699, 4918.065567542173, 4996.675216110941, 5023.799048038074, 5048.6465947383695, 4795.760211989422, 4804.615630749532, 4869.561739443449, 4876.171050921352, 4881.633877459205, 4846.61227101831, 4862.465128835825, 4870.172070747982, 4886.169351210303, 4905.386826646669, 4848.951510484885, 4849.709017458928, 4859.951400485986, 4863.610911127137, 4891.144049791273, 5196.76614552346, 5209.1404918188455, 5212.113940630102, 5247.921281180786, 5300.01949639318, 5566.777328906839, 5601.6358936668985, 5609.5792815539, 5613.10190369543, 5616.775328986836, 5574.136008918624, 5670.0, 5689.772409103631, 5693.259876216107, 5729.885402291972, 5287.259783630295, 5319.627626066177, 5339.305890234284, 5358.062339090644, 5363.570914326844, 5772.278465191851, 5786.537077033827, 5811.389804070512, 5812.738426770806, 5820.3888591698105, 5424.321959755031, 5581.609287349846, 5582.106862901916, 5585.553155747531, 5603.8879222416135, 5734.053881109654, 5780.768769249183, 5796.913046304308, 5799.710014499343, 5853.209816674695, 5553.8333849984565, 5618.719064046782, 5621.5221706155435, 5702.258706368229, 5774.018416869142, 5527.613067085346, 5649.71751412436, 5712.571557133231, 5713.971430142906, 5714.7428365723645, 4359.2807186813825, 4391.077873646506, 4391.8682439526865, 4415.602595766396, 4417.160739459492, 3872.206197729515, 3895.902602434905, 3903.1413089120347, 3907.902302442405, 3928.3518219494035, 5266.947330526646, 5412.052890744104, 5417.8103766367985, 5444.700541470257, 5495.422980587061, 5746.195532625436, 5759.596828221985, 5781.566382521328, 5791.768329266866, 5816.738246778905, 5427.402985671573, 5472.261244731911, 5475.753591088331, 5476.342838859283, 5481.588880833874, 4880.951190488121, 4911.484294149134, 4954.0, 4970.030843985461, 5014.448410674823, 5845.327787304429, 5845.3277873045145, 5849.912251316234, 5850.0, 5851.151583020438, 5689.402612725604, 5691.8292451226525, 5695.202671626059, 5696.373398926197, 5697.572682048946, 5700.0, 5752.108423194411, 5792.913106303493, 5831.125331200354, 5868.677222752619, 5552.944470555242, 5560.694161821139, 5566.359868615161, 5570.275864137636, 5576.665400076008, 5549.028919939075, 5591.245181900392, 5646.124850648156, 5647.858803529944, 5660.320761508646, 5379.1662292344745, 5557.249771280987, 5558.749856256397, 5566.165075238747, 5580.0, 5515.806946756844, 5520.337559492726, 5520.861978450571, 5555.0834112371, 5583.246261754611, 5475.09660905962, 5491.697956612425, 5494.532964698045, 5495.313085864267, 5518.724063796713, 5465.316835395575, 5542.140968149944, 5607.130894711163, 5656.123300888369, 5675.489205971482, 5517.034518959246, 5535.031369510239, 5535.474129957647, 5537.280153580009, 5552.7778888845605], "value": 5255.345465965012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2656473149638, 590.2356448399325, 601.80742162508, 616.3189675408674, 634.876199141167, 29741.405171896575, 32367.51448728271, 32853.835730821374, 32976.67023329766, 33005.33989320212, 35971.10072248195, 36338.81830590843, 36435.453468198, 36453.635463645354, 36454.0, 8479.618417171212, 8670.263027642657, 8672.392932494728, 8673.566321683922, 8679.045305016474, 8574.528400937947, 8677.045524992245, 8680.956595217014, 8681.696140635078, 8686.86969695455, 8669.393142480028, 8704.608292626846, 8724.214820666139, 8740.606672699743, 8749.825003499926, 8671.176238257356, 8698.304135669132, 8734.995475520333, 8735.95632021839, 8746.125387461234, 8304.418690691655, 8327.084020757711, 8354.498730076215, 8358.122397148272, 8366.498010119412, 30204.24489387783, 34251.143721406916, 34255.31489370199, 34457.13857153566, 34484.0, 2931.692172321897, 2953.143588359373, 2993.4611769881412, 3083.337082527245, 3137.466630672768, 25925.870370648026, 26015.869920650464, 26134.085307014164, 26449.73550264492, 27689.67723873128, 4064.329385651364, 4106.187261725728, 4169.082801783603, 4214.2414365414215, 4277.935830962538, 292594.0, 294253.0, 294890.0, 295604.0, 295977.0, 29299.853500732785, 30039.849800750857, 30071.0, 30162.396752064837, 30173.69826301709, 31463.37073258522, 31549.842250789057, 31580.36839263202, 31592.0, 31630.209244768605, 13210.07529472947, 13356.933215333862, 13456.394462249222, 13506.257155856521, 13516.12145210558, 11518.596849110409, 11617.825732614017, 11632.825507617392, 11641.47613357401, 11649.708757280967, 7453.068366454193, 7457.701691932262, 7533.1336896257635, 7546.245375462519, 7598.20218877021, 2694.8383097014244, 2728.863556822151, 2736.3855325358136, 2755.338718707496, 2781.235160330885, 775.2789905387931, 791.1376599506566, 804.1998211779317, 828.2669837194127, 864.6022829498376, 27997.60011999392, 28027.859860700974, 28216.29459263535, 28387.858060709565, 28733.28166795847, 986.8421052631544, 1008.5864795433984, 1025.7230547752065, 1033.9247182929819, 1034.5137785240925, 15076.698466030617, 15809.920950395175, 16260.918695406448, 16365.181740912907, 16407.917960410123, 518431.0, 522976.0, 524884.0, 525357.0, 526575.0, 46571.0, 47384.0, 47387.526124739, 47503.762481187376, 47605.28592071122, 1178.4932479034098, 1191.7676053169723, 1204.5121725701106, 1210.098476634895, 1211.2490256041488, 27907.162785116478, 28246.576301355086, 28822.71177288284, 28866.567001494575, 29239.85380073086, 40635.796821015705, 40957.79521102375, 41222.79388603038, 41298.1740365185, 41342.79328603458, 477232.0, 481932.0, 484418.0, 484476.0, 484999.0, 24739.134130305352, 24831.25506234816, 24973.250802475955, 25056.62415063812, 25144.74855251424, 36972.07569810669, 38613.22773544457, 39658.2068358637, 39684.801575991936, 39733.80133099316, 33634.66365336315, 34197.487037694955, 34456.65543344535, 34758.65241347554, 34800.129996750285, 33206.335873282886, 33280.16799579933, 33287.66712332846, 33825.0, 33843.66156338405, 30878.38243235168, 33576.49635255522, 33703.66296337005, 37069.81465092657, 37632.247355053296, 31187.0, 32424.83787581047, 32453.51319730159, 32745.18137046593, 32795.83602081974, 25384.238472845846, 25442.618360724235, 25691.0, 25874.482510350063, 25932.0], "value": 16500.30767612547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.9854005839768, 367.60849695074745, 368.19916681218353, 376.6515972725232, 385.5431313893037, 16115.838841611596, 17316.567085822844, 18285.90857045713, 18318.26726930921, 18369.908150459247, 15395.076295422283, 15873.92063039686, 16208.83791162088, 16250.0, 16278.26747796349, 5382.8923421531545, 5569.359523654771, 5636.323641163066, 5650.26546548948, 5656.151577263402, 4009.2582872168596, 5413.26920865684, 5856.238688970449, 6229.750809967596, 6247.375262473739, 6191.0, 6223.5332350073695, 6224.439800417961, 6250.062490626419, 6271.15339429178, 6074.848128796772, 6244.344343843876, 6251.468625166866, 6253.218347706536, 6278.121063051177, 5509.311336082989, 5529.336479622471, 5548.722563871831, 6522.77170299042, 6951.061606683134, 24290.635640465407, 24298.392540186636, 24694.5061098777, 24748.25755227328, 24769.0, 2273.7498875123724, 2327.8254130940077, 2330.0330362899376, 2483.453640199153, 2538.4796116796015, 15065.945383823137, 15087.849121508754, 15139.621509462242, 15152.545423637308, 15712.685746285124, 1942.2522328903333, 1981.8612697111207, 2035.3486884197064, 2111.0711287033655, 2117.841161912863, 96314.0, 97711.51144244305, 98210.99999999929, 100514.0, 101075.49462252716, 16128.75806862898, 16345.0, 16615.833841661428, 16698.749518757228, 16715.91642041782, 28634.570481442377, 28640.427191456056, 28734.0, 28981.42037159287, 28994.27514312117, 8698.391112622183, 9235.584398702074, 9286.72139835806, 9435.622575096919, 9458.817647794025, 7620.390368770485, 7649.9617501912135, 7704.499207551491, 7717.498362606412, 7819.921800781919, 7955.5624440655165, 8117.715879944174, 8121.837563248702, 8177.550234737147, 8271.67653175489, 1434.5409468969829, 1478.645125169973, 1504.593759684879, 1545.4127431576153, 3223.435898717715, 795.7572940253278, 810.9918900811034, 812.9918700812916, 834.5034704350901, 876.1370050500252, 17299.481015569552, 17550.210240539207, 17675.823241767674, 18197.818021819876, 18257.81742182561, 870.8040690844635, 875.7591662292793, 894.4856707393145, 915.5285028210477, 933.9912894074383, 9897.60409583623, 9960.452175130438, 10136.442495662663, 10197.796044079078, 10255.0, 539103.0, 543466.0, 549098.0, 556925.0, 558571.0, 94767.52616236874, 97668.0, 97684.02315976891, 97903.51048244713, 98152.0, 887.2015186332223, 912.0, 923.5059243304934, 927.967521136757, 937.1752857485506, 16506.0, 16558.172091395623, 16629.168541573115, 16776.483019168812, 16880.324787008383, 42033.528826490925, 42431.15137697167, 43118.13763724645, 43741.56258437375, 44516.0, 60486.39513604984, 60682.08976865439, 62157.0, 62407.37592624016, 62870.68564657147, 7853.882191767242, 8095.595220238847, 8315.293200078062, 8391.58042097905, 8412.579371031301, 9077.409968352036, 11804.40977951082, 12233.0, 13008.21950682962, 13377.0, 11550.249233799776, 11614.5354185835, 11653.825192622287, 11897.762044759229, 11904.821427678418, 11692.70768230767, 11755.412229388325, 11922.403879806148, 12002.459889304828, 12060.457279422271, 11887.643370698894, 11892.76214475723, 12006.159568830099, 12033.518659253532, 12267.509299627915, 8109.59452027408, 8246.216609422096, 8275.08974012846, 8332.791680208044, 8354.87467687973, 8323.35032919172, 11770.705732356759, 11800.527978881091, 11911.52353905834, 12053.397330133634], "value": 9675.159906063245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1161.8199179127237, 1173.7183076061742, 1194.3132698698248, 1357.3688234970743, 1407.669197738532, 7272.127344718628, 8004.599770011498, 8032.638531266092, 8591.527465989377, 8637.179467950542, 8165.91834081659, 8426.199511046456, 8442.155784421555, 8464.449810762297, 8480.872786908201, 2236.0720301075035, 2258.2322010516423, 2275.8179345652306, 2277.3281881844814, 2282.0073268128335, 2208.7791220877943, 2240.2383189715492, 2262.875541845198, 2270.0, 2271.1256166375897, 2223.444138965259, 2232.2521955145044, 2232.9106835726634, 2244.5959727249087, 2247.8538894971857, 2221.9000144993515, 2222.511047569532, 2225.94435139122, 2226.510167763098, 2237.3847192022163, 2187.803097721197, 2207.5253820428684, 2209.0832304593573, 2212.7344718633867, 2212.8451008429415, 8348.081711011784, 8424.578771061484, 8431.957840210822, 8466.026406963216, 8525.957370213171, 4825.10735513931, 4994.026164897847, 5012.498750124958, 5022.748862556894, 5033.421156567005, 3120.422721796452, 3215.5980502437196, 3249.431349513826, 3266.183454136466, 3321.8173000484962, 1068.1294744782977, 1075.639660713662, 1080.4597701149426, 1084.7559299157706, 1085.6634443322596, 11376.431178441046, 11752.529898804038, 11781.352025638587, 11967.64097077089, 11989.22070065443, 4129.0, 4175.415441838145, 4248.086661367821, 4253.2769429197115, 4285.228658841438, 8976.8653470198, 8977.416467929565, 8998.64005439775, 9022.368434209542, 9072.773180670536, 4810.95189048105, 4876.853694389174, 4894.559489645949, 4898.093852637274, 4905.779239934212, 3822.7897465639103, 4399.890002749957, 4508.639308855284, 4579.542045795394, 4617.3074038893765, 3369.275605744777, 3428.5371474850576, 3463.480477928331, 3493.7729047611824, 3568.286342731464, 1089.145021158387, 1092.983605245922, 1105.2318638546133, 1105.8175401058895, 1119.1326721790515, 674.8043067510465, 820.9081921044996, 878.1043335797578, 893.1202765276198, 901.2204443156753, 5799.797007104731, 5895.64626122434, 5896.734646940898, 5907.1434641976675, 6099.573029887954, 820.5527987246965, 862.4820316243331, 871.4466313890598, 902.4765635931144, 903.5482258870564, 3751.3247615429486, 3809.676177524886, 3883.184531248413, 3987.142764305688, 4027.395890616431, 9859.753506162404, 9937.552810123418, 9956.502174891226, 9961.950190249003, 10079.9496002521, 9819.36174148678, 9892.950535247277, 9986.900130998742, 10415.16678665705, 10430.113440357503, 7599.810004749926, 7692.538447693044, 7768.300852923151, 7789.454738168387, 7894.131645518988, 5526.889462210814, 5786.594938354443, 5787.276590426197, 5884.676342801187, 5954.791582294599, 9580.56887440053, 9710.223182145553, 9805.558749856416, 9839.901600983898, 9892.653757118467, 9849.261305402268, 9870.851937220803, 9907.900920990698, 9970.950145249228, 10028.147607453448, 6608.603483790988, 7216.8917466237, 7257.782266532013, 7397.741079062207, 7526.774196774106, 8123.593820309079, 8141.470804397695, 8142.67429302845, 8224.958875205586, 8268.710595129141, 7204.423646108404, 7323.9267607323245, 7370.189279179179, 7426.368758655359, 7499.625018748931, 6991.895121573282, 7093.751718689821, 7186.6047367395295, 7282.235365286569, 7294.781156565312, 6666.26671066192, 6706.865862682816, 6713.127293452016, 6723.663816809042, 6726.8654626908165, 4920.901581968269, 4988.5260900214425, 4994.350734404504, 5020.397552293748, 5106.7446627669215, 5074.416442109205, 5118.283440318284, 5186.066508028591, 5201.973990130025, 5217.0], "value": 4356.37524323482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.28682015881236, 301.90188188838636, 303.7934204740776, 304.50061898486473, 309.48470796124457, 5402.270693456382, 5475.589330800196, 5659.236003139575, 5701.629394089381, 5714.942735593912, 5532.502074813266, 5570.359408668004, 5571.4428557144265, 5575.358833734122, 5582.637128586639, 4273.551277115905, 4274.230638485072, 4282.635975942041, 4290.292101803198, 4295.52749197588, 4152.190322887038, 4309.676774241929, 4312.374705667692, 4314.741115533078, 4332.436783218177, 4248.851290204843, 4257.787110644455, 4266.381374700666, 4279.609127033711, 4303.8063287152, 4299.462567179103, 4299.763513006767, 4310.159518893817, 4314.590113939171, 4326.8269269229195, 3683.4106542953, 3786.7917264550438, 3797.7531460455257, 3803.2013277211818, 3812.80935953204, 5420.972895135538, 5439.456054394568, 5442.455754424565, 5460.890782184334, 5475.0966090595, 4903.607711383116, 4921.286413470062, 4925.408950925876, 4932.53140951609, 4938.135826230396, 5637.943620563783, 5831.766729330821, 5863.120531920204, 5875.500582450497, 5890.676012819294, 4126.442930204414, 4130.669546436308, 4148.108156746284, 4150.439690641755, 4155.812988415529, 6054.848628784272, 6055.848603784896, 6073.1497590337385, 6096.451319381233, 6120.663363515005, 3898.9805050975133, 4127.2570937231585, 4191.7484950903045, 4231.449911511484, 4260.914781704349, 4107.630313271819, 4122.752634841919, 4143.399207115011, 4149.128682976609, 4156.9792151039055, 4826.58973987215, 4832.710037397767, 4851.272309153655, 4859.611231101503, 4887.218045112765, 5328.280682107943, 5889.764409423575, 5989.940100599026, 5999.9100013498955, 6007.429294217042, 1391.2053451048034, 1406.374163497234, 1410.379433049455, 1418.4113592858848, 1420.8650178233052, 859.6475445067492, 882.9404714342814, 888.5201990924828, 900.5767289373983, 902.278177458031, 4984.601231901439, 5004.649674522749, 5014.07239660664, 5034.823781167642, 5093.567046800989, 5286.805975520193, 5298.629095963245, 5315.0, 5317.308749862493, 5339.919901201485, 4728.976355118271, 5053.772580233898, 5110.642255042111, 5123.87190320245, 5136.844210052708, 2821.7742580593504, 2891.7831162662883, 2892.4648939945755, 2903.0114371655063, 2903.535434330497, 5358.946410535845, 5498.257735205696, 5498.890022199534, 5528.55771538276, 5556.777728890799, 5316.787328506894, 5414.105063227838, 5443.727813609304, 5469.945300547023, 5471.4528547145765, 5475.342958844964, 5494.670319780746, 5501.624593851537, 5510.779568817283, 5547.643675576218, 5252.632315737862, 5256.185291279858, 5310.8141215057285, 5343.9198412024625, 5367.275417818701, 5582.972085139549, 6030.396960303934, 6068.666223357758, 6085.208922840003, 6108.0, 6295.779647712308, 6313.800377928179, 6317.431431171217, 6368.331325210786, 6369.617822930639, 4074.4295798588814, 4121.319982202903, 4142.79286035691, 4184.870085077073, 4189.97905010473, 5836.212111364912, 5939.227900372924, 6226.906596401148, 6232.0, 6232.75068997235, 5920.3062606514795, 5935.673537955454, 5939.881202375842, 5958.497431079044, 5982.162497250475, 5884.676342801187, 5886.705664716833, 5888.970555147197, 5951.434613711691, 5955.523558115254, 5634.380218176079, 5713.228714123707, 5806.506446952057, 5847.158145184253, 5855.560832937462, 5898.587098903035, 5947.672877991752, 5977.760889564369, 6004.889095517343, 6029.668368239789, 5621.943780562142, 5844.649321040752, 5869.765209391577, 5876.26856945851, 5930.970345148246], "value": 4302.823068064036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.5834270154139, 579.736220019891, 602.1269159718407, 625.9687015649217, 626.3423405424303, 13448.327583620816, 14456.20490873003, 14496.63758406039, 14649.780253296209, 15095.924520377383, 14170.858291417082, 14265.643358916006, 14266.714665706706, 14351.28243587819, 14354.784678229835, 582.0628787651877, 591.1664552980299, 595.9135925290831, 602.6745557399021, 604.2265899648457, 594.049520766774, 597.4354235247692, 599.1791245992974, 599.733118762151, 600.372610621899, 621.0125899819286, 621.0683974038942, 626.3767551286477, 626.3923993726079, 627.2817623820722, 623.2863371439698, 624.8125562331282, 626.2141013028665, 626.8746250749869, 627.8179327994899, 449.65152007194683, 450.9368688383629, 452.0506935435592, 453.6212262760599, 454.3366684640429, 13207.207567545978, 13255.337233138305, 13261.734765304736, 13279.336033198302, 13336.133151345131, 12591.937040314831, 13014.674633134153, 13101.803472947913, 13241.867581324159, 13401.0, 11267.098632109411, 11580.247283926603, 11595.304281743123, 11615.0, 11642.941785291105, 3757.210985693008, 3793.2223894101644, 3806.923861522782, 3823.847046118152, 3921.19615478829, 80054.59972700158, 80502.0, 81141.18858811396, 81151.0, 81901.59049204775, 9681.66114186, 10086.697399078039, 10165.898341016644, 10203.897961020442, 10245.897541024644, 17130.571735706708, 17180.22688978999, 17189.398371056952, 17416.129193540273, 17534.736978945326, 7685.884711729329, 7695.307422332017, 7701.422393320523, 7713.190115037953, 7784.2994130527395, 4476.320265793978, 4593.150267200579, 4630.81914111906, 4736.692115012514, 4778.689385189951, 3110.1136176189675, 3215.839208039589, 3224.3228921926657, 3230.6930841570015, 3232.4181647303712, 535.74552087758, 546.5163330452499, 547.9342478902557, 555.2559570175903, 556.8607848037991, 546.2870953405765, 566.7138095261867, 573.3807487913044, 620.3238470067648, 670.3196255800367, 8572.571371431404, 9036.45781253127, 9057.230135438429, 9092.8636070459, 9201.515590790583, 628.8553632664513, 632.6583644831832, 636.153747064476, 640.9839754006094, 655.7180412422704, 4356.760378179167, 4413.183561041217, 4447.288433850633, 4452.30989196675, 4455.26488129455, 111625.0, 117947.0, 118332.0, 120861.0, 123922.0, 89399.0, 89459.55270223737, 91825.54087229521, 101675.0, 101712.0, 56604.15093773515, 57371.0, 62357.0, 69078.3092169082, 88293.0, 9419.481928493999, 9484.857727134236, 9520.428774273565, 9760.85358719634, 9842.803143937224, 51049.0, 51121.233181501564, 52460.213096802814, 52494.21258681199, 53003.20495192498, 69016.65491672509, 75643.62178189073, 76521.0, 78280.0, 79107.20892790999, 11435.142364322543, 11695.0, 11706.473208705458, 11799.82300265514, 12120.03039756835, 13575.913926885627, 13805.930970345084, 13833.792493112813, 13895.096818706752, 14032.158070515394, 12970.935145324212, 13227.735445290848, 13241.404136813673, 13435.596932092052, 13597.728045439233, 12642.747145057232, 12735.55425560101, 13023.479060837839, 13046.0, 13301.66745831362, 13000.0, 13076.934615326862, 13081.411336490071, 13087.214767114003, 13173.341332933507, 10270.383776973405, 10426.42654653971, 10724.702491863618, 10872.945635271773, 10943.726406839893, 10812.189085818753, 11120.0, 11283.210175287652, 11288.153388495732, 11295.0], "value": 6813.244137569754, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 108.0, 110.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 131.0, 156.0, 181.0, 140.0, 161.0, 156.0, 128.0, 188.0, 128.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 165.0, 175.0, 163.0, 166.0, 163.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 161.0, 77.0, 76.0, 74.0, 77.0, 170.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 136.0, 84.0, 84.0, 85.0, 140.0, 85.0, 85.0, 160.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 155.0, 150.0, 148.0, 148.0, 149.0, 146.0, 148.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 55.0, 57.0, 54.0, 56.0, 55.0, 55.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 64.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 78.0, 81.0, 79.0, 81.0, 80.0, 81.0, 90.0, 86.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 125.0, 127.0, 121.0, 128.0, 147.0, 122.0, 122.0, 137.0, 127.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 163.0, 159.0, 160.0, 158.0, 160.0, 157.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 63.0, 66.0, 64.0, 62.0, 63.0, 64.0, 62.0], "value": 63.4, "unit": "score"}]}]} 08:49:29 INFO - Return code: 0 08:49:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:49:29 ERROR - # TBPL SUCCESS # 08:49:29 INFO - Running post-action listener: _resource_record_post_action 08:49:29 INFO - ##### 08:49:29 INFO - ##### Finished run-tests step (success) 08:49:29 INFO - ##### 08:49:29 INFO - Running post-run listener: _resource_record_post_run 08:49:29 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 0; Write bytes: 551755776; Read time: 0; Write time: 442680 08:49:29 INFO - TinderboxPrint: CPU usage
13.5% 08:49:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:49:29 INFO - TinderboxPrint: I/O write bytes / time
551,755,776 / 442,680 08:49:29 INFO - TinderboxPrint: CPU idle
8,215.0 (86.5%) 08:49:29 INFO - TinderboxPrint: CPU user
1,227.2 (12.9%) 08:49:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:49:29 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256528384; Read time: 0; Write time: 247604 08:49:29 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 295227392; Read time: 0; Write time: 195076 08:49:30 INFO - Running post-run listener: _upload_blobber_files 08:49:30 INFO - Blob upload gear active. 08:49:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:30 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 08:49:30 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:49:30 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:49:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:49:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:49:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:31 INFO - (blobuploader) - INFO - Done attempting. 08:49:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:49:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:49:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:32 INFO - (blobuploader) - INFO - Done attempting. 08:49:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:49:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:35 INFO - (blobuploader) - INFO - Done attempting. 08:49:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:35 INFO - Return code: 0 08:49:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030ea0aa5a943978d9c975a2c4ddee656ec875ddd87ee3d0365fec157c2d0fa8b4fc37750ed8d3ff190d0e483ad0b4821cde87d4e9098ea4111184ed30cef2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0395ebb9714b19979bd7d9fe4ee0311e5200c858f272147596f41a00e9521aa6a6311be66f9d51c274e1c87d3d03c0eed98beb81d91b497c638fccb74d7052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1121f8cdb19e2cc51be3fe17ef8bc6fe9ee620085576d42eced69a71e2a1ca999a49c4eca65b3239719f12aef64025c64d6ea8a2b3972b78d7dec2ce76e504da"} 08:49:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:35 INFO - Contents: 08:49:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030ea0aa5a943978d9c975a2c4ddee656ec875ddd87ee3d0365fec157c2d0fa8b4fc37750ed8d3ff190d0e483ad0b4821cde87d4e9098ea4111184ed30cef2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0395ebb9714b19979bd7d9fe4ee0311e5200c858f272147596f41a00e9521aa6a6311be66f9d51c274e1c87d3d03c0eed98beb81d91b497c638fccb74d7052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1121f8cdb19e2cc51be3fe17ef8bc6fe9ee620085576d42eced69a71e2a1ca999a49c4eca65b3239719f12aef64025c64d6ea8a2b3972b78d7dec2ce76e504da"} 08:49:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:35 INFO - Copying logs to upload dir... 08:49:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.043887 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-23 08:49:35.302339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:49:35.307798) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030ea0aa5a943978d9c975a2c4ddee656ec875ddd87ee3d0365fec157c2d0fa8b4fc37750ed8d3ff190d0e483ad0b4821cde87d4e9098ea4111184ed30cef2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0395ebb9714b19979bd7d9fe4ee0311e5200c858f272147596f41a00e9521aa6a6311be66f9d51c274e1c87d3d03c0eed98beb81d91b497c638fccb74d7052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1121f8cdb19e2cc51be3fe17ef8bc6fe9ee620085576d42eced69a71e2a1ca999a49c4eca65b3239719f12aef64025c64d6ea8a2b3972b78d7dec2ce76e504da"} build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/030ea0aa5a943978d9c975a2c4ddee656ec875ddd87ee3d0365fec157c2d0fa8b4fc37750ed8d3ff190d0e483ad0b4821cde87d4e9098ea4111184ed30cef2f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c0395ebb9714b19979bd7d9fe4ee0311e5200c858f272147596f41a00e9521aa6a6311be66f9d51c274e1c87d3d03c0eed98beb81d91b497c638fccb74d7052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1121f8cdb19e2cc51be3fe17ef8bc6fe9ee620085576d42eced69a71e2a1ca999a49c4eca65b3239719f12aef64025c64d6ea8a2b3972b78d7dec2ce76e504da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:49:35.335849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:49:35.336229) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1466695739.337898-1440705667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:49:35.420084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:49:35.420532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:49:35.420896) ========= ========= Total master_lag: 0.18 =========