builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1465489904.12 results: success (0) buildid: 20160609090330 builduid: c0bc181ffaa245c6a93226187cd7c2bd revision: f4c18cbc1201927d52b23a97dad073a5617237bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.124956) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.125727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.126166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.144088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.144705) ========= 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=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 09:31:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2016-06-09 09:31:44 (25.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.276324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.277002) ========= 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=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016851 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.329294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:44.329909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4c18cbc1201927d52b23a97dad073a5617237bd --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 f4c18cbc1201927d52b23a97dad073a5617237bd --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=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 09:31:44,702 truncating revision to first 12 chars 2016-06-09 09:31:44,702 Setting DEBUG logging. 2016-06-09 09:31:44,702 attempt 1/10 2016-06-09 09:31:44,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4c18cbc1201?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 09:31:44,992 unpacking tar archive at: fx-team-f4c18cbc1201/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:45.064167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:45.064652) ========= script_repo_revision: f4c18cbc1201927d52b23a97dad073a5617237bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:45.065150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:45.065580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:31:45.078879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-09 09:31:45.079677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:31:45 INFO - MultiFileLogger online at 20160609 09:31:45 in /builds/slave/test 09:31:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:31:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:45 INFO - {'append_to_log': False, 09:31:45 INFO - 'base_work_dir': '/builds/slave/test', 09:31:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:31:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:45 INFO - 'branch': 'Fx-Team-Non-PGO', 09:31:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:45 INFO - 'config_files': ('talos/linux_config.py',), 09:31:45 INFO - 'default_actions': ('clobber', 09:31:45 INFO - 'read-buildbot-config', 09:31:45 INFO - 'download-and-extract', 09:31:45 INFO - 'populate-webroot', 09:31:45 INFO - 'create-virtualenv', 09:31:45 INFO - 'install', 09:31:45 INFO - 'run-tests'), 09:31:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:45 INFO - 'download_minidump_stackwalk': True, 09:31:45 INFO - 'download_symbols': 'ondemand', 09:31:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:45 INFO - 'installer_path': 'installer.exe', 09:31:45 INFO - 'log_level': 'info', 09:31:45 INFO - 'log_name': 'talos', 09:31:45 INFO - 'log_to_console': True, 09:31:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:31:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:31:45 INFO - 'opt_config_files': (), 09:31:45 INFO - 'pip_index': False, 09:31:45 INFO - 'sps_profile': False, 09:31:45 INFO - 'sps_profile_interval': 0, 09:31:45 INFO - 'suite': 'dromaeojs-e10s', 09:31:45 INFO - 'system_bits': '32', 09:31:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:45 INFO - 'title': 'talos-linux64-ix-043', 09:31:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:45 INFO - 'use_talos_json': True, 09:31:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:45 INFO - 'work_dir': 'build'} 09:31:45 INFO - ##### 09:31:45 INFO - ##### Running clobber step. 09:31:45 INFO - ##### 09:31:45 INFO - Running pre-action listener: _resource_record_pre_action 09:31:45 INFO - Running main action method: clobber 09:31:45 INFO - rmtree: /builds/slave/test/build 09:31:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:46 INFO - Running post-action listener: _resource_record_post_action 09:31:46 INFO - ##### 09:31:46 INFO - ##### Finished clobber step (success) 09:31:46 INFO - ##### 09:31:46 INFO - ##### 09:31:46 INFO - ##### Running read-buildbot-config step. 09:31:46 INFO - ##### 09:31:46 INFO - Running pre-action listener: _resource_record_pre_action 09:31:46 INFO - Running main action method: read_buildbot_config 09:31:46 INFO - Using buildbot properties: 09:31:46 INFO - { 09:31:46 INFO - "project": "", 09:31:46 INFO - "product": "firefox", 09:31:46 INFO - "script_repo_revision": "production", 09:31:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:31:46 INFO - "repository": "", 09:31:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:31:46 INFO - "buildid": "20160609090330", 09:31:46 INFO - "pgo_build": "False", 09:31:46 INFO - "basedir": "/builds/slave/test", 09:31:46 INFO - "buildnumber": 1393, 09:31:46 INFO - "slavename": "talos-linux64-ix-043", 09:31:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:31:46 INFO - "platform": "ubuntu64_hw", 09:31:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:31:46 INFO - "branch": "fx-team", 09:31:46 INFO - "repo_path": "integration/fx-team", 09:31:46 INFO - "revision": "f4c18cbc1201927d52b23a97dad073a5617237bd", 09:31:46 INFO - "stage_platform": "linux64", 09:31:46 INFO - "builduid": "c0bc181ffaa245c6a93226187cd7c2bd", 09:31:46 INFO - "slavebuilddir": "test" 09:31:46 INFO - } 09:31:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:31:46 INFO - Running post-action listener: _resource_record_post_action 09:31:46 INFO - ##### 09:31:46 INFO - ##### Finished read-buildbot-config step (success) 09:31:46 INFO - ##### 09:31:46 INFO - ##### 09:31:46 INFO - ##### Running download-and-extract step. 09:31:46 INFO - ##### 09:31:46 INFO - Running pre-action listener: _resource_record_pre_action 09:31:46 INFO - Running main action method: download_and_extract 09:31:46 INFO - mkdir: /builds/slave/test/build/tests 09:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:46 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:31:46 INFO - Downloaded 1361 bytes. 09:31:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:31:46 INFO - Using the following test package requirements: 09:31:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:31:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:31:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'jsshell-linux-x86_64.zip'], 09:31:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:31:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:31:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:31:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:31:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:31:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:31:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:31:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:46 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:47 INFO - Downloaded 22879604 bytes. 09:31:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:31:48 INFO - Return code: 0 09:31:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:48 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:50 INFO - Downloaded 22879604 bytes. 09:31:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:31:51 INFO - Return code: 0 09:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:51 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:31:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:31:52 INFO - Downloaded 10833377 bytes. 09:31:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:31:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:31:52 INFO - Return code: 0 09:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:52 INFO - https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:31:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:31:53 INFO - Downloaded 55364925 bytes. 09:31:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:53 INFO - mkdir: /builds/slave/test/properties 09:31:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:53 INFO - Contents: 09:31:53 INFO - build_url:https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:31:54 INFO - Running post-action listener: _resource_record_post_action 09:31:54 INFO - Running post-action listener: set_extra_try_arguments 09:31:54 INFO - ##### 09:31:54 INFO - ##### Finished download-and-extract step (success) 09:31:54 INFO - ##### 09:31:54 INFO - ##### 09:31:54 INFO - ##### Running populate-webroot step. 09:31:54 INFO - ##### 09:31:54 INFO - Running pre-action listener: _resource_record_pre_action 09:31:54 INFO - Running main action method: populate_webroot 09:31:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:54 INFO - '--tppagecycles', 09:31:54 INFO - '7'], 09:31:54 INFO - 'tests': ['tsvgm']}}, 09:31:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['damp', 'tps']}, 09:31:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'tests': ['damp', 'tps']}, 09:31:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['dromaeo_dom']}, 09:31:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['a11yr', 09:31:54 INFO - 'ts_paint', 09:31:54 INFO - 'tpaint', 09:31:54 INFO - 'sessionrestore', 09:31:54 INFO - 'sessionrestore_no_auto_restore', 09:31:54 INFO - 'tabpaint']}, 09:31:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['tsvgx', 09:31:54 INFO - 'tsvgr_opacity', 09:31:54 INFO - 'tart', 09:31:54 INFO - 'tscrollx', 09:31:54 INFO - 'cart']}, 09:31:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:54 INFO - 'tsvgr_opacity', 09:31:54 INFO - 'tart', 09:31:54 INFO - 'tscrollx', 09:31:54 INFO - 'cart']}, 09:31:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'talos_options': ['--disable-e10s'], 09:31:54 INFO - 'tests': ['tp5o']}, 09:31:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'tests': ['tp5o']}, 09:31:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'talos_options': ['--disable-e10s', 09:31:54 INFO - '--xperf_path', 09:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:54 INFO - 'tests': ['tp5n']}, 09:31:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:54 INFO - 'talos_options': ['--xperf_path', 09:31:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:54 INFO - 'tests': ['tp5n']}}, 09:31:54 INFO - 'talos.zip': {'path': '', 09:31:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:54 INFO - Running post-action listener: _resource_record_post_action 09:31:54 INFO - ##### 09:31:54 INFO - ##### Finished populate-webroot step (success) 09:31:54 INFO - ##### 09:31:54 INFO - ##### 09:31:54 INFO - ##### Running create-virtualenv step. 09:31:54 INFO - ##### 09:31:54 INFO - Running pre-action listener: _resource_record_pre_action 09:31:54 INFO - Running main action method: create_virtualenv 09:31:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:31:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:54 INFO - Using real prefix '/usr' 09:31:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:55 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:57 INFO - Installing pip.................done. 09:31:57 INFO - Return code: 0 09:31:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:57 INFO - Using env: {'DISPLAY': ':0', 09:31:57 INFO - 'HOME': '/home/cltbld', 09:31:57 INFO - 'LANG': 'en_US.UTF-8', 09:31:57 INFO - 'LANGUAGE': 'en_US:en', 09:31:57 INFO - 'LOGNAME': 'cltbld', 09:31:57 INFO - 'MAIL': '/var/mail/cltbld', 09:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:57 INFO - 'MOZ_NO_REMOTE': '1', 09:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:57 INFO - 'NO_EM_RESTART': '1', 09:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:57 INFO - 'PWD': '/builds/slave/test', 09:31:57 INFO - 'SHELL': '/bin/bash', 09:31:57 INFO - 'SHLVL': '1', 09:31:57 INFO - 'TERM': 'linux', 09:31:57 INFO - 'TMOUT': '86400', 09:31:57 INFO - 'USER': 'cltbld', 09:31:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:57 INFO - '_': '/tools/buildbot/bin/python'} 09:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:31:57 INFO - Cleaning up... 09:31:57 INFO - Return code: 0 09:31:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:31:57 INFO - Using env: {'DISPLAY': ':0', 09:31:57 INFO - 'HOME': '/home/cltbld', 09:31:57 INFO - 'LANG': 'en_US.UTF-8', 09:31:57 INFO - 'LANGUAGE': 'en_US:en', 09:31:57 INFO - 'LOGNAME': 'cltbld', 09:31:57 INFO - 'MAIL': '/var/mail/cltbld', 09:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:57 INFO - 'MOZ_NO_REMOTE': '1', 09:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:57 INFO - 'NO_EM_RESTART': '1', 09:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:57 INFO - 'PWD': '/builds/slave/test', 09:31:57 INFO - 'SHELL': '/bin/bash', 09:31:57 INFO - 'SHLVL': '1', 09:31:57 INFO - 'TERM': 'linux', 09:31:57 INFO - 'TMOUT': '86400', 09:31:57 INFO - 'USER': 'cltbld', 09:31:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:57 INFO - '_': '/tools/buildbot/bin/python'} 09:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:57 INFO - Downloading/unpacking psutil>=3.1.1 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:59 INFO - Installing collected packages: psutil 09:31:59 INFO - Running setup.py install for psutil 09:31:59 INFO - building 'psutil._psutil_linux' extension 09:31:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:32:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:32:00 INFO - building 'psutil._psutil_posix' extension 09:32:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:32:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:32:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:00 INFO - Successfully installed psutil 09:32:00 INFO - Cleaning up... 09:32:00 INFO - Return code: 0 09:32:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:32:00 INFO - Using env: {'DISPLAY': ':0', 09:32:00 INFO - 'HOME': '/home/cltbld', 09:32:00 INFO - 'LANG': 'en_US.UTF-8', 09:32:00 INFO - 'LANGUAGE': 'en_US:en', 09:32:00 INFO - 'LOGNAME': 'cltbld', 09:32:00 INFO - 'MAIL': '/var/mail/cltbld', 09:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:00 INFO - 'MOZ_NO_REMOTE': '1', 09:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:00 INFO - 'NO_EM_RESTART': '1', 09:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:00 INFO - 'PWD': '/builds/slave/test', 09:32:00 INFO - 'SHELL': '/bin/bash', 09:32:00 INFO - 'SHLVL': '1', 09:32:00 INFO - 'TERM': 'linux', 09:32:00 INFO - 'TMOUT': '86400', 09:32:00 INFO - 'USER': 'cltbld', 09:32:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:00 INFO - '_': '/tools/buildbot/bin/python'} 09:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:02 INFO - Installing collected packages: mozsystemmonitor 09:32:02 INFO - Running setup.py install for mozsystemmonitor 09:32:02 INFO - Successfully installed mozsystemmonitor 09:32:02 INFO - Cleaning up... 09:32:02 INFO - Return code: 0 09:32:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:32:02 INFO - Using env: {'DISPLAY': ':0', 09:32:02 INFO - 'HOME': '/home/cltbld', 09:32:02 INFO - 'LANG': 'en_US.UTF-8', 09:32:02 INFO - 'LANGUAGE': 'en_US:en', 09:32:02 INFO - 'LOGNAME': 'cltbld', 09:32:02 INFO - 'MAIL': '/var/mail/cltbld', 09:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:02 INFO - 'MOZ_NO_REMOTE': '1', 09:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:02 INFO - 'NO_EM_RESTART': '1', 09:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:02 INFO - 'PWD': '/builds/slave/test', 09:32:02 INFO - 'SHELL': '/bin/bash', 09:32:02 INFO - 'SHLVL': '1', 09:32:02 INFO - 'TERM': 'linux', 09:32:02 INFO - 'TMOUT': '86400', 09:32:02 INFO - 'USER': 'cltbld', 09:32:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:02 INFO - '_': '/tools/buildbot/bin/python'} 09:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:05 INFO - warning: no files found matching '*.txt' 09:32:05 INFO - no previously-included directories found matching 'build' 09:32:05 INFO - no previously-included directories found matching 'dist' 09:32:05 INFO - no previously-included directories found matching '.git*' 09:32:05 INFO - Installing collected packages: jsonschema, functools32 09:32:05 INFO - Running setup.py install for functools32 09:32:05 INFO - warning: no files found matching '*.txt' 09:32:05 INFO - no previously-included directories found matching 'build' 09:32:05 INFO - no previously-included directories found matching 'dist' 09:32:05 INFO - no previously-included directories found matching '.git*' 09:32:05 INFO - Successfully installed jsonschema functools32 09:32:05 INFO - Cleaning up... 09:32:05 INFO - Return code: 0 09:32:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:32:05 INFO - Using env: {'DISPLAY': ':0', 09:32:05 INFO - 'HOME': '/home/cltbld', 09:32:05 INFO - 'LANG': 'en_US.UTF-8', 09:32:05 INFO - 'LANGUAGE': 'en_US:en', 09:32:05 INFO - 'LOGNAME': 'cltbld', 09:32:05 INFO - 'MAIL': '/var/mail/cltbld', 09:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:05 INFO - 'MOZ_NO_REMOTE': '1', 09:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:05 INFO - 'NO_EM_RESTART': '1', 09:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:05 INFO - 'PWD': '/builds/slave/test', 09:32:05 INFO - 'SHELL': '/bin/bash', 09:32:05 INFO - 'SHLVL': '1', 09:32:05 INFO - 'TERM': 'linux', 09:32:05 INFO - 'TMOUT': '86400', 09:32:05 INFO - 'USER': 'cltbld', 09:32:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:05 INFO - '_': '/tools/buildbot/bin/python'} 09:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:08 INFO - Downloading docopt-0.6.1.tar.gz 09:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:08 INFO - Running setup.py install for blobuploader 09:32:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:08 INFO - Running setup.py install for requests 09:32:08 INFO - Running setup.py install for docopt 09:32:08 INFO - Successfully installed blobuploader requests docopt 09:32:08 INFO - Cleaning up... 09:32:08 INFO - Return code: 0 09:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:08 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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:08 INFO - Using env: {'DISPLAY': ':0', 09:32:08 INFO - 'HOME': '/home/cltbld', 09:32:08 INFO - 'LANG': 'en_US.UTF-8', 09:32:08 INFO - 'LANGUAGE': 'en_US:en', 09:32:08 INFO - 'LOGNAME': 'cltbld', 09:32:08 INFO - 'MAIL': '/var/mail/cltbld', 09:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:08 INFO - 'MOZ_NO_REMOTE': '1', 09:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:08 INFO - 'NO_EM_RESTART': '1', 09:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:08 INFO - 'PWD': '/builds/slave/test', 09:32:08 INFO - 'SHELL': '/bin/bash', 09:32:08 INFO - 'SHLVL': '1', 09:32:08 INFO - 'TERM': 'linux', 09:32:08 INFO - 'TMOUT': '86400', 09:32:08 INFO - 'USER': 'cltbld', 09:32:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:08 INFO - '_': '/tools/buildbot/bin/python'} 09:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:09 INFO - Running setup.py (path:/tmp/pip-0Bw2aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:09 INFO - Running setup.py (path:/tmp/pip-NKaSDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:09 INFO - Running setup.py (path:/tmp/pip-Hu57ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:09 INFO - Running setup.py (path:/tmp/pip-RSQL7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:09 INFO - Running setup.py (path:/tmp/pip-qIpLBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:09 INFO - Running setup.py (path:/tmp/pip-RGagdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:09 INFO - Running setup.py (path:/tmp/pip-f6vPzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:09 INFO - Running setup.py (path:/tmp/pip-0UgEVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:09 INFO - Running setup.py (path:/tmp/pip-3j2cbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:09 INFO - Running setup.py (path:/tmp/pip-D0GF49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:09 INFO - Running setup.py (path:/tmp/pip-MkkIXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:09 INFO - Running setup.py (path:/tmp/pip-FPzlmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:09 INFO - Running setup.py (path:/tmp/pip-noE2qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:10 INFO - Running setup.py (path:/tmp/pip-6BYShh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:10 INFO - Running setup.py (path:/tmp/pip-OTZfrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:10 INFO - Running setup.py (path:/tmp/pip-a5_0pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:10 INFO - Running setup.py (path:/tmp/pip-LWwNKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:10 INFO - Running setup.py install for manifestparser 09:32:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Running setup.py install for mozcrash 09:32:10 INFO - Running setup.py install for mozdebug 09:32:10 INFO - Running setup.py install for mozdevice 09:32:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Running setup.py install for mozfile 09:32:10 INFO - Running setup.py install for mozhttpd 09:32:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Running setup.py install for mozinfo 09:32:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for mozInstall 09:32:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for mozleak 09:32:11 INFO - Running setup.py install for mozlog 09:32:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for moznetwork 09:32:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for mozprocess 09:32:11 INFO - Running setup.py install for mozprofile 09:32:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for mozrunner 09:32:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:11 INFO - Running setup.py install for mozscreenshot 09:32:11 INFO - Running setup.py install for moztest 09:32:12 INFO - Running setup.py install for mozversion 09:32:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:12 INFO - Cleaning up... 09:32:12 INFO - Return code: 0 09:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:12 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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:12 INFO - Using env: {'DISPLAY': ':0', 09:32:12 INFO - 'HOME': '/home/cltbld', 09:32:12 INFO - 'LANG': 'en_US.UTF-8', 09:32:12 INFO - 'LANGUAGE': 'en_US:en', 09:32:12 INFO - 'LOGNAME': 'cltbld', 09:32:12 INFO - 'MAIL': '/var/mail/cltbld', 09:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:12 INFO - 'MOZ_NO_REMOTE': '1', 09:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:12 INFO - 'NO_EM_RESTART': '1', 09:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:12 INFO - 'PWD': '/builds/slave/test', 09:32:12 INFO - 'SHELL': '/bin/bash', 09:32:12 INFO - 'SHLVL': '1', 09:32:12 INFO - 'TERM': 'linux', 09:32:12 INFO - 'TMOUT': '86400', 09:32:12 INFO - 'USER': 'cltbld', 09:32:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:12 INFO - '_': '/tools/buildbot/bin/python'} 09:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:12 INFO - Running setup.py (path:/tmp/pip-fqwWs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:12 INFO - Running setup.py (path:/tmp/pip-_2pvv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:12 INFO - Running setup.py (path:/tmp/pip-euhWhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:12 INFO - Running setup.py (path:/tmp/pip-KXtPPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:12 INFO - Running setup.py (path:/tmp/pip-ev_BJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:12 INFO - Running setup.py (path:/tmp/pip-DIIezN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:12 INFO - Running setup.py (path:/tmp/pip-uM0fWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:12 INFO - Running setup.py (path:/tmp/pip-Gc9fji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:12 INFO - Running setup.py (path:/tmp/pip-pKNMYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:13 INFO - Running setup.py (path:/tmp/pip-JUAzY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:13 INFO - Running setup.py (path:/tmp/pip-Q3GqKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:13 INFO - Running setup.py (path:/tmp/pip-8XF2NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:13 INFO - Running setup.py (path:/tmp/pip-J6ezHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:13 INFO - Running setup.py (path:/tmp/pip-g_z4yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:13 INFO - Running setup.py (path:/tmp/pip-zF2075-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:13 INFO - Running setup.py (path:/tmp/pip-ZqRRg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:13 INFO - Running setup.py (path:/tmp/pip-jFvoZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:15 INFO - Downloading blessings-1.6.tar.gz 09:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:15 INFO - Installing collected packages: blessings 09:32:15 INFO - Running setup.py install for blessings 09:32:15 INFO - Successfully installed blessings 09:32:15 INFO - Cleaning up... 09:32:15 INFO - Return code: 0 09:32:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:16 INFO - Reading from file tmpfile_stdout 09:32:16 INFO - Current package versions: 09:32:16 INFO - argparse == 1.2.1 09:32:16 INFO - blessings == 1.6 09:32:16 INFO - blobuploader == 1.2.4 09:32:16 INFO - docopt == 0.6.1 09:32:16 INFO - functools32 == 3.2.3-2 09:32:16 INFO - jsonschema == 2.5.1 09:32:16 INFO - manifestparser == 1.1 09:32:16 INFO - mozInstall == 1.12 09:32:16 INFO - mozcrash == 0.17 09:32:16 INFO - mozdebug == 0.1 09:32:16 INFO - mozdevice == 0.48 09:32:16 INFO - mozfile == 1.2 09:32:16 INFO - mozhttpd == 0.7 09:32:16 INFO - mozinfo == 0.9 09:32:16 INFO - mozleak == 0.1 09:32:16 INFO - mozlog == 3.2 09:32:16 INFO - moznetwork == 0.27 09:32:16 INFO - mozprocess == 0.22 09:32:16 INFO - mozprofile == 0.28 09:32:16 INFO - mozrunner == 6.11 09:32:16 INFO - mozscreenshot == 0.1 09:32:16 INFO - mozsystemmonitor == 0.3 09:32:16 INFO - moztest == 0.7 09:32:16 INFO - mozversion == 1.4 09:32:16 INFO - psutil == 3.1.1 09:32:16 INFO - requests == 1.2.3 09:32:16 INFO - wsgiref == 0.1.2 09:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:16 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 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:16 INFO - Using env: {'DISPLAY': ':0', 09:32:16 INFO - 'HOME': '/home/cltbld', 09:32:16 INFO - 'LANG': 'en_US.UTF-8', 09:32:16 INFO - 'LANGUAGE': 'en_US:en', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MAIL': '/var/mail/cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SHLVL': '1', 09:32:16 INFO - 'TERM': 'linux', 09:32:16 INFO - 'TMOUT': '86400', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - '_': '/tools/buildbot/bin/python'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:16 INFO - Cleaning up... 09:32:16 INFO - Return code: 0 09:32:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32: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', 'jsonschema'] in /builds/slave/test/build 09:32: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 jsonschema 09:32:16 INFO - Using env: {'DISPLAY': ':0', 09:32:16 INFO - 'HOME': '/home/cltbld', 09:32:16 INFO - 'LANG': 'en_US.UTF-8', 09:32:16 INFO - 'LANGUAGE': 'en_US:en', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MAIL': '/var/mail/cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SHLVL': '1', 09:32:16 INFO - 'TERM': 'linux', 09:32:16 INFO - 'TMOUT': '86400', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - '_': '/tools/buildbot/bin/python'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:16 INFO - Cleaning up... 09:32:16 INFO - Return code: 0 09:32:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa39e940f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, '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': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32: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', 'flake8'] in /builds/slave/test/build 09:32: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 flake8 09:32:16 INFO - Using env: {'DISPLAY': ':0', 09:32:16 INFO - 'HOME': '/home/cltbld', 09:32:16 INFO - 'LANG': 'en_US.UTF-8', 09:32:16 INFO - 'LANGUAGE': 'en_US:en', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MAIL': '/var/mail/cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SHLVL': '1', 09:32:16 INFO - 'TERM': 'linux', 09:32:16 INFO - 'TMOUT': '86400', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - '_': '/tools/buildbot/bin/python'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Downloading/unpacking flake8 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:32:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:32:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:19 INFO - no previously-included directories found matching 'docs/_build' 09:32:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:32:19 INFO - Running setup.py install for pep8 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:19 INFO - no previously-included directories found matching 'docs/_build' 09:32:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:32:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:32:19 INFO - Cleaning up... 09:32:19 INFO - Return code: 0 09:32:19 INFO - Running post-action listener: _resource_record_post_action 09:32:19 INFO - Running post-action listener: _start_resource_monitoring 09:32:19 INFO - Starting resource monitoring. 09:32:19 INFO - ##### 09:32:19 INFO - ##### Finished create-virtualenv step (success) 09:32:19 INFO - ##### 09:32:19 INFO - ##### 09:32:19 INFO - ##### Running install step. 09:32:19 INFO - ##### 09:32:19 INFO - Running pre-action listener: _resource_record_pre_action 09:32:19 INFO - Running main action method: install 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:19 INFO - Reading from file tmpfile_stdout 09:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:19 INFO - Reading from file tmpfile_stdout 09:32:19 INFO - Output received: 09:32:19 INFO - Usage: mozinstall [options] installer 09:32:19 INFO - Options: 09:32:19 INFO - -h, --help show this help message and exit 09:32:19 INFO - -d DEST, --destination=DEST 09:32:19 INFO - Directory to install application into. [default: 09:32:19 INFO - "/builds/slave/test"] 09:32:19 INFO - --app=APP Application being installed. [default: firefox] 09:32:19 INFO - mkdir: /builds/slave/test/build/application 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:32:35 INFO - Reading from file tmpfile_stdout 09:32:35 INFO - Output received: 09:32:35 INFO - /builds/slave/test/build/application/firefox/firefox 09:32:35 INFO - Running post-action listener: _resource_record_post_action 09:32:35 INFO - ##### 09:32:35 INFO - ##### Finished install step (success) 09:32:35 INFO - ##### 09:32:35 INFO - ##### 09:32:35 INFO - ##### Running run-tests step. 09:32:35 INFO - ##### 09:32:35 INFO - Running pre-action listener: _resource_record_pre_action 09:32:35 INFO - Running main action method: run_tests 09:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:35 INFO - Python 2.7.3 09:32:36 INFO - Return code: 0 09:32:36 INFO - grabbing minidump binary from tooltool 09:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:36 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 0x2b871c0>, '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 0x2b880c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:32:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:32:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:32:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:36 INFO - Return code: 0 09:32:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:32:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:32:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:32:36 INFO - Return code: 0 09:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:32:36 INFO - Using env: {'DISPLAY': ':0', 09:32:36 INFO - 'HOME': '/home/cltbld', 09:32:36 INFO - 'LANG': 'en_US.UTF-8', 09:32:36 INFO - 'LANGUAGE': 'en_US:en', 09:32:36 INFO - 'LOGNAME': 'cltbld', 09:32:36 INFO - 'MAIL': '/var/mail/cltbld', 09:32:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:36 INFO - 'MOZ_NO_REMOTE': '1', 09:32:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:36 INFO - 'NO_EM_RESTART': '1', 09:32:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:36 INFO - 'PWD': '/builds/slave/test', 09:32:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:36 INFO - 'SHELL': '/bin/bash', 09:32:36 INFO - 'SHLVL': '1', 09:32:36 INFO - 'TERM': 'linux', 09:32:36 INFO - 'TMOUT': '86400', 09:32:36 INFO - 'USER': 'cltbld', 09:32:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138', 09:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:36 INFO - '_': '/tools/buildbot/bin/python'} 09:32:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:32:37 INFO - mozversion application_buildid: 20160609090330 09:32:37 INFO - mozversion application_changeset: f4c18cbc1201927d52b23a97dad073a5617237bd 09:32:37 INFO - mozversion application_display_name: Nightly 09:32:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:37 INFO - mozversion application_name: Firefox 09:32:37 INFO - mozversion application_remotingname: firefox 09:32:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:32:37 INFO - mozversion application_vendor: Mozilla 09:32:37 INFO - mozversion application_version: 50.0a1 09:32:37 INFO - mozversion platform_buildid: 20160609090330 09:32:37 INFO - mozversion platform_changeset: f4c18cbc1201927d52b23a97dad073a5617237bd 09:32:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:32:37 INFO - mozversion platform_version: 50.0a1 09:32:37 INFO - using testdate: 1465489957 09:32:37 INFO - actual date: 1465489957 09:32:37 INFO - starting webserver on 'localhost:52682' 09:32:37 INFO - SUITE-START | Running 2 tests 09:32:37 INFO - TEST-START | dromaeo_css 09:32:37 INFO - operating with platform_type : linux_ 09:32:37 INFO - Initialising browser for dromaeo_css test... 09:32:37 INFO - TEST-INFO | started process 22971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY1R2B9/profile http://localhost:52682/getInfo.html) 09:32:42 INFO - PROCESS | 22971 | __metrics Screen width/height:1600/1200 09:32:42 INFO - PROCESS | 22971 | colorDepth:24 09:32:42 INFO - PROCESS | 22971 | Browser inner width/height: 1024/697 09:32:42 INFO - PROCESS | 22971 | __metrics 09:32:43 ERROR - PROCESS | 22971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:32:44 INFO - TEST-INFO | 22971: exit 0 09:32:44 INFO - Browser initialized. 09:32:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:44 INFO - TEST-INFO | started process 23089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY1R2B9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:56 INFO - PROCESS | 23089 | RSS: Main: 185634816 09:32:56 INFO - PROCESS | 23089 | 09:33:46 INFO - PROCESS | 23089 | 1465490026388 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:35:58 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52682/tests/dromaeo/cssquery-ext.html) 09:35:59 INFO - PROCESS | 23089 | RSS: Main: 187973632 09:35:59 INFO - PROCESS | 23089 | 09:39:01 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-ext.html (next: http://localhost:52682/tests/dromaeo/cssquery-jquery.html) 09:39:02 INFO - PROCESS | 23089 | RSS: Main: 187396096 09:39:02 INFO - PROCESS | 23089 | 09:42:04 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52682/tests/dromaeo/cssquery-mootools.html) 09:42:04 INFO - PROCESS | 23089 | RSS: Main: 189100032 09:42:04 INFO - PROCESS | 23089 | 09:45:06 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52682/tests/dromaeo/cssquery-prototype.html) 09:45:07 INFO - PROCESS | 23089 | RSS: Main: 186810368 09:45:07 INFO - PROCESS | 23089 | 09:48:09 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52682/tests/dromaeo/cssquery-yui.html) 09:48:10 INFO - PROCESS | 23089 | RSS: Main: 188657664 09:48:10 INFO - PROCESS | 23089 | 09:51:12 INFO - PROCESS | 23089 | Cycle 1(1): loaded http://localhost:52682/tests/dromaeo/cssquery-yui.html (next: http://localhost:52682/tests/dromaeo/cssquery-dojo.html) 09:51:13 INFO - PROCESS | 23089 | RSS: Main: 190251008 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | __start_tp_report 09:51:13 INFO - PROCESS | 23089 | _x_x_mozilla_page_load 09:51:13 INFO - PROCESS | 23089 | _x_x_mozilla_page_load_details 09:51:13 INFO - PROCESS | 23089 | |i|pagename|runs| 09:51:13 INFO - PROCESS | 23089 | |0;dojo.html;2603.518349105416;2639.142278759404;2655.654764880566;2667.293167310664;2667.4931762965034;4714.481407045227;4729.29060640904;4787.569118779309;4842.951570484294;4874.683145595543;4637.976810115944;4739.052189562084;4783.402074740658;4837.540433658805;4844.4913284105105;4313.741175529471;4342.630876375496;4364.738115713068;4408.470983481987;4443.977780111095;4409;4463.888402789924;4472.575105364985;4472.686911916167;4499.302608095734;4267.445232119836;4314.374415709704;4318.69769116162;4322.351647252905;4359.433273674402;4337.240982828024;4345.9130817383475;4372.693911426201;4395.4725432947935;4398.8020539075815;4367.956320436819;4370.759608221547;4379.08039311745;4397.494288156871;4419.9337009944875;4723.669343145981;4784.425868895755;4800.879978000578;4818.927716084261;4825.734584597846;5116.616253780944;5131.820386286462;5142.331496905378;5157.819476318348;5173.8189163379475;5070.416902056274;5118.872028199287;5165.690058596496;5167.948320516822;5179.456157103487;4804;4807.158747219222;4807.254875494304;4815.253635686474;4826.396700412449;5206.297149884717;5210.374755029421;5215.921761173586;5233.685978841282;5240.978009288228;4831;5002.974985125051;5010.323606313101;5041.974790126099;5077.720725360141;4939.160342741742;5020.347354843847;5105.5149760772665;5118.97440512795;5128.205128205134;5007.4491805901325;5023.372078490189;5028.32117664118;5034.697918124924;5037.471065538139;4916.385451818523;4961.05739909416;5006.3992320921725;5057.115004874132;5067.695938243717;4229.2598795210715;4238.809253583596;4271.508776490743;4290.120525292307;4302.720323179046;3702.0559757262263;3707.5550933888107;3714.665680088805;3753.474513568103;3789.2610940866816;4376.693631445832;4459.687821852439;4503.414556107685;4506.864794056183;4523.751193684379;5147.613928955343;5166.638335316492;5172.586193104543;5183.0670479314085;5210.635255532076;4473.7986790594505;4512.481064677539;4515.435570553681;4539.614132798749;4554.0891821635805;4377.146456441027;4545.36364908913;4576.336431217454;4577.5880170784785;4595.770211489412;4831.613470922248;4861.076395484846;4878.219484882473;4895.363602731693;4935.235038569028;5152.27868098459;5159;5170.27616133734;5176.741162941913;5227.738613069408;4588.632909367309;4812.903741925212;4839.685420447659;4840.975795121002;4842.128416884994;5052.418971818288;5054.924176137288;5056.974715126401;5072.112380333353;5111.565516930954;4878.0975519529;5119.718415487184;5132.8460146195675;5134.7175905324075;5136.948630513647;4782.067496838084;4953.72754498506;4966.056449274626;4976.253561965589;4983.626228032839;4956.900861982668;5000.049990501793;5002.824901128443;5026.095302845523;5028.899422011466;4871.293662418859;4938.08645400602;4945.6043516517875;4956.6530342877095;4979.626528010486;4742.762861856962;4996.350474438445;5016.523430274118;5027.145385284583;5036.395632524121;4896.534829191221;4936.703797772145;4959.504049595156;4964.925526117184;4991.450940396481 09:51:13 INFO - PROCESS | 23089 | |1;ext.html;564.2016546586581;570.1277046119436;580.9419058094192;587.6738410182347;592.200529285465;33745.493817592724;38227.42658860119;38312.23375532488;38325.80837095814;38359.61640383596;37292.440613390754;37686.0578485538;37774.62225377745;37831.24337513255;37975.430368544425;7654.54072755635;7736.613169341538;7800.960995195016;7814.648340824648;7825.13923468418;7603.80990475237;7633.732819351324;7687.884681729778;7785.532868027908;7793.181715919832;7737.883931741028;7760.805979850493;7763;7772.106207786092;7777.961110194441;7705.075390953066;7740.26467485588;7746.573938433356;7749.0701115865895;7770.49491783038;7704.422168337397;7788.922110778876;7792.220777922219;7795.9220407795765;7816.960915195445;36780;36978.815105924295;37165;37275.81362093199;37398.25203495942;2833.914982550527;2906.433245517104;2909.7526710229654;3020.6828283030186;3179;29053.273668158254;29304.853475732485;29788.8510557448;29789;30539.847300763577;2953.7489313408173;2961.526155815081;2967.614210152688;2977.032464449063;3026.8637911294045;258590;258950;259875;259997;261079;26422.47155056888;51290.74354628203;51315.48684513107;51603.48396515987;51647;31682.366352672816;31920;31926.680733192836;31970.520442193385;32136.83931580327;13457.327133643279;13649;13674.31628418575;13682.52111176104;13733.931330343485;11276.097912167006;11328.150388720878;11338.489767960462;11368.317900925971;11378.943105284587;7794.22057794216;7814.921850781419;7884.64519096642;7888.40836937232;7902.328302094272;3055.9847200764298;3096.3617749144664;3108.020973393374;3137.905862824119;3158.842057897142;812.0215140755375;851.9659213631385;859.6088779605265;915.3135148638521;949.1215154107891;28091;28187.295317617223;28469.231113164475;28488.430231395258;28802.855985719936;919.7148883846029;965.3676841668719;979.5494072726625;1001.8878301844711;1056.7041228456044;14820.25898705082;15092.924535377473;15121.16833574164;15333.233338333039;15361.6159596011;374563;377930;379914;381340;384365;48634;48887.755561221966;48950.51049489531;48955.755221224375;49120;1106.4025426269725;1169.140681599024;1170.6839153428698;1172.695099274178;1174.4949671641277;24033;27443;28941.710582893902;30816.53775193419;31469.213269668442;47439;47736;48274.75862620665;48290.27564586464;48371;358254;358843;360770;360858;361533;37913.620863792115;39552.80223598864;39866.003349916486;40001.59998399979;40023.39964900587;42159.36760948649;42379.364309535995;42891.35423489039;43218.56781432145;43591.34612980745;36299.81850090733;36934.07664808294;37085.629143709295;37275.44086838645;37407.6259237415;35959.82020089883;36114.638853611126;36131.81934090313;36409.817950911136;37533.62466375301;30529;35966.280674386886;36042;36506;39494.80252598719;32339.838300808344;33433.33133337271;33899.83050084734;34106;34171.48742768811;25449.10928117507;25846.483070338865;25906.740932591187;26077.478450430506;26372 09:51:13 INFO - PROCESS | 23089 | |2;jquery.html;338.4956414941736;340.042779575495;352.33584692853964;363.028897698656;364.5843738138521;13414.731705365886;15434;16246.43137490188;16943.491695249162;17475.737863932052;16633.085180315076;16977.49067527976;17077.23152458139;17279.13604319782;17505.82494175058;4889.853304400874;5099.7705103270255;5114.258432527281;5281.524662780349;5880.794172203974;5833.912491312633;5865.736041878125;5872.354041055481;5908;5910.438508341701;5641.210230567704;5827;5909.084091965752;5949.8215053548465;5957.404259574051;5853.7365818538265;5866.589338746268;5878.853028674317;5897.705114744267;5940.821775346746;4617.5151609080895;4949.109160351135;4970.950290497085;5048.268001139814;5059.241113832954;11799.82300265488;12002.51989920402;12092.697682557919;12219.694507637292;12264.877351226463;1784.3130394797965;1799.9370022049166;1814.7096464565739;1836.0544319675378;1860.9162587683586;8290.544020078893;8470.364722645765;8922.86615700765;9269.165775080275;9286.349955503118;1539.6535779449534;1555.7199704053266;1562.945296914614;1613.5804690780365;1636.7790348302947;66450.3354966449;70729.29270707279;71685.28314716839;72048.37264855149;72973.9053914197;9726.416415015121;9878.604855805832;9887.505624718735;10104.141148002354;10241.129503992244;11877.22798018126;12187.634370968884;13755.862441375659;13834.169949802843;13871.930640346734;7124.251953544906;7246.347828695442;7275.490715649854;7330.157031941289;7534.660940257701;6999.23008469068;7054.118235220598;7107.111611048619;7166.104236970379;7219.855602887913;4204.327307630764;4272.530021697611;4276.444062271885;4386.0789234261165;4429.49060857999;1735.9913200433916;1777.8133296003991;1813.9727904081449;1814.637072585488;1838.981610183881;810.9918900811034;826.6770375245579;882.7881308485917;905.3029167540957;939.7603611079131;15928.955877282131;16536.917315413586;16768.077755723552;16908.577285567713;17123;828.705809437653;834.5118105907991;835.1731785532279;861.2291998661163;875.4615911214557;9172.587233574504;9343.766405839908;9378.249740020781;9543.904560954441;9658.420494770337;387445;388220;392461;397471;401541;51078.489215108115;51285;59187.70406147942;81470;83357.16642833615;907.9558507716047;911.6991392840347;918.0865039285953;933.6732143749633;934.4066517761134;15004.624884377541;15021.924890375478;15171.620709482351;15227.162506062274;15372.769408458658;29026.41947161003;33484.162895927795;35002.29995400129;36225.27549449049;36537;47136.29295560638;48595.75702121608;49089.509104908495;49169.2624610624;49253.78357973828;7540.3213710766295;7581;7704.036995375578;7710.306072453506;7885.2114788520685;11149.944250278697;11761.941190293994;11976.700582485159;12131.454084566392;12223.816642750187;10372;10436.269461137648;10529.526171322463;10622.628208012682;10724.571017159225;10299.279050466395;10360.378377297386;10488.68533943983;10495.737606559896;10595.894041059491;9988.750281243027;10151.89848101539;10629.521671524955;10637;10637.734056648645;7735.845283094419;7954;8089.312408445348;8121.512709237465;8127.268545830903;7784.455088143775;9846.409215446809;10192.439415832201;10336.793264134525;10344.948275258575 09:51:13 INFO - PROCESS | 23089 | |3;mootools.html;1324.5297919238667;1380.7238552289543;1398.4336343780767;1628.1208147600303;1628.421910221872;6616.172978377703;7437.479376443651;7466.104067511899;7969.481983671058;7970.282674559288;7720.768376948687;7755.146933837287;7829.9608501957555;7846.058472983235;7863.449558530905;2118.7245658064467;2143.882086485243;2148.806607405333;2150.8601940873873;2154.429076294783;2139.5079131799694;2168.761436242012;2183.770704076073;2186.5189658275153;2189.310367234324;2164.5779073080757;2164.8701077935298;2166.9891650541726;2172.1745736620064;2197.198022721711;2063.5253891604866;2063.649179639465;2067.945347872581;2070.4823794051485;2070.554830711389;2047.836173106148;2080.895955202249;2090.0908104974233;2091.1008266445424;2096.2663067926255;7660.2722741339485;7722.343600793939;7737.57443340616;7749.883751743729;7773.339266162383;4469.061497085583;4599.793009314589;4622.144903192887;4627.861164165047;4629.86110416688;2745.8215216011095;2803.1170181392795;2825.816321939067;2852.87162077707;2861.3561948561614;856.5802756649259;868.3313848336745;876.2070326354659;886.3928209176735;895.6104094718753;10482.63310784119;10533.947330263376;10556.47217639115;10601.628942987036;10706;4085.101277718897;4132.73137246078;4177.394277829698;4184.602462766033;4229.429027081366;8963.193312601898;8987.910120898838;9041.321900857462;9076.319276054322;9091.681791137278;4544.750038747835;4616.422947131608;4657.836975705834;4667.416572928384;4679.836205732851;3385.2213990782257;3931.783751893616;4057.5130984282073;4209.137126888981;4241.745495270294;3593.3352329819068;3630.8184590770356;3726.31063253299;3739.9439008414897;3859.710521710883;1116.2855772305732;1173.6889724223088;1178.3519064514483;1181.1377694283221;1185.5968970549882;791.0112359550562;793.2226418110168;796.884451754504;801.4990630855715;807.6971135824066;4866.975665121652;5056.064628043824;5106.131957567222;5198.454162312978;5242.213667949838;385.3987779064668;400.73751692641366;401.560291480828;403.1513663737848;410.29019795753516;3318.352921180395;3328.5340052392685;3359.8488068036995;3383.3233353329433;3385.8984230473125;9118.36171468004;9350.438973661601;9513.238940884712;9518.762030949281;9522;9254.768630784285;9335.859962100574;9535.952320238355;9536.094071063239;9537.666181683608;7186.56880587156;7203.495755297184;7213.1704853942465;7215.278472152848;7222.205557388683;4907.165781817028;5027.2207807789855;5166.793328266977;5198.532132108128;5250.789968401374;8275.213854683796;8276.83446331082;8307.792305192419;8368.41421100517;8565.528895910535;8283.95858020706;8479.745607631781;8503.914960850312;8509.957450212709;8573.614187361709;5726.198332233574;6131.96934015327;6180.876382472416;6216.409441103088;6454.031895215755;7353.191148973501;7380.151282602569;7439;7459.36595389398;7504;6430.935690643034;6559.836004099745;6666.533342665967;6695.7321707133115;6761.22245941723;6531.3468653134305;6642.070110184482;6659.833504162435;6704.128463299739;6750.966245168743;6097.908531371944;6148.047052706837;6151.169592105188;6185.381461853958;6191.535634827316;4184.225918205142;4307.138572285493;4338.479382473997;4368.716033457942;4384.4519435070615;4274.829006839816;4316.9352459713755;4346.7826608670075;4432.490263619596;4468.4414448193975 09:51:13 INFO - PROCESS | 23089 | |4;prototype.html;276.4843566748014;286.1929359207036;286.515788317743;290.7238123782407;291.33139444973784;4934.654574179809;4948.233023881296;4976.278439626252;5059.620528460367;5066.6706664066805;4948.208286674133;4957.132501812178;4981;4997.800087996476;5028.849134525961;3883.640650837027;3893.824777885002;3905.9609403905883;3913.4716813230275;3913.6477717005464;3658.8902332930056;3939.251542206986;3940.7044471664594;3943.6647884929816;3955.4857868477056;3786.924261514768;3791.2227993261317;3800.0879788850616;3805.46723458716;3820.923581528382;3796.1838204785968;3837.808109594523;3841.559415219293;3853.807309634507;3872.535295764498;3368.96631033689;3378.6621337866263;3380.222548813762;3383.3571621391857;3387.8814241501427;4821.180399332087;4945.851624451272;4998.525140111684;5052.216906379517;5059.241113832954;4375.737455752633;4397.230484665203;4397.758123303217;4402.625776808975;4409.338599210112;5203.661761985459;5222.817201397971;5239.5546378557865;5259.3951695555115;5261.815836445744;3583.2475180212186;3597.1726502904216;3678.337899178147;3695.7043436525014;3699.445083237509;5463.863403414906;5475.945240547583;5524.640898341595;5552.972235138839;5568.470995255485;3735.7945313007504;3759.6240375962734;3763.569843459468;3766.9246615067545;3791.559207501132;3817.1602247505502;3820.5357544384274;3827.1438352399064;3830.2339532093692;3834.578196398394;4300.51632186895;4343.435353404037;4356.978215108904;4361.454818147731;4374.387585737999;5162.896742065138;5241.947580524146;5266.289050978069;5276.472352764693;5290.550303224269;1199.6281152842646;1273.9490420383265;1302.785040468331;1306.9348480987965;1307.405130665545;795.2047952047952;805.693836342198;819.5410570080774;827.2472050434196;829.8132920093052;4228.302330115496;4230.915381692349;4241.321388577874;4260.403543503912;4276.935845962313;4827.696521939127;4852.733099679552;4858.392700912386;4896.681715688469;4904.190808516626;4194.65770953292;4232.449781528443;4238.809253583535;4243.68172387066;4289.056407590325;2480.255923223062;2577.8915066521577;2588.2235329401105;2596.9350766230996;2600.946616620272;4545.181867263925;4547.658925580595;4563.566461186182;4568.149899290726;4584.931226031612;4836.347093142381;4861.708297502161;4863.932828547853;4896.216605343128;4902.754862256873;4267.573242675708;4541.364209010741;4550.792865460249;4572.154151481986;4586.908261834811;4821.6383771218;4834.830780922651;4847.757612119451;4854.19905715553;4875.463698993037;4629.490756016903;4648.674592778473;4669.626429885669;4696;4711.31685905535;4375.431193944894;4413.7793110345;4523.276275795857;4524.208263553931;4594.356790049463;3340.8808049303757;3368.814715190688;3372.8650853966546;3374.915627109342;3388.4243826619754;4798.8560343188365;4800.255960326155;4807.927881081717;4833.879153021203;5223.973880130575;5188.974055129851;5251.606129540223;5290.576753859759;5298.70857102863;5315.681059136464;5256.579473642023;5299.258103865539;5304.204369344629;5305.867353316198;5320.467953204648;4936.975315123402;5179.378474583074;5213.635045546927;5215.869603259949;5224.817131400383;5290.391604965324;5313.574914006947;5316.0761581131;5349.251104845247;5358.651687640291;5235.083860324504;5249.973750131225;5266.814966632477;5310.7875684973715;5312.734363281743 09:51:13 INFO - PROCESS | 23089 | |5;yui.html;523.0532735748296;525.3197109742882;534.289395104511;545.868991442054;592.7480820651224;11276.661700148989;11457.885421145786;11545.365004924726;11608.12939029574;11729.296242225473;12078;12088.093392995517;12099.032077433807;12607.36963151841;12950.287734174617;611.9694015299217;754.294734423316;760.1903972269529;764.5680190692241;769.1731388757081;769.2154002917022;769.4844454215689;769.7883082152425;769.96920123195;777.6966982876683;813.8738495533172;821.7000794709918;823.3865770001357;824.9133840946704;826.8098337382405;816.1838161838161;816.346922462028;816.5876232502578;817.1787353709514;817.8446095241944;597.1580072098363;600.7867207141489;601.897677394844;603.044174982653;604.0787798607115;12489;12675.239485630891;12693.619191424272;12741.872581274161;12765.297908615023;12434.37828108591;12954.15797973138;13347;13873.37569809361;14021;10072.496375181285;10252;10526.842097368546;10587.047165755119;10713.946430267799;3304.621911209351;3335.933281334384;3354.412977728912;3362.7309815214726;3396.4735466002808;62240.06639900405;62509.68745156245;62678.37321626771;63053.684731576504;63327.36672633307;10155.39067655943;10250.231232657581;10361;10446;10553.208509361828;16792.160391980353;17362.3055077798;17397.739033914502;18138;18144.274229030954;6527.67361631926;6867.862642747117;6895.620740859201;7001.614911179832;7018.684159212848;3568.3933731265747;3603.1892824114366;3663.3955397359136;3666.9816650916573;3671.6511931366476;2769.127724766692;2857.1857020748985;2864.08349328213;2868.956965645517;2870.397216584499;482.01909114951604;482.5295337046422;485.5169106738747;491.26555799079887;492.9605631549467;420.60883378457714;523.602062432554;528.8149147798317;541.1666034307201;549.5630973376176;6609.966950165219;6720.22717387497;6750.222833042095;6810.659467026629;6918.688659010357;461.96073333767004;479.32175971000646;498.4093848789124;506.12693104394623;512.9615278854026;3167.176534101104;3193.1697758582472;3269.9346013079603;3278.3115545735186;3327.883524076694;54388.728056360254;92678;94532.52733736426;95770.52114739381;95801.5209923946;49870.75064624654;51100;52789;83951.16048839434;84826.5758671215;46248.3062754059;46695.06609867784;46765;47022.999999999316;47358;6343.270523889812;6375.884220261343;6535.379138981789;6688.632125232964;6716;43431.34852977271;44075.77962110169;44567.33149002832;45297.77351113223;47137.7643111796;60702;63536;64895.186005470634;64957.35042649702;65107.674461627386;8807.559622019002;8809.823803523765;8879.801226834554;8894.33292503052;8971.237444817263;9977.600895964371;10040.849387259343;10077.848832267375;10127.848082278919;10175.28772985884;8514.914850851412;8546.743597692079;8587.785305367415;8686.609102590524;8904.688335908211;9028.458292502472;9084.863727043967;9124.863127052966;9180.816383672423;9192.17270445663;8676.262517686067;8765.91234087651;8823.867641985247;8851.513166775632;8897.377183597086;7296.452766042462;7334.889976650461;7416.7404140854815;7598.886016709865;7873.881891771743;7348.595827229554;7497.175310715926;7683.961580192064;7751.6124193788955;7803.843923121392 09:51:13 INFO - PROCESS | 23089 | __end_tp_report 09:51:13 INFO - PROCESS | 23089 | __start_cc_report 09:51:13 INFO - PROCESS | 23089 | _x_x_mozilla_cycle_collect,403 09:51:13 INFO - PROCESS | 23089 | __end_cc_report 09:51:13 INFO - PROCESS | 23089 | __startTimestamp1465491073124__endTimestamp 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | ------- Summary: start ------- 09:51:13 INFO - PROCESS | 23089 | Number of tests: 6 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#0] dojo.html Cycles:165 Average:4720.98 Median:4844.49 stddev:501.92 (10.4%) stddev-sans-first:475.18 09:51:13 INFO - PROCESS | 23089 | Values: 2603.5 2639.1 2655.7 2667.3 2667.5 4714.5 4729.3 4787.6 4843.0 4874.7 4638.0 4739.1 4783.4 4837.5 4844.5 4313.7 4342.6 4364.7 4408.5 4444.0 4409.0 4463.9 4472.6 4472.7 4499.3 4267.4 4314.4 4318.7 4322.4 4359.4 4337.2 4345.9 4372.7 4395.5 4398.8 4368.0 4370.8 4379.1 4397.5 4419.9 4723.7 4784.4 4800.9 4818.9 4825.7 5116.6 5131.8 5142.3 5157.8 5173.8 5070.4 5118.9 5165.7 5167.9 5179.5 4804.0 4807.2 4807.3 4815.3 4826.4 5206.3 5210.4 5215.9 5233.7 5241.0 4831.0 5003.0 5010.3 5042.0 5077.7 4939.2 5020.3 5105.5 5119.0 5128.2 5007.4 5023.4 5028.3 5034.7 5037.5 4916.4 4961.1 5006.4 5057.1 5067.7 4229.3 4238.8 4271.5 4290.1 4302.7 3702.1 3707.6 3714.7 3753.5 3789.3 4376.7 4459.7 4503.4 4506.9 4523.8 5147.6 5166.6 5172.6 5183.1 5210.6 4473.8 4512.5 4515.4 4539.6 4554.1 4377.1 4545.4 4576.3 4577.6 4595.8 4831.6 4861.1 4878.2 4895.4 4935.2 5152.3 5159.0 5170.3 5176.7 5227.7 4588.6 4812.9 4839.7 4841.0 4842.1 5052.4 5054.9 5057.0 5072.1 5111.6 4878.1 5119.7 5132.8 5134.7 5136.9 4782.1 4953.7 4966.1 4976.3 4983.6 4956.9 5000.0 5002.8 5026.1 5028.9 4871.3 4938.1 4945.6 4956.7 4979.6 4742.8 4996.4 5016.5 5027.1 5036.4 4896.5 4936.7 4959.5 4964.9 4991.5 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#1] ext.html Cycles:180 Average:47886.80 Median:37032.22 stddev:88981.73 (240.3%) stddev-sans-first:89160.41 09:51:13 INFO - PROCESS | 23089 | Values: 564.2 570.1 580.9 587.7 592.2 33745.5 38227.4 38312.2 38325.8 38359.6 37292.4 37686.1 37774.6 37831.2 37975.4 7654.5 7736.6 7801.0 7814.6 7825.1 7603.8 7633.7 7687.9 7785.5 7793.2 7737.9 7760.8 7763.0 7772.1 7778.0 7705.1 7740.3 7746.6 7749.1 7770.5 7704.4 7788.9 7792.2 7795.9 7817.0 36780.0 36978.8 37165.0 37275.8 37398.3 2833.9 2906.4 2909.8 3020.7 3179.0 29053.3 29304.9 29788.9 29789.0 30539.8 2953.7 2961.5 2967.6 2977.0 3026.9 258590.0 258950.0 259875.0 259997.0 261079.0 26422.5 51290.7 51315.5 51603.5 51647.0 31682.4 31920.0 31926.7 31970.5 32136.8 13457.3 13649.0 13674.3 13682.5 13733.9 11276.1 11328.2 11338.5 11368.3 11378.9 7794.2 7814.9 7884.6 7888.4 7902.3 3056.0 3096.4 3108.0 3137.9 3158.8 812.0 852.0 859.6 915.3 949.1 28091.0 28187.3 28469.2 28488.4 28802.9 919.7 965.4 979.5 1001.9 1056.7 14820.3 15092.9 15121.2 15333.2 15361.6 374563.0 377930.0 379914.0 381340.0 384365.0 48634.0 48887.8 48950.5 48955.8 49120.0 1106.4 1169.1 1170.7 1172.7 1174.5 24033.0 27443.0 28941.7 30816.5 31469.2 47439.0 47736.0 48274.8 48290.3 48371.0 358254.0 358843.0 360770.0 360858.0 361533.0 37913.6 39552.8 39866.0 40001.6 40023.4 42159.4 42379.4 42891.4 43218.6 43591.3 36299.8 36934.1 37085.6 37275.4 37407.6 35959.8 36114.6 36131.8 36409.8 37533.6 30529.0 35966.3 36042.0 36506.0 39494.8 32339.8 33433.3 33899.8 34106.0 34171.5 25449.1 25846.5 25906.7 26077.5 26372.0 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#2] jquery.html Cycles:180 Average:23715.68 Median:47866.02 stddev:64772.53 (135.3%) stddev-sans-first:64930.45 09:51:13 INFO - PROCESS | 23089 | Values: 338.5 340.0 352.3 363.0 364.6 13414.7 15434.0 16246.4 16943.5 17475.7 16633.1 16977.5 17077.2 17279.1 17505.8 4889.9 5099.8 5114.3 5281.5 5880.8 5833.9 5865.7 5872.4 5908.0 5910.4 5641.2 5827.0 5909.1 5949.8 5957.4 5853.7 5866.6 5878.9 5897.7 5940.8 4617.5 4949.1 4971.0 5048.3 5059.2 11799.8 12002.5 12092.7 12219.7 12264.9 1784.3 1799.9 1814.7 1836.1 1860.9 8290.5 8470.4 8922.9 9269.2 9286.3 1539.7 1555.7 1562.9 1613.6 1636.8 66450.3 70729.3 71685.3 72048.4 72973.9 9726.4 9878.6 9887.5 10104.1 10241.1 11877.2 12187.6 13755.9 13834.2 13871.9 7124.3 7246.3 7275.5 7330.2 7534.7 6999.2 7054.1 7107.1 7166.1 7219.9 4204.3 4272.5 4276.4 4386.1 4429.5 1736.0 1777.8 1814.0 1814.6 1839.0 811.0 826.7 882.8 905.3 939.8 15929.0 16536.9 16768.1 16908.6 17123.0 828.7 834.5 835.2 861.2 875.5 9172.6 9343.8 9378.2 9543.9 9658.4 387445.0 388220.0 392461.0 397471.0 401541.0 51078.5 51285.0 59187.7 81470.0 83357.2 908.0 911.7 918.1 933.7 934.4 15004.6 15021.9 15171.6 15227.2 15372.8 29026.4 33484.2 35002.3 36225.3 36537.0 47136.3 48595.8 49089.5 49169.3 49253.8 7540.3 7581.0 7704.0 7710.3 7885.2 11149.9 11761.9 11976.7 12131.5 12223.8 10372.0 10436.3 10529.5 10622.6 10724.6 10299.3 10360.4 10488.7 10495.7 10595.9 9988.8 10151.9 10629.5 10637.0 10637.7 7735.8 7954.0 8089.3 8121.5 8127.3 7784.5 9846.4 10192.4 10336.8 10344.9 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#3] mootools.html Cycles:180 Average:4999.78 Median:4887.07 stddev:2831.26 (57.9%) stddev-sans-first:2825.73 09:51:13 INFO - PROCESS | 23089 | Values: 1324.5 1380.7 1398.4 1628.1 1628.4 6616.2 7437.5 7466.1 7969.5 7970.3 7720.8 7755.1 7830.0 7846.1 7863.4 2118.7 2143.9 2148.8 2150.9 2154.4 2139.5 2168.8 2183.8 2186.5 2189.3 2164.6 2164.9 2167.0 2172.2 2197.2 2063.5 2063.6 2067.9 2070.5 2070.6 2047.8 2080.9 2090.1 2091.1 2096.3 7660.3 7722.3 7737.6 7749.9 7773.3 4469.1 4599.8 4622.1 4627.9 4629.9 2745.8 2803.1 2825.8 2852.9 2861.4 856.6 868.3 876.2 886.4 895.6 10482.6 10533.9 10556.5 10601.6 10706.0 4085.1 4132.7 4177.4 4184.6 4229.4 8963.2 8987.9 9041.3 9076.3 9091.7 4544.8 4616.4 4657.8 4667.4 4679.8 3385.2 3931.8 4057.5 4209.1 4241.7 3593.3 3630.8 3726.3 3739.9 3859.7 1116.3 1173.7 1178.4 1181.1 1185.6 791.0 793.2 796.9 801.5 807.7 4867.0 5056.1 5106.1 5198.5 5242.2 385.4 400.7 401.6 403.2 410.3 3318.4 3328.5 3359.8 3383.3 3385.9 9118.4 9350.4 9513.2 9518.8 9522.0 9254.8 9335.9 9536.0 9536.1 9537.7 7186.6 7203.5 7213.2 7215.3 7222.2 4907.2 5027.2 5166.8 5198.5 5250.8 8275.2 8276.8 8307.8 8368.4 8565.5 8284.0 8479.7 8503.9 8510.0 8573.6 5726.2 6132.0 6180.9 6216.4 6454.0 7353.2 7380.2 7439.0 7459.4 7504.0 6430.9 6559.8 6666.5 6695.7 6761.2 6531.3 6642.1 6659.8 6704.1 6751.0 6097.9 6148.0 6151.2 6185.4 6191.5 4184.2 4307.1 4338.5 4368.7 4384.5 4274.8 4316.9 4346.8 4432.5 4468.4 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#4] prototype.html Cycles:180 Average:4182.82 Median:4570.15 stddev:1232.26 (27.0%) stddev-sans-first:1200.33 09:51:13 INFO - PROCESS | 23089 | Values: 276.5 286.2 286.5 290.7 291.3 4934.7 4948.2 4976.3 5059.6 5066.7 4948.2 4957.1 4981.0 4997.8 5028.8 3883.6 3893.8 3906.0 3913.5 3913.6 3658.9 3939.3 3940.7 3943.7 3955.5 3786.9 3791.2 3800.1 3805.5 3820.9 3796.2 3837.8 3841.6 3853.8 3872.5 3369.0 3378.7 3380.2 3383.4 3387.9 4821.2 4945.9 4998.5 5052.2 5059.2 4375.7 4397.2 4397.8 4402.6 4409.3 5203.7 5222.8 5239.6 5259.4 5261.8 3583.2 3597.2 3678.3 3695.7 3699.4 5463.9 5475.9 5524.6 5553.0 5568.5 3735.8 3759.6 3763.6 3766.9 3791.6 3817.2 3820.5 3827.1 3830.2 3834.6 4300.5 4343.4 4357.0 4361.5 4374.4 5162.9 5241.9 5266.3 5276.5 5290.6 1199.6 1273.9 1302.8 1306.9 1307.4 795.2 805.7 819.5 827.2 829.8 4228.3 4230.9 4241.3 4260.4 4276.9 4827.7 4852.7 4858.4 4896.7 4904.2 4194.7 4232.4 4238.8 4243.7 4289.1 2480.3 2577.9 2588.2 2596.9 2600.9 4545.2 4547.7 4563.6 4568.1 4584.9 4836.3 4861.7 4863.9 4896.2 4902.8 4267.6 4541.4 4550.8 4572.2 4586.9 4821.6 4834.8 4847.8 4854.2 4875.5 4629.5 4648.7 4669.6 4696.0 4711.3 4375.4 4413.8 4523.3 4524.2 4594.4 3340.9 3368.8 3372.9 3374.9 3388.4 4798.9 4800.3 4807.9 4833.9 5224.0 5189.0 5251.6 5290.6 5298.7 5315.7 5256.6 5299.3 5304.2 5305.9 5320.5 4937.0 5179.4 5213.6 5215.9 5224.8 5290.4 5313.6 5316.1 5349.3 5358.7 5235.1 5250.0 5266.8 5310.8 5312.7 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - PROCESS | 23089 | [#5] yui.html Cycles:180 Average:15482.27 Median:547.72 stddev:22205.60 (4054.2%) stddev-sans-first:22239.49 09:51:13 INFO - PROCESS | 23089 | Values: 523.1 525.3 534.3 545.9 592.7 11276.7 11457.9 11545.4 11608.1 11729.3 12078.0 12088.1 12099.0 12607.4 12950.3 612.0 754.3 760.2 764.6 769.2 769.2 769.5 769.8 770.0 777.7 813.9 821.7 823.4 824.9 826.8 816.2 816.3 816.6 817.2 817.8 597.2 600.8 601.9 603.0 604.1 12489.0 12675.2 12693.6 12741.9 12765.3 12434.4 12954.2 13347.0 13873.4 14021.0 10072.5 10252.0 10526.8 10587.0 10713.9 3304.6 3335.9 3354.4 3362.7 3396.5 62240.1 62509.7 62678.4 63053.7 63327.4 10155.4 10250.2 10361.0 10446.0 10553.2 16792.2 17362.3 17397.7 18138.0 18144.3 6527.7 6867.9 6895.6 7001.6 7018.7 3568.4 3603.2 3663.4 3667.0 3671.7 2769.1 2857.2 2864.1 2869.0 2870.4 482.0 482.5 485.5 491.3 493.0 420.6 523.6 528.8 541.2 549.6 6610.0 6720.2 6750.2 6810.7 6918.7 462.0 479.3 498.4 506.1 513.0 3167.2 3193.2 3269.9 3278.3 3327.9 54388.7 92678.0 94532.5 95770.5 95801.5 49870.8 51100.0 52789.0 83951.2 84826.6 46248.3 46695.1 46765.0 47023.0 47358.0 6343.3 6375.9 6535.4 6688.6 6716.0 43431.3 44075.8 44567.3 45297.8 47137.8 60702.0 63536.0 64895.2 64957.4 65107.7 8807.6 8809.8 8879.8 8894.3 8971.2 9977.6 10040.8 10077.8 10127.8 10175.3 8514.9 8546.7 8587.8 8686.6 8904.7 9028.5 9084.9 9124.9 9180.8 9192.2 8676.3 8765.9 8823.9 8851.5 8897.4 7296.5 7334.9 7416.7 7598.9 7873.9 7348.6 7497.2 7684.0 7751.6 7803.8 09:51:13 INFO - PROCESS | 23089 | -------- Summary: end -------- 09:51:13 INFO - PROCESS | 23089 | 09:51:13 INFO - TEST-INFO | 23089: exit 0 09:51:13 INFO - TEST-OK | dromaeo_css | took 1116784ms 09:51:13 INFO - TEST-START | kraken 09:51:13 INFO - operating with platform_type : linux_ 09:51:13 INFO - Initialising browser for kraken test... 09:51:13 INFO - TEST-INFO | started process 23325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbdT10/profile http://localhost:52682/getInfo.html) 09:51:19 INFO - PROCESS | 23325 | __metrics Screen width/height:1600/1200 09:51:19 INFO - PROCESS | 23325 | colorDepth:24 09:51:19 INFO - PROCESS | 23325 | Browser inner width/height: 1024/697 09:51:19 INFO - PROCESS | 23325 | __metrics 09:51:20 ERROR - PROCESS | 23325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:51:21 INFO - TEST-INFO | 23325: exit 0 09:51:21 INFO - Browser initialized. 09:51:21 INFO - Running cycle 1/1 for kraken test... 09:51:21 INFO - TEST-INFO | started process 23445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYbdT10/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:33 INFO - PROCESS | 23445 | RSS: Main: 186306560 09:51:33 INFO - PROCESS | 23445 | 09:51:35 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:36 INFO - PROCESS | 23445 | RSS: Main: 190201856 09:51:36 INFO - PROCESS | 23445 | 09:51:39 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-dft) 09:51:40 INFO - PROCESS | 23445 | RSS: Main: 190095360 09:51:40 INFO - PROCESS | 23445 | 09:51:43 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-fft) 09:51:43 INFO - PROCESS | 23445 | RSS: Main: 185659392 09:51:43 INFO - PROCESS | 23445 | 09:51:46 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52682/tests/kraken/driver.html?testName=audio-oscillator) 09:51:46 INFO - PROCESS | 23445 | RSS: Main: 186245120 09:51:46 INFO - PROCESS | 23445 | 09:51:48 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:49 INFO - PROCESS | 23445 | RSS: Main: 186085376 09:51:49 INFO - PROCESS | 23445 | 09:51:52 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:53 INFO - PROCESS | 23445 | RSS: Main: 186466304 09:51:53 INFO - PROCESS | 23445 | 09:51:56 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52682/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:57 INFO - PROCESS | 23445 | RSS: Main: 184176640 09:51:57 INFO - PROCESS | 23445 | 09:52:00 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52682/tests/kraken/driver.html?testName=json-parse-financial) 09:52:01 INFO - PROCESS | 23445 | RSS: Main: 185618432 09:52:01 INFO - PROCESS | 23445 | 09:52:02 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:03 INFO - PROCESS | 23445 | RSS: Main: 185860096 09:52:03 INFO - PROCESS | 23445 | 09:52:05 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:06 INFO - PROCESS | 23445 | RSS: Main: 186142720 09:52:06 INFO - PROCESS | 23445 | 09:52:08 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:09 INFO - PROCESS | 23445 | RSS: Main: 186695680 09:52:09 INFO - PROCESS | 23445 | 09:52:11 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:12 INFO - PROCESS | 23445 | RSS: Main: 186650624 09:52:12 INFO - PROCESS | 23445 | 09:52:15 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:15 INFO - PROCESS | 23445 | RSS: Main: 186241024 09:52:15 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | Cycle 1(1): loaded http://localhost:52682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52682/tests/kraken/driver.html?testName=ai-astar) 09:52:17 INFO - PROCESS | 23445 | RSS: Main: 187174912 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | __start_tp_report 09:52:17 INFO - PROCESS | 23445 | _x_x_mozilla_page_load 09:52:17 INFO - PROCESS | 23445 | _x_x_mozilla_page_load_details 09:52:17 INFO - PROCESS | 23445 | |i|pagename|runs| 09:52:17 INFO - PROCESS | 23445 | |0;ai-astar;115;109;117;116;117;114;113;113;114;113 09:52:17 INFO - PROCESS | 23445 | |1;audio-beat-detection;160;136;157;180;141;153;163;141;188;132 09:52:17 INFO - PROCESS | 23445 | |2;audio-dft;164;168;171;170;163;165;166;165;164;162 09:52:17 INFO - PROCESS | 23445 | |3;audio-fft;76;75;77;151;76;76;76;76;160;76 09:52:17 INFO - PROCESS | 23445 | |4;audio-oscillator;88;88;157;89;86;86;128;86;87;130 09:52:17 INFO - PROCESS | 23445 | |5;imaging-gaussian-blur;118;118;118;118;118;119;122;120;119;119 09:52:17 INFO - PROCESS | 23445 | |6;imaging-darkroom;149;149;148;148;147;148;147;148;148;146 09:52:17 INFO - PROCESS | 23445 | |7;imaging-desaturate;96;96;97;95;96;98;96;96;96;96 09:52:17 INFO - PROCESS | 23445 | |8;json-parse-financial;65;64;65;64;65;65;63;64;64;64 09:52:17 INFO - PROCESS | 23445 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;64;65;65 09:52:17 INFO - PROCESS | 23445 | |10;stanford-crypto-aes;84;89;85;84;88;86;86;85;108;86 09:52:17 INFO - PROCESS | 23445 | |11;stanford-crypto-ccm;135;147;148;146;131;142;134;136;138;139 09:52:17 INFO - PROCESS | 23445 | |12;stanford-crypto-pbkdf2;171;168;171;167;171;165;173;168;168;167 09:52:17 INFO - PROCESS | 23445 | |13;stanford-crypto-sha256-iterative;69;70;67;68;70;68;67;67;68;65 09:52:17 INFO - PROCESS | 23445 | __end_tp_report 09:52:17 INFO - PROCESS | 23445 | __start_cc_report 09:52:17 INFO - PROCESS | 23445 | _x_x_mozilla_cycle_collect,984 09:52:17 INFO - PROCESS | 23445 | __end_cc_report 09:52:17 INFO - PROCESS | 23445 | __startTimestamp1465491137973__endTimestamp 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | ------- Summary: start ------- 09:52:17 INFO - PROCESS | 23445 | Number of tests: 14 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:2.38 (2.1%) stddev-sans-first:2.50 09:52:17 INFO - PROCESS | 23445 | Values: 115.0 109.0 117.0 116.0 117.0 114.0 113.0 113.0 114.0 113.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:158.50 stddev:18.54 (11.7%) stddev-sans-first:19.58 09:52:17 INFO - PROCESS | 23445 | Values: 160.0 136.0 157.0 180.0 141.0 153.0 163.0 141.0 188.0 132.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:2.97 (1.8%) stddev-sans-first:3.08 09:52:17 INFO - PROCESS | 23445 | Values: 164.0 168.0 171.0 170.0 163.0 165.0 166.0 165.0 164.0 162.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#3] audio-fft Cycles:10 Average:91.90 Median:76.00 stddev:33.59 (44.2%) stddev-sans-first:35.13 09:52:17 INFO - PROCESS | 23445 | Values: 76.0 75.0 77.0 151.0 76.0 76.0 76.0 76.0 160.0 76.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:86.50 stddev:25.90 (29.9%) stddev-sans-first:26.93 09:52:17 INFO - PROCESS | 23445 | Values: 88.0 88.0 157.0 89.0 86.0 86.0 128.0 86.0 87.0 130.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 09:52:17 INFO - PROCESS | 23445 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 122.0 120.0 119.0 119.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 09:52:17 INFO - PROCESS | 23445 | Values: 149.0 149.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 146.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:52:17 INFO - PROCESS | 23445 | Values: 96.0 96.0 97.0 95.0 96.0 98.0 96.0 96.0 96.0 96.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 09:52:17 INFO - PROCESS | 23445 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 63.0 64.0 64.0 64.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 09:52:17 INFO - PROCESS | 23445 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:7.17 (8.3%) stddev-sans-first:7.45 09:52:17 INFO - PROCESS | 23445 | Values: 84.0 89.0 85.0 84.0 88.0 86.0 86.0 85.0 108.0 86.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:140.50 stddev:5.91 (4.2%) stddev-sans-first:6.03 09:52:17 INFO - PROCESS | 23445 | Values: 135.0 147.0 148.0 146.0 131.0 142.0 134.0 136.0 138.0 139.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.50 stddev:2.47 (1.5%) stddev-sans-first:2.50 09:52:17 INFO - PROCESS | 23445 | Values: 171.0 168.0 171.0 167.0 171.0 165.0 173.0 168.0 168.0 167.0 09:52:17 INFO - PROCESS | 23445 | 09:52:17 INFO - PROCESS | 23445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.56 09:52:17 INFO - PROCESS | 23445 | Values: 69.0 70.0 67.0 68.0 70.0 68.0 67.0 67.0 68.0 65.0 09:52:17 INFO - PROCESS | 23445 | -------- Summary: end -------- 09:52:17 INFO - PROCESS | 23445 | 09:52:19 INFO - TEST-INFO | 23445: exit 0 09:52:19 INFO - TEST-OK | kraken | took 65108ms 09:52:19 INFO - SUITE-END | took 1181s 09:52:19 INFO - Completed test suite (00:19:41) 09:52:19 INFO - javascript benchmark 09:52:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6158.593990921446, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.518349105416, 2639.142278759404, 2655.654764880566, 2667.293167310664, 2667.4931762965034, 4714.481407045227, 4729.29060640904, 4787.569118779309, 4842.951570484294, 4874.683145595543, 4637.976810115944, 4739.052189562084, 4783.402074740658, 4837.540433658805, 4844.4913284105105, 4313.741175529471, 4342.630876375496, 4364.738115713068, 4408.470983481987, 4443.977780111095, 4409.0, 4463.888402789924, 4472.575105364985, 4472.686911916167, 4499.302608095734, 4267.445232119836, 4314.374415709704, 4318.69769116162, 4322.351647252905, 4359.433273674402, 4337.240982828024, 4345.9130817383475, 4372.693911426201, 4395.4725432947935, 4398.8020539075815, 4367.956320436819, 4370.759608221547, 4379.08039311745, 4397.494288156871, 4419.9337009944875, 4723.669343145981, 4784.425868895755, 4800.879978000578, 4818.927716084261, 4825.734584597846, 5116.616253780944, 5131.820386286462, 5142.331496905378, 5157.819476318348, 5173.8189163379475, 5070.416902056274, 5118.872028199287, 5165.690058596496, 5167.948320516822, 5179.456157103487, 4804.0, 4807.158747219222, 4807.254875494304, 4815.253635686474, 4826.396700412449, 5206.297149884717, 5210.374755029421, 5215.921761173586, 5233.685978841282, 5240.978009288228, 4831.0, 5002.974985125051, 5010.323606313101, 5041.974790126099, 5077.720725360141, 4939.160342741742, 5020.347354843847, 5105.5149760772665, 5118.97440512795, 5128.205128205134, 5007.4491805901325, 5023.372078490189, 5028.32117664118, 5034.697918124924, 5037.471065538139, 4916.385451818523, 4961.05739909416, 5006.3992320921725, 5057.115004874132, 5067.695938243717, 4229.2598795210715, 4238.809253583596, 4271.508776490743, 4290.120525292307, 4302.720323179046, 3702.0559757262263, 3707.5550933888107, 3714.665680088805, 3753.474513568103, 3789.2610940866816, 4376.693631445832, 4459.687821852439, 4503.414556107685, 4506.864794056183, 4523.751193684379, 5147.613928955343, 5166.638335316492, 5172.586193104543, 5183.0670479314085, 5210.635255532076, 4473.7986790594505, 4512.481064677539, 4515.435570553681, 4539.614132798749, 4554.0891821635805, 4377.146456441027, 4545.36364908913, 4576.336431217454, 4577.5880170784785, 4595.770211489412, 4831.613470922248, 4861.076395484846, 4878.219484882473, 4895.363602731693, 4935.235038569028, 5152.27868098459, 5159.0, 5170.27616133734, 5176.741162941913, 5227.738613069408, 4588.632909367309, 4812.903741925212, 4839.685420447659, 4840.975795121002, 4842.128416884994, 5052.418971818288, 5054.924176137288, 5056.974715126401, 5072.112380333353, 5111.565516930954, 4878.0975519529, 5119.718415487184, 5132.8460146195675, 5134.7175905324075, 5136.948630513647, 4782.067496838084, 4953.72754498506, 4966.056449274626, 4976.253561965589, 4983.626228032839, 4956.900861982668, 5000.049990501793, 5002.824901128443, 5026.095302845523, 5028.899422011466, 4871.293662418859, 4938.08645400602, 4945.6043516517875, 4956.6530342877095, 4979.626528010486, 4742.762861856962, 4996.350474438445, 5016.523430274118, 5027.145385284583, 5036.395632524121, 4896.534829191221, 4936.703797772145, 4959.504049595156, 4964.925526117184, 4991.450940396481], "value": 4688.383955741968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2016546586581, 570.1277046119436, 580.9419058094192, 587.6738410182347, 592.200529285465, 33745.493817592724, 38227.42658860119, 38312.23375532488, 38325.80837095814, 38359.61640383596, 37292.440613390754, 37686.0578485538, 37774.62225377745, 37831.24337513255, 37975.430368544425, 7654.54072755635, 7736.613169341538, 7800.960995195016, 7814.648340824648, 7825.13923468418, 7603.80990475237, 7633.732819351324, 7687.884681729778, 7785.532868027908, 7793.181715919832, 7737.883931741028, 7760.805979850493, 7763.0, 7772.106207786092, 7777.961110194441, 7705.075390953066, 7740.26467485588, 7746.573938433356, 7749.0701115865895, 7770.49491783038, 7704.422168337397, 7788.922110778876, 7792.220777922219, 7795.9220407795765, 7816.960915195445, 36780.0, 36978.815105924295, 37165.0, 37275.81362093199, 37398.25203495942, 2833.914982550527, 2906.433245517104, 2909.7526710229654, 3020.6828283030186, 3179.0, 29053.273668158254, 29304.853475732485, 29788.8510557448, 29789.0, 30539.847300763577, 2953.7489313408173, 2961.526155815081, 2967.614210152688, 2977.032464449063, 3026.8637911294045, 258590.0, 258950.0, 259875.0, 259997.0, 261079.0, 26422.47155056888, 51290.74354628203, 51315.48684513107, 51603.48396515987, 51647.0, 31682.366352672816, 31920.0, 31926.680733192836, 31970.520442193385, 32136.83931580327, 13457.327133643279, 13649.0, 13674.31628418575, 13682.52111176104, 13733.931330343485, 11276.097912167006, 11328.150388720878, 11338.489767960462, 11368.317900925971, 11378.943105284587, 7794.22057794216, 7814.921850781419, 7884.64519096642, 7888.40836937232, 7902.328302094272, 3055.9847200764298, 3096.3617749144664, 3108.020973393374, 3137.905862824119, 3158.842057897142, 812.0215140755375, 851.9659213631385, 859.6088779605265, 915.3135148638521, 949.1215154107891, 28091.0, 28187.295317617223, 28469.231113164475, 28488.430231395258, 28802.855985719936, 919.7148883846029, 965.3676841668719, 979.5494072726625, 1001.8878301844711, 1056.7041228456044, 14820.25898705082, 15092.924535377473, 15121.16833574164, 15333.233338333039, 15361.6159596011, 374563.0, 377930.0, 379914.0, 381340.0, 384365.0, 48634.0, 48887.755561221966, 48950.51049489531, 48955.755221224375, 49120.0, 1106.4025426269725, 1169.140681599024, 1170.6839153428698, 1172.695099274178, 1174.4949671641277, 24033.0, 27443.0, 28941.710582893902, 30816.53775193419, 31469.213269668442, 47439.0, 47736.0, 48274.75862620665, 48290.27564586464, 48371.0, 358254.0, 358843.0, 360770.0, 360858.0, 361533.0, 37913.620863792115, 39552.80223598864, 39866.003349916486, 40001.59998399979, 40023.39964900587, 42159.36760948649, 42379.364309535995, 42891.35423489039, 43218.56781432145, 43591.34612980745, 36299.81850090733, 36934.07664808294, 37085.629143709295, 37275.44086838645, 37407.6259237415, 35959.82020089883, 36114.638853611126, 36131.81934090313, 36409.817950911136, 37533.62466375301, 30529.0, 35966.280674386886, 36042.0, 36506.0, 39494.80252598719, 32339.838300808344, 33433.33133337271, 33899.83050084734, 34106.0, 34171.48742768811, 25449.10928117507, 25846.483070338865, 25906.740932591187, 26077.478450430506, 26372.0], "value": 16638.167942872322, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4956414941736, 340.042779575495, 352.33584692853964, 363.028897698656, 364.5843738138521, 13414.731705365886, 15434.0, 16246.43137490188, 16943.491695249162, 17475.737863932052, 16633.085180315076, 16977.49067527976, 17077.23152458139, 17279.13604319782, 17505.82494175058, 4889.853304400874, 5099.7705103270255, 5114.258432527281, 5281.524662780349, 5880.794172203974, 5833.912491312633, 5865.736041878125, 5872.354041055481, 5908.0, 5910.438508341701, 5641.210230567704, 5827.0, 5909.084091965752, 5949.8215053548465, 5957.404259574051, 5853.7365818538265, 5866.589338746268, 5878.853028674317, 5897.705114744267, 5940.821775346746, 4617.5151609080895, 4949.109160351135, 4970.950290497085, 5048.268001139814, 5059.241113832954, 11799.82300265488, 12002.51989920402, 12092.697682557919, 12219.694507637292, 12264.877351226463, 1784.3130394797965, 1799.9370022049166, 1814.7096464565739, 1836.0544319675378, 1860.9162587683586, 8290.544020078893, 8470.364722645765, 8922.86615700765, 9269.165775080275, 9286.349955503118, 1539.6535779449534, 1555.7199704053266, 1562.945296914614, 1613.5804690780365, 1636.7790348302947, 66450.3354966449, 70729.29270707279, 71685.28314716839, 72048.37264855149, 72973.9053914197, 9726.416415015121, 9878.604855805832, 9887.505624718735, 10104.141148002354, 10241.129503992244, 11877.22798018126, 12187.634370968884, 13755.862441375659, 13834.169949802843, 13871.930640346734, 7124.251953544906, 7246.347828695442, 7275.490715649854, 7330.157031941289, 7534.660940257701, 6999.23008469068, 7054.118235220598, 7107.111611048619, 7166.104236970379, 7219.855602887913, 4204.327307630764, 4272.530021697611, 4276.444062271885, 4386.0789234261165, 4429.49060857999, 1735.9913200433916, 1777.8133296003991, 1813.9727904081449, 1814.637072585488, 1838.981610183881, 810.9918900811034, 826.6770375245579, 882.7881308485917, 905.3029167540957, 939.7603611079131, 15928.955877282131, 16536.917315413586, 16768.077755723552, 16908.577285567713, 17123.0, 828.705809437653, 834.5118105907991, 835.1731785532279, 861.2291998661163, 875.4615911214557, 9172.587233574504, 9343.766405839908, 9378.249740020781, 9543.904560954441, 9658.420494770337, 387445.0, 388220.0, 392461.0, 397471.0, 401541.0, 51078.489215108115, 51285.0, 59187.70406147942, 81470.0, 83357.16642833615, 907.9558507716047, 911.6991392840347, 918.0865039285953, 933.6732143749633, 934.4066517761134, 15004.624884377541, 15021.924890375478, 15171.620709482351, 15227.162506062274, 15372.769408458658, 29026.41947161003, 33484.162895927795, 35002.29995400129, 36225.27549449049, 36537.0, 47136.29295560638, 48595.75702121608, 49089.509104908495, 49169.2624610624, 49253.78357973828, 7540.3213710766295, 7581.0, 7704.036995375578, 7710.306072453506, 7885.2114788520685, 11149.944250278697, 11761.941190293994, 11976.700582485159, 12131.454084566392, 12223.816642750187, 10372.0, 10436.269461137648, 10529.526171322463, 10622.628208012682, 10724.571017159225, 10299.279050466395, 10360.378377297386, 10488.68533943983, 10495.737606559896, 10595.894041059491, 9988.750281243027, 10151.89848101539, 10629.521671524955, 10637.0, 10637.734056648645, 7735.845283094419, 7954.0, 8089.312408445348, 8121.512709237465, 8127.268545830903, 7784.455088143775, 9846.409215446809, 10192.439415832201, 10336.793264134525, 10344.948275258575], "value": 7998.62216240599, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.5297919238667, 1380.7238552289543, 1398.4336343780767, 1628.1208147600303, 1628.421910221872, 6616.172978377703, 7437.479376443651, 7466.104067511899, 7969.481983671058, 7970.282674559288, 7720.768376948687, 7755.146933837287, 7829.9608501957555, 7846.058472983235, 7863.449558530905, 2118.7245658064467, 2143.882086485243, 2148.806607405333, 2150.8601940873873, 2154.429076294783, 2139.5079131799694, 2168.761436242012, 2183.770704076073, 2186.5189658275153, 2189.310367234324, 2164.5779073080757, 2164.8701077935298, 2166.9891650541726, 2172.1745736620064, 2197.198022721711, 2063.5253891604866, 2063.649179639465, 2067.945347872581, 2070.4823794051485, 2070.554830711389, 2047.836173106148, 2080.895955202249, 2090.0908104974233, 2091.1008266445424, 2096.2663067926255, 7660.2722741339485, 7722.343600793939, 7737.57443340616, 7749.883751743729, 7773.339266162383, 4469.061497085583, 4599.793009314589, 4622.144903192887, 4627.861164165047, 4629.86110416688, 2745.8215216011095, 2803.1170181392795, 2825.816321939067, 2852.87162077707, 2861.3561948561614, 856.5802756649259, 868.3313848336745, 876.2070326354659, 886.3928209176735, 895.6104094718753, 10482.63310784119, 10533.947330263376, 10556.47217639115, 10601.628942987036, 10706.0, 4085.101277718897, 4132.73137246078, 4177.394277829698, 4184.602462766033, 4229.429027081366, 8963.193312601898, 8987.910120898838, 9041.321900857462, 9076.319276054322, 9091.681791137278, 4544.750038747835, 4616.422947131608, 4657.836975705834, 4667.416572928384, 4679.836205732851, 3385.2213990782257, 3931.783751893616, 4057.5130984282073, 4209.137126888981, 4241.745495270294, 3593.3352329819068, 3630.8184590770356, 3726.31063253299, 3739.9439008414897, 3859.710521710883, 1116.2855772305732, 1173.6889724223088, 1178.3519064514483, 1181.1377694283221, 1185.5968970549882, 791.0112359550562, 793.2226418110168, 796.884451754504, 801.4990630855715, 807.6971135824066, 4866.975665121652, 5056.064628043824, 5106.131957567222, 5198.454162312978, 5242.213667949838, 385.3987779064668, 400.73751692641366, 401.560291480828, 403.1513663737848, 410.29019795753516, 3318.352921180395, 3328.5340052392685, 3359.8488068036995, 3383.3233353329433, 3385.8984230473125, 9118.36171468004, 9350.438973661601, 9513.238940884712, 9518.762030949281, 9522.0, 9254.768630784285, 9335.859962100574, 9535.952320238355, 9536.094071063239, 9537.666181683608, 7186.56880587156, 7203.495755297184, 7213.1704853942465, 7215.278472152848, 7222.205557388683, 4907.165781817028, 5027.2207807789855, 5166.793328266977, 5198.532132108128, 5250.789968401374, 8275.213854683796, 8276.83446331082, 8307.792305192419, 8368.41421100517, 8565.528895910535, 8283.95858020706, 8479.745607631781, 8503.914960850312, 8509.957450212709, 8573.614187361709, 5726.198332233574, 6131.96934015327, 6180.876382472416, 6216.409441103088, 6454.031895215755, 7353.191148973501, 7380.151282602569, 7439.0, 7459.36595389398, 7504.0, 6430.935690643034, 6559.836004099745, 6666.533342665967, 6695.7321707133115, 6761.22245941723, 6531.3468653134305, 6642.070110184482, 6659.833504162435, 6704.128463299739, 6750.966245168743, 6097.908531371944, 6148.047052706837, 6151.169592105188, 6185.381461853958, 6191.535634827316, 4184.225918205142, 4307.138572285493, 4338.479382473997, 4368.716033457942, 4384.4519435070615, 4274.829006839816, 4316.9352459713755, 4346.7826608670075, 4432.490263619596, 4468.4414448193975], "value": 3952.698392526948, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.4843566748014, 286.1929359207036, 286.515788317743, 290.7238123782407, 291.33139444973784, 4934.654574179809, 4948.233023881296, 4976.278439626252, 5059.620528460367, 5066.6706664066805, 4948.208286674133, 4957.132501812178, 4981.0, 4997.800087996476, 5028.849134525961, 3883.640650837027, 3893.824777885002, 3905.9609403905883, 3913.4716813230275, 3913.6477717005464, 3658.8902332930056, 3939.251542206986, 3940.7044471664594, 3943.6647884929816, 3955.4857868477056, 3786.924261514768, 3791.2227993261317, 3800.0879788850616, 3805.46723458716, 3820.923581528382, 3796.1838204785968, 3837.808109594523, 3841.559415219293, 3853.807309634507, 3872.535295764498, 3368.96631033689, 3378.6621337866263, 3380.222548813762, 3383.3571621391857, 3387.8814241501427, 4821.180399332087, 4945.851624451272, 4998.525140111684, 5052.216906379517, 5059.241113832954, 4375.737455752633, 4397.230484665203, 4397.758123303217, 4402.625776808975, 4409.338599210112, 5203.661761985459, 5222.817201397971, 5239.5546378557865, 5259.3951695555115, 5261.815836445744, 3583.2475180212186, 3597.1726502904216, 3678.337899178147, 3695.7043436525014, 3699.445083237509, 5463.863403414906, 5475.945240547583, 5524.640898341595, 5552.972235138839, 5568.470995255485, 3735.7945313007504, 3759.6240375962734, 3763.569843459468, 3766.9246615067545, 3791.559207501132, 3817.1602247505502, 3820.5357544384274, 3827.1438352399064, 3830.2339532093692, 3834.578196398394, 4300.51632186895, 4343.435353404037, 4356.978215108904, 4361.454818147731, 4374.387585737999, 5162.896742065138, 5241.947580524146, 5266.289050978069, 5276.472352764693, 5290.550303224269, 1199.6281152842646, 1273.9490420383265, 1302.785040468331, 1306.9348480987965, 1307.405130665545, 795.2047952047952, 805.693836342198, 819.5410570080774, 827.2472050434196, 829.8132920093052, 4228.302330115496, 4230.915381692349, 4241.321388577874, 4260.403543503912, 4276.935845962313, 4827.696521939127, 4852.733099679552, 4858.392700912386, 4896.681715688469, 4904.190808516626, 4194.65770953292, 4232.449781528443, 4238.809253583535, 4243.68172387066, 4289.056407590325, 2480.255923223062, 2577.8915066521577, 2588.2235329401105, 2596.9350766230996, 2600.946616620272, 4545.181867263925, 4547.658925580595, 4563.566461186182, 4568.149899290726, 4584.931226031612, 4836.347093142381, 4861.708297502161, 4863.932828547853, 4896.216605343128, 4902.754862256873, 4267.573242675708, 4541.364209010741, 4550.792865460249, 4572.154151481986, 4586.908261834811, 4821.6383771218, 4834.830780922651, 4847.757612119451, 4854.19905715553, 4875.463698993037, 4629.490756016903, 4648.674592778473, 4669.626429885669, 4696.0, 4711.31685905535, 4375.431193944894, 4413.7793110345, 4523.276275795857, 4524.208263553931, 4594.356790049463, 3340.8808049303757, 3368.814715190688, 3372.8650853966546, 3374.915627109342, 3388.4243826619754, 4798.8560343188365, 4800.255960326155, 4807.927881081717, 4833.879153021203, 5223.973880130575, 5188.974055129851, 5251.606129540223, 5290.576753859759, 5298.70857102863, 5315.681059136464, 5256.579473642023, 5299.258103865539, 5304.204369344629, 5305.867353316198, 5320.467953204648, 4936.975315123402, 5179.378474583074, 5213.635045546927, 5215.869603259949, 5224.817131400383, 5290.391604965324, 5313.574914006947, 5316.0761581131, 5349.251104845247, 5358.651687640291, 5235.083860324504, 5249.973750131225, 5266.814966632477, 5310.7875684973715, 5312.734363281743], "value": 3784.830039673452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.0532735748296, 525.3197109742882, 534.289395104511, 545.868991442054, 592.7480820651224, 11276.661700148989, 11457.885421145786, 11545.365004924726, 11608.12939029574, 11729.296242225473, 12078.0, 12088.093392995517, 12099.032077433807, 12607.36963151841, 12950.287734174617, 611.9694015299217, 754.294734423316, 760.1903972269529, 764.5680190692241, 769.1731388757081, 769.2154002917022, 769.4844454215689, 769.7883082152425, 769.96920123195, 777.6966982876683, 813.8738495533172, 821.7000794709918, 823.3865770001357, 824.9133840946704, 826.8098337382405, 816.1838161838161, 816.346922462028, 816.5876232502578, 817.1787353709514, 817.8446095241944, 597.1580072098363, 600.7867207141489, 601.897677394844, 603.044174982653, 604.0787798607115, 12489.0, 12675.239485630891, 12693.619191424272, 12741.872581274161, 12765.297908615023, 12434.37828108591, 12954.15797973138, 13347.0, 13873.37569809361, 14021.0, 10072.496375181285, 10252.0, 10526.842097368546, 10587.047165755119, 10713.946430267799, 3304.621911209351, 3335.933281334384, 3354.412977728912, 3362.7309815214726, 3396.4735466002808, 62240.06639900405, 62509.68745156245, 62678.37321626771, 63053.684731576504, 63327.36672633307, 10155.39067655943, 10250.231232657581, 10361.0, 10446.0, 10553.208509361828, 16792.160391980353, 17362.3055077798, 17397.739033914502, 18138.0, 18144.274229030954, 6527.67361631926, 6867.862642747117, 6895.620740859201, 7001.614911179832, 7018.684159212848, 3568.3933731265747, 3603.1892824114366, 3663.3955397359136, 3666.9816650916573, 3671.6511931366476, 2769.127724766692, 2857.1857020748985, 2864.08349328213, 2868.956965645517, 2870.397216584499, 482.01909114951604, 482.5295337046422, 485.5169106738747, 491.26555799079887, 492.9605631549467, 420.60883378457714, 523.602062432554, 528.8149147798317, 541.1666034307201, 549.5630973376176, 6609.966950165219, 6720.22717387497, 6750.222833042095, 6810.659467026629, 6918.688659010357, 461.96073333767004, 479.32175971000646, 498.4093848789124, 506.12693104394623, 512.9615278854026, 3167.176534101104, 3193.1697758582472, 3269.9346013079603, 3278.3115545735186, 3327.883524076694, 54388.728056360254, 92678.0, 94532.52733736426, 95770.52114739381, 95801.5209923946, 49870.75064624654, 51100.0, 52789.0, 83951.16048839434, 84826.5758671215, 46248.3062754059, 46695.06609867784, 46765.0, 47022.999999999316, 47358.0, 6343.270523889812, 6375.884220261343, 6535.379138981789, 6688.632125232964, 6716.0, 43431.34852977271, 44075.77962110169, 44567.33149002832, 45297.77351113223, 47137.7643111796, 60702.0, 63536.0, 64895.186005470634, 64957.35042649702, 65107.674461627386, 8807.559622019002, 8809.823803523765, 8879.801226834554, 8894.33292503052, 8971.237444817263, 9977.600895964371, 10040.849387259343, 10077.848832267375, 10127.848082278919, 10175.28772985884, 8514.914850851412, 8546.743597692079, 8587.785305367415, 8686.609102590524, 8904.688335908211, 9028.458292502472, 9084.863727043967, 9124.863127052966, 9180.816383672423, 9192.17270445663, 8676.262517686067, 8765.91234087651, 8823.867641985247, 8851.513166775632, 8897.377183597086, 7296.452766042462, 7334.889976650461, 7416.7404140854815, 7598.886016709865, 7873.881891771743, 7348.595827229554, 7497.175310715926, 7683.961580192064, 7751.6124193788955, 7803.843923121392], "value": 5844.625615023453, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 117.0, 116.0, 117.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 136.0, 157.0, 180.0, 141.0, 153.0, 163.0, 141.0, 188.0, 132.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 171.0, 170.0, 163.0, 165.0, 166.0, 165.0, 164.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 151.0, 76.0, 76.0, 76.0, 76.0, 160.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 157.0, 89.0, 86.0, 86.0, 128.0, 86.0, 87.0, 130.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 122.0, 120.0, 119.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 85.0, 84.0, 88.0, 86.0, 86.0, 85.0, 108.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 147.0, 148.0, 146.0, 131.0, 142.0, 134.0, 136.0, 138.0, 139.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 171.0, 167.0, 171.0, 165.0, 173.0, 168.0, 168.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 68.0, 70.0, 68.0, 67.0, 67.0, 68.0, 65.0], "value": 67.9, "unit": "score"}]}]} 09:52:19 INFO - Return code: 0 09:52:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:19 ERROR - # TBPL SUCCESS # 09:52:19 INFO - Running post-action listener: _resource_record_post_action 09:52:19 INFO - ##### 09:52:19 INFO - ##### Finished run-tests step (success) 09:52:19 INFO - ##### 09:52:19 INFO - Running post-run listener: _resource_record_post_run 09:52:19 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 533876736; Read time: 8; Write time: 474512 09:52:19 INFO - TinderboxPrint: CPU usage
13.5% 09:52:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:52:19 INFO - TinderboxPrint: I/O write bytes / time
533,876,736 / 474,512 09:52:19 INFO - TinderboxPrint: CPU idle
8,267.5 (86.4%) 09:52:19 INFO - TinderboxPrint: CPU user
1,238.8 (13.0%) 09:52:19 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:19 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238129152; Read time: 0; Write time: 258104 09:52:19 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 4096; Write bytes: 295747584; Read time: 8; Write time: 216408 09:52:19 INFO - Running post-run listener: _upload_blobber_files 09:52:19 INFO - Blob upload gear active. 09:52:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:19 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 09:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:21 INFO - (blobuploader) - INFO - Done attempting. 09:52:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:52:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:24 INFO - (blobuploader) - INFO - Done attempting. 09:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:25 INFO - (blobuploader) - INFO - Done attempting. 09:52:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:25 INFO - Return code: 0 09:52:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/164522ba3d986356a8816fa73e54894b16673da7b38cddaca452208582c7ad3057b5e5bb3d7acbe6193c06a1f9c4d718fb8adeb90eff56a33094362886d031b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992e857afe763469bcf49fb15533a14b50a644b4eaa3f1cc7834b05189f95200c93296a7673711c5aa210b64646a836d4fec7ae0d76ea83848aa86e1c4f57bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d122a21316b67ba438df0c127a7d1cf0424daa02e5647ba1d516a75b65cffc2b3735572e506b177641616c6a594bb0c015633af1c387c89209b4a1a87c9e53f2"} 09:52:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:25 INFO - Contents: 09:52:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/164522ba3d986356a8816fa73e54894b16673da7b38cddaca452208582c7ad3057b5e5bb3d7acbe6193c06a1f9c4d718fb8adeb90eff56a33094362886d031b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992e857afe763469bcf49fb15533a14b50a644b4eaa3f1cc7834b05189f95200c93296a7673711c5aa210b64646a836d4fec7ae0d76ea83848aa86e1c4f57bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d122a21316b67ba438df0c127a7d1cf0424daa02e5647ba1d516a75b65cffc2b3735572e506b177641616c6a594bb0c015633af1c387c89209b4a1a87c9e53f2"} 09:52:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:25 INFO - Copying logs to upload dir... 09:52:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.192059 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-09 09:52:25.286498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:52:25.289688) ========= 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=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/164522ba3d986356a8816fa73e54894b16673da7b38cddaca452208582c7ad3057b5e5bb3d7acbe6193c06a1f9c4d718fb8adeb90eff56a33094362886d031b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992e857afe763469bcf49fb15533a14b50a644b4eaa3f1cc7834b05189f95200c93296a7673711c5aa210b64646a836d4fec7ae0d76ea83848aa86e1c4f57bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d122a21316b67ba438df0c127a7d1cf0424daa02e5647ba1d516a75b65cffc2b3735572e506b177641616c6a594bb0c015633af1c387c89209b4a1a87c9e53f2"} build_url:https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/STB88ShVSSWpTtauN6iZKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/164522ba3d986356a8816fa73e54894b16673da7b38cddaca452208582c7ad3057b5e5bb3d7acbe6193c06a1f9c4d718fb8adeb90eff56a33094362886d031b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/992e857afe763469bcf49fb15533a14b50a644b4eaa3f1cc7834b05189f95200c93296a7673711c5aa210b64646a836d4fec7ae0d76ea83848aa86e1c4f57bcf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d122a21316b67ba438df0c127a7d1cf0424daa02e5647ba1d516a75b65cffc2b3735572e506b177641616c6a594bb0c015633af1c387c89209b4a1a87c9e53f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:52:25.315082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:52:25.315448) ========= 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=d2a8c569965ab8367867b893000001a1-1465489903.361003-2090019138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:52:25.399216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:52:25.399542) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:52:25.399832) ========= ========= Total master_lag: 0.18 =========