builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1465549779.02 results: success (0) buildid: 20160609233020 builduid: c9743ed94240451ebe26dc53e13c6d72 revision: ff9fd611d818116cfd47ee7d067c2642368cf3f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.019523) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.020017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.020499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.057244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.057520) ========= 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=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 02:09:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-06-10 02:09:39 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.217784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.218066) ========= 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=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019474 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.267824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:39.268246) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff9fd611d818116cfd47ee7d067c2642368cf3f9 --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 ff9fd611d818116cfd47ee7d067c2642368cf3f9 --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=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 02:09:39,497 truncating revision to first 12 chars 2016-06-10 02:09:39,497 Setting DEBUG logging. 2016-06-10 02:09:39,497 attempt 1/10 2016-06-10 02:09:39,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff9fd611d818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 02:09:40,010 unpacking tar archive at: fx-team-ff9fd611d818/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:40.143328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:40.143646) ========= script_repo_revision: ff9fd611d818116cfd47ee7d067c2642368cf3f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:40.144070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:40.144342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 02:09:40.154343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-10 02:09:40.154659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:09:40 INFO - MultiFileLogger online at 20160610 02:09:40 in /builds/slave/test 02:09:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:09:40 INFO - {'append_to_log': False, 02:09:40 INFO - 'base_work_dir': '/builds/slave/test', 02:09:40 INFO - 'blob_upload_branch': 'Fx-Team', 02:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:09:40 INFO - 'branch': 'Fx-Team', 02:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:09:40 INFO - 'config_files': ('talos/linux_config.py',), 02:09:40 INFO - 'default_actions': ('clobber', 02:09:40 INFO - 'read-buildbot-config', 02:09:40 INFO - 'download-and-extract', 02:09:40 INFO - 'populate-webroot', 02:09:40 INFO - 'create-virtualenv', 02:09:40 INFO - 'install', 02:09:40 INFO - 'run-tests'), 02:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:09:40 INFO - 'download_minidump_stackwalk': True, 02:09:40 INFO - 'download_symbols': 'ondemand', 02:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:09:40 INFO - 'installer_path': 'installer.exe', 02:09:40 INFO - 'log_level': 'info', 02:09:40 INFO - 'log_name': 'talos', 02:09:40 INFO - 'log_to_console': True, 02:09:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:09:40 INFO - 'opt_config_files': (), 02:09:40 INFO - 'pip_index': False, 02:09:40 INFO - 'sps_profile': False, 02:09:40 INFO - 'sps_profile_interval': 0, 02:09:40 INFO - 'suite': 'dromaeojs', 02:09:40 INFO - 'system_bits': '32', 02:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:09:40 INFO - 'title': 'talos-linux64-ix-048', 02:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:09:40 INFO - 'use_talos_json': True, 02:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:09:40 INFO - 'work_dir': 'build'} 02:09:40 INFO - ##### 02:09:40 INFO - ##### Running clobber step. 02:09:40 INFO - ##### 02:09:40 INFO - Running pre-action listener: _resource_record_pre_action 02:09:40 INFO - Running main action method: clobber 02:09:40 INFO - rmtree: /builds/slave/test/build 02:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:09:40 INFO - Running post-action listener: _resource_record_post_action 02:09:40 INFO - ##### 02:09:40 INFO - ##### Finished clobber step (success) 02:09:40 INFO - ##### 02:09:40 INFO - ##### 02:09:40 INFO - ##### Running read-buildbot-config step. 02:09:40 INFO - ##### 02:09:40 INFO - Running pre-action listener: _resource_record_pre_action 02:09:40 INFO - Running main action method: read_buildbot_config 02:09:40 INFO - Using buildbot properties: 02:09:40 INFO - { 02:09:40 INFO - "project": "", 02:09:40 INFO - "product": "firefox", 02:09:40 INFO - "script_repo_revision": "production", 02:09:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:09:40 INFO - "repository": "", 02:09:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:09:40 INFO - "buildid": "20160609233020", 02:09:40 INFO - "pgo_build": "True", 02:09:40 INFO - "basedir": "/builds/slave/test", 02:09:40 INFO - "buildnumber": 1242, 02:09:40 INFO - "slavename": "talos-linux64-ix-048", 02:09:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:09:40 INFO - "platform": "ubuntu64_hw", 02:09:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:09:40 INFO - "branch": "fx-team", 02:09:40 INFO - "repo_path": "integration/fx-team", 02:09:40 INFO - "revision": "ff9fd611d818116cfd47ee7d067c2642368cf3f9", 02:09:40 INFO - "stage_platform": "linux64-pgo", 02:09:40 INFO - "builduid": "c9743ed94240451ebe26dc53e13c6d72", 02:09:40 INFO - "slavebuilddir": "test" 02:09:40 INFO - } 02:09:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:09:40 INFO - Running post-action listener: _resource_record_post_action 02:09:40 INFO - ##### 02:09:40 INFO - ##### Finished read-buildbot-config step (success) 02:09:40 INFO - ##### 02:09:40 INFO - ##### 02:09:40 INFO - ##### Running download-and-extract step. 02:09:40 INFO - ##### 02:09:40 INFO - Running pre-action listener: _resource_record_pre_action 02:09:40 INFO - Running main action method: download_and_extract 02:09:40 INFO - mkdir: /builds/slave/test/build/tests 02:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:40 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:43 INFO - Downloaded 1361 bytes. 02:09:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:09:43 INFO - Using the following test package requirements: 02:09:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:09:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:09:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'jsshell-linux-x86_64.zip'], 02:09:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:09:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:09:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:09:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:09:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:09:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:09:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:09:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:09:43 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')]} 02:09:43 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:44 INFO - Downloaded 24452446 bytes. 02:09:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:09:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:09:45 INFO - Return code: 0 02:09:45 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 02:09:45 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')]} 02:09:45 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:09:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:09:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:09:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:48 INFO - Downloaded 24452446 bytes. 02:09:48 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'] 02:09:48 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 02:09:50 INFO - Return code: 0 02:09:50 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')]} 02:09:50 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:09:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:09:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:09:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:51 INFO - Downloaded 10833377 bytes. 02:09:51 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'] 02:09:51 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 02:09:51 INFO - Return code: 0 02:09: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')]} 02:09:51 INFO - https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPBihWaIQWCnEQtkCpO24A/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 02:09:53 INFO - Downloaded 59304052 bytes. 02:09:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:09:53 INFO - mkdir: /builds/slave/test/properties 02:09:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:09:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:09:53 INFO - Contents: 02:09:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:09:53 INFO - Running post-action listener: _resource_record_post_action 02:09:53 INFO - Running post-action listener: set_extra_try_arguments 02:09:53 INFO - ##### 02:09:53 INFO - ##### Finished download-and-extract step (success) 02:09:53 INFO - ##### 02:09:53 INFO - ##### 02:09:53 INFO - ##### Running populate-webroot step. 02:09:53 INFO - ##### 02:09:53 INFO - Running pre-action listener: _resource_record_pre_action 02:09:53 INFO - Running main action method: populate_webroot 02:09:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:09:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:09:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:09:53 INFO - '--tppagecycles', 02:09:53 INFO - '7'], 02:09:53 INFO - 'tests': ['tsvgm']}}, 02:09:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:09:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:09:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:09:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:09:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:09:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['damp', 'tps']}, 02:09:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'tests': ['damp', 'tps']}, 02:09:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['dromaeo_dom']}, 02:09:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:09:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['a11yr', 02:09:53 INFO - 'ts_paint', 02:09:53 INFO - 'tpaint', 02:09:53 INFO - 'sessionrestore', 02:09:53 INFO - 'sessionrestore_no_auto_restore', 02:09:53 INFO - 'tabpaint']}, 02:09:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['tsvgx', 02:09:53 INFO - 'tsvgr_opacity', 02:09:53 INFO - 'tart', 02:09:53 INFO - 'tscrollx', 02:09:53 INFO - 'cart']}, 02:09:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:09:53 INFO - 'tsvgr_opacity', 02:09:53 INFO - 'tart', 02:09:53 INFO - 'tscrollx', 02:09:53 INFO - 'cart']}, 02:09:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'talos_options': ['--disable-e10s'], 02:09:53 INFO - 'tests': ['tp5o']}, 02:09:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'tests': ['tp5o']}, 02:09:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'talos_options': ['--disable-e10s', 02:09:53 INFO - '--xperf_path', 02:09:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:53 INFO - 'tests': ['tp5n']}, 02:09:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:09:53 INFO - 'talos_options': ['--xperf_path', 02:09:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:09:53 INFO - 'tests': ['tp5n']}}, 02:09:53 INFO - 'talos.zip': {'path': '', 02:09:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:09:53 INFO - Running post-action listener: _resource_record_post_action 02:09:53 INFO - ##### 02:09:53 INFO - ##### Finished populate-webroot step (success) 02:09:53 INFO - ##### 02:09:53 INFO - ##### 02:09:53 INFO - ##### Running create-virtualenv step. 02:09:53 INFO - ##### 02:09:53 INFO - Running pre-action listener: _resource_record_pre_action 02:09:53 INFO - Running main action method: create_virtualenv 02:09:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:09:53 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 02:09:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:09:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:09:53 INFO - Using real prefix '/usr' 02:09:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:09:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:09:56 INFO - Installing pip.................done. 02:09:56 INFO - Return code: 0 02:09:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:09:56 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 02:09:56 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 02:09:56 INFO - Using env: {'DISPLAY': ':0', 02:09:56 INFO - 'HOME': '/home/cltbld', 02:09:56 INFO - 'LANG': 'en_US.UTF-8', 02:09:56 INFO - 'LANGUAGE': 'en_US:en', 02:09:56 INFO - 'LOGNAME': 'cltbld', 02:09:56 INFO - 'MAIL': '/var/mail/cltbld', 02:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:56 INFO - 'MOZ_NO_REMOTE': '1', 02:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:56 INFO - 'NO_EM_RESTART': '1', 02:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:56 INFO - 'PWD': '/builds/slave/test', 02:09:56 INFO - 'SHELL': '/bin/bash', 02:09:56 INFO - 'SHLVL': '1', 02:09:56 INFO - 'TERM': 'linux', 02:09:56 INFO - 'TMOUT': '86400', 02:09:56 INFO - 'USER': 'cltbld', 02:09:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:56 INFO - '_': '/tools/buildbot/bin/python'} 02:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:56 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 02:09:56 INFO - Cleaning up... 02:09:56 INFO - Return code: 0 02:09:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:56 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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:09:56 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 02:09:56 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 02:09:56 INFO - Using env: {'DISPLAY': ':0', 02:09:56 INFO - 'HOME': '/home/cltbld', 02:09:56 INFO - 'LANG': 'en_US.UTF-8', 02:09:56 INFO - 'LANGUAGE': 'en_US:en', 02:09:56 INFO - 'LOGNAME': 'cltbld', 02:09:56 INFO - 'MAIL': '/var/mail/cltbld', 02:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:56 INFO - 'MOZ_NO_REMOTE': '1', 02:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:56 INFO - 'NO_EM_RESTART': '1', 02:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:56 INFO - 'PWD': '/builds/slave/test', 02:09:56 INFO - 'SHELL': '/bin/bash', 02:09:56 INFO - 'SHLVL': '1', 02:09:56 INFO - 'TERM': 'linux', 02:09:56 INFO - 'TMOUT': '86400', 02:09:56 INFO - 'USER': 'cltbld', 02:09:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:56 INFO - '_': '/tools/buildbot/bin/python'} 02:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:56 INFO - Downloading/unpacking psutil>=3.1.1 02:09:56 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 02:09:56 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 02:09:56 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 02:09:56 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 02:09:56 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 02:09:56 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 02:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:00 INFO - Installing collected packages: psutil 02:10:00 INFO - Running setup.py install for psutil 02:10:00 INFO - building 'psutil._psutil_linux' extension 02:10:00 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 02:10: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 02:10:00 INFO - building 'psutil._psutil_posix' extension 02:10: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 02:10: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 02:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:00 INFO - Successfully installed psutil 02:10:00 INFO - Cleaning up... 02:10:00 INFO - Return code: 0 02:10:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:00 INFO - Using env: {'DISPLAY': ':0', 02:10:00 INFO - 'HOME': '/home/cltbld', 02:10:00 INFO - 'LANG': 'en_US.UTF-8', 02:10:00 INFO - 'LANGUAGE': 'en_US:en', 02:10:00 INFO - 'LOGNAME': 'cltbld', 02:10:00 INFO - 'MAIL': '/var/mail/cltbld', 02:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:00 INFO - 'MOZ_NO_REMOTE': '1', 02:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:00 INFO - 'NO_EM_RESTART': '1', 02:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:00 INFO - 'PWD': '/builds/slave/test', 02:10:00 INFO - 'SHELL': '/bin/bash', 02:10:00 INFO - 'SHLVL': '1', 02:10:00 INFO - 'TERM': 'linux', 02:10:00 INFO - 'TMOUT': '86400', 02:10:00 INFO - 'USER': 'cltbld', 02:10:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:00 INFO - '_': '/tools/buildbot/bin/python'} 02:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:01 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 02:10:01 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 02:10:01 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 02:10:01 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 02:10:01 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 02:10:01 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 02:10:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:03 INFO - Installing collected packages: mozsystemmonitor 02:10:03 INFO - Running setup.py install for mozsystemmonitor 02:10:03 INFO - Successfully installed mozsystemmonitor 02:10:03 INFO - Cleaning up... 02:10:03 INFO - Return code: 0 02:10:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:03 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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10:03 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 02:10:03 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 02:10:03 INFO - Using env: {'DISPLAY': ':0', 02:10:03 INFO - 'HOME': '/home/cltbld', 02:10:03 INFO - 'LANG': 'en_US.UTF-8', 02:10:03 INFO - 'LANGUAGE': 'en_US:en', 02:10:03 INFO - 'LOGNAME': 'cltbld', 02:10:03 INFO - 'MAIL': '/var/mail/cltbld', 02:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:03 INFO - 'MOZ_NO_REMOTE': '1', 02:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:03 INFO - 'NO_EM_RESTART': '1', 02:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:03 INFO - 'PWD': '/builds/slave/test', 02:10:03 INFO - 'SHELL': '/bin/bash', 02:10:03 INFO - 'SHLVL': '1', 02:10:03 INFO - 'TERM': 'linux', 02:10:03 INFO - 'TMOUT': '86400', 02:10:03 INFO - 'USER': 'cltbld', 02:10:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:03 INFO - '_': '/tools/buildbot/bin/python'} 02:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:03 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 02:10:03 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 02:10:03 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 02:10:03 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 02:10:03 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 02:10:03 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 02:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:05 INFO - warning: no files found matching '*.txt' 02:10:05 INFO - no previously-included directories found matching 'build' 02:10:05 INFO - no previously-included directories found matching 'dist' 02:10:05 INFO - no previously-included directories found matching '.git*' 02:10:05 INFO - Installing collected packages: jsonschema, functools32 02:10:05 INFO - Running setup.py install for functools32 02:10:05 INFO - warning: no files found matching '*.txt' 02:10:05 INFO - no previously-included directories found matching 'build' 02:10:05 INFO - no previously-included directories found matching 'dist' 02:10:05 INFO - no previously-included directories found matching '.git*' 02:10:05 INFO - Successfully installed jsonschema functools32 02:10:05 INFO - Cleaning up... 02:10:05 INFO - Return code: 0 02:10:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:05 INFO - Using env: {'DISPLAY': ':0', 02:10:05 INFO - 'HOME': '/home/cltbld', 02:10:05 INFO - 'LANG': 'en_US.UTF-8', 02:10:05 INFO - 'LANGUAGE': 'en_US:en', 02:10:05 INFO - 'LOGNAME': 'cltbld', 02:10:05 INFO - 'MAIL': '/var/mail/cltbld', 02:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:05 INFO - 'MOZ_NO_REMOTE': '1', 02:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:05 INFO - 'NO_EM_RESTART': '1', 02:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:05 INFO - 'PWD': '/builds/slave/test', 02:10:05 INFO - 'SHELL': '/bin/bash', 02:10:05 INFO - 'SHLVL': '1', 02:10:05 INFO - 'TERM': 'linux', 02:10:05 INFO - 'TMOUT': '86400', 02:10:05 INFO - 'USER': 'cltbld', 02:10:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:05 INFO - '_': '/tools/buildbot/bin/python'} 02:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:06 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:06 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 02:10:06 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 02:10:06 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 02:10:06 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 02:10:06 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 02:10:06 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 02:10:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 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 02:10:08 INFO - Downloading docopt-0.6.1.tar.gz 02:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:08 INFO - Running setup.py install for blobuploader 02:10:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:08 INFO - Running setup.py install for requests 02:10:09 INFO - Running setup.py install for docopt 02:10:09 INFO - Successfully installed blobuploader requests docopt 02:10:09 INFO - Cleaning up... 02:10:09 INFO - Return code: 0 02:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:09 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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10:09 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 02:10:09 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 02:10:09 INFO - Using env: {'DISPLAY': ':0', 02:10:09 INFO - 'HOME': '/home/cltbld', 02:10:09 INFO - 'LANG': 'en_US.UTF-8', 02:10:09 INFO - 'LANGUAGE': 'en_US:en', 02:10:09 INFO - 'LOGNAME': 'cltbld', 02:10:09 INFO - 'MAIL': '/var/mail/cltbld', 02:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:09 INFO - 'MOZ_NO_REMOTE': '1', 02:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:09 INFO - 'NO_EM_RESTART': '1', 02:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:09 INFO - 'PWD': '/builds/slave/test', 02:10:09 INFO - 'SHELL': '/bin/bash', 02:10:09 INFO - 'SHLVL': '1', 02:10:09 INFO - 'TERM': 'linux', 02:10:09 INFO - 'TMOUT': '86400', 02:10:09 INFO - 'USER': 'cltbld', 02:10:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:09 INFO - '_': '/tools/buildbot/bin/python'} 02:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:09 INFO - Running setup.py (path:/tmp/pip-b0AGna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:09 INFO - Running setup.py (path:/tmp/pip-NJehll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:09 INFO - Running setup.py (path:/tmp/pip-It66gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:09 INFO - Running setup.py (path:/tmp/pip-7E5Dbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:09 INFO - Running setup.py (path:/tmp/pip-NTX1Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:10 INFO - Running setup.py (path:/tmp/pip-88TZpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:10 INFO - Running setup.py (path:/tmp/pip-sOp2mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:10 INFO - Running setup.py (path:/tmp/pip-tPFrBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:10 INFO - Running setup.py (path:/tmp/pip-CpBBoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:10 INFO - Running setup.py (path:/tmp/pip-WfsHR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:10 INFO - Running setup.py (path:/tmp/pip-SXaj9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:10 INFO - Running setup.py (path:/tmp/pip-2CxBy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:10 INFO - Running setup.py (path:/tmp/pip-AYZ51P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:10 INFO - Running setup.py (path:/tmp/pip-q2xJWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:10 INFO - Running setup.py (path:/tmp/pip-HH1xsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:10 INFO - Running setup.py (path:/tmp/pip-om6nju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:10 INFO - Running setup.py (path:/tmp/pip-_Nv6re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:10 INFO - Running setup.py install for manifestparser 02:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:10 INFO - Running setup.py install for mozcrash 02:10:11 INFO - Running setup.py install for mozdebug 02:10:11 INFO - Running setup.py install for mozdevice 02:10:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Running setup.py install for mozfile 02:10:11 INFO - Running setup.py install for mozhttpd 02:10:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Running setup.py install for mozinfo 02:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Running setup.py install for mozInstall 02:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Running setup.py install for mozleak 02:10:11 INFO - Running setup.py install for mozlog 02:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:11 INFO - Running setup.py install for moznetwork 02:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Running setup.py install for mozprocess 02:10:12 INFO - Running setup.py install for mozprofile 02:10:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Running setup.py install for mozrunner 02:10:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Running setup.py install for mozscreenshot 02:10:12 INFO - Running setup.py install for moztest 02:10:12 INFO - Running setup.py install for mozversion 02:10:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:12 INFO - Cleaning up... 02:10:12 INFO - Return code: 0 02:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:12 INFO - Using env: {'DISPLAY': ':0', 02:10:12 INFO - 'HOME': '/home/cltbld', 02:10:12 INFO - 'LANG': 'en_US.UTF-8', 02:10:12 INFO - 'LANGUAGE': 'en_US:en', 02:10:12 INFO - 'LOGNAME': 'cltbld', 02:10:12 INFO - 'MAIL': '/var/mail/cltbld', 02:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:12 INFO - 'MOZ_NO_REMOTE': '1', 02:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:12 INFO - 'NO_EM_RESTART': '1', 02:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:12 INFO - 'PWD': '/builds/slave/test', 02:10:12 INFO - 'SHELL': '/bin/bash', 02:10:12 INFO - 'SHLVL': '1', 02:10:12 INFO - 'TERM': 'linux', 02:10:12 INFO - 'TMOUT': '86400', 02:10:12 INFO - 'USER': 'cltbld', 02:10:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:12 INFO - '_': '/tools/buildbot/bin/python'} 02:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:12 INFO - Running setup.py (path:/tmp/pip-svjcis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10: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)) 02:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:12 INFO - Running setup.py (path:/tmp/pip-pb4h1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:13 INFO - Running setup.py (path:/tmp/pip-czlBIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:13 INFO - Running setup.py (path:/tmp/pip-naMAdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:13 INFO - Running setup.py (path:/tmp/pip-yrdLXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:13 INFO - Running setup.py (path:/tmp/pip-tCFAmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:13 INFO - Running setup.py (path:/tmp/pip-wXA8Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:13 INFO - Running setup.py (path:/tmp/pip-fK8bgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:13 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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:13 INFO - Running setup.py (path:/tmp/pip-_L8WFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:13 INFO - Running setup.py (path:/tmp/pip-qGXTI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:13 INFO - Running setup.py (path:/tmp/pip-LtIt_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:13 INFO - Running setup.py (path:/tmp/pip-IBLDEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:13 INFO - Running setup.py (path:/tmp/pip-1aYXUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:13 INFO - Running setup.py (path:/tmp/pip-Xx7zmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:13 INFO - Running setup.py (path:/tmp/pip-LJ8HJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10: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)) 02:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:13 INFO - Running setup.py (path:/tmp/pip-mTUKb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:14 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)) 02:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:14 INFO - Running setup.py (path:/tmp/pip-UOxkgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:14 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)) 02:10:14 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)) 02:10:14 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)) 02:10:14 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)) 02:10:14 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)) 02:10:14 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)) 02:10:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:15 INFO - Downloading blessings-1.6.tar.gz 02:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:16 INFO - Installing collected packages: blessings 02:10:16 INFO - Running setup.py install for blessings 02:10:16 INFO - Successfully installed blessings 02:10:16 INFO - Cleaning up... 02:10:16 INFO - Return code: 0 02:10:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:16 INFO - Reading from file tmpfile_stdout 02:10:16 INFO - Current package versions: 02:10:16 INFO - argparse == 1.2.1 02:10:16 INFO - blessings == 1.6 02:10:16 INFO - blobuploader == 1.2.4 02:10:16 INFO - docopt == 0.6.1 02:10:16 INFO - functools32 == 3.2.3-2 02:10:16 INFO - jsonschema == 2.5.1 02:10:16 INFO - manifestparser == 1.1 02:10:16 INFO - mozInstall == 1.12 02:10:16 INFO - mozcrash == 0.17 02:10:16 INFO - mozdebug == 0.1 02:10:16 INFO - mozdevice == 0.48 02:10:16 INFO - mozfile == 1.2 02:10:16 INFO - mozhttpd == 0.7 02:10:16 INFO - mozinfo == 0.9 02:10:16 INFO - mozleak == 0.1 02:10:16 INFO - mozlog == 3.2 02:10:16 INFO - moznetwork == 0.27 02:10:16 INFO - mozprocess == 0.22 02:10:16 INFO - mozprofile == 0.28 02:10:16 INFO - mozrunner == 6.11 02:10:16 INFO - mozscreenshot == 0.1 02:10:16 INFO - mozsystemmonitor == 0.3 02:10:16 INFO - moztest == 0.7 02:10:16 INFO - mozversion == 1.4 02:10:16 INFO - psutil == 3.1.1 02:10:16 INFO - requests == 1.2.3 02:10:16 INFO - wsgiref == 0.1.2 02:10:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:16 INFO - Using env: {'DISPLAY': ':0', 02:10:16 INFO - 'HOME': '/home/cltbld', 02:10:16 INFO - 'LANG': 'en_US.UTF-8', 02:10:16 INFO - 'LANGUAGE': 'en_US:en', 02:10:16 INFO - 'LOGNAME': 'cltbld', 02:10:16 INFO - 'MAIL': '/var/mail/cltbld', 02:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:16 INFO - 'MOZ_NO_REMOTE': '1', 02:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:16 INFO - 'NO_EM_RESTART': '1', 02:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:16 INFO - 'PWD': '/builds/slave/test', 02:10:16 INFO - 'SHELL': '/bin/bash', 02:10:16 INFO - 'SHLVL': '1', 02:10:16 INFO - 'TERM': 'linux', 02:10:16 INFO - 'TMOUT': '86400', 02:10:16 INFO - 'USER': 'cltbld', 02:10:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:16 INFO - '_': '/tools/buildbot/bin/python'} 02:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10: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)) 02:10:16 INFO - Cleaning up... 02:10:16 INFO - Return code: 0 02:10:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:16 INFO - Using env: {'DISPLAY': ':0', 02:10:16 INFO - 'HOME': '/home/cltbld', 02:10:16 INFO - 'LANG': 'en_US.UTF-8', 02:10:16 INFO - 'LANGUAGE': 'en_US:en', 02:10:16 INFO - 'LOGNAME': 'cltbld', 02:10:16 INFO - 'MAIL': '/var/mail/cltbld', 02:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:16 INFO - 'MOZ_NO_REMOTE': '1', 02:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:16 INFO - 'NO_EM_RESTART': '1', 02:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:16 INFO - 'PWD': '/builds/slave/test', 02:10:16 INFO - 'SHELL': '/bin/bash', 02:10:16 INFO - 'SHLVL': '1', 02:10:16 INFO - 'TERM': 'linux', 02:10:16 INFO - 'TMOUT': '86400', 02:10:16 INFO - 'USER': 'cltbld', 02:10:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:16 INFO - '_': '/tools/buildbot/bin/python'} 02:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:16 INFO - Cleaning up... 02:10:16 INFO - Return code: 0 02:10:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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 0x7f4714cacf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2994190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, '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': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', '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 02:10: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 02:10: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 02:10:16 INFO - Using env: {'DISPLAY': ':0', 02:10:16 INFO - 'HOME': '/home/cltbld', 02:10:16 INFO - 'LANG': 'en_US.UTF-8', 02:10:16 INFO - 'LANGUAGE': 'en_US:en', 02:10:16 INFO - 'LOGNAME': 'cltbld', 02:10:16 INFO - 'MAIL': '/var/mail/cltbld', 02:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:16 INFO - 'MOZ_NO_REMOTE': '1', 02:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:16 INFO - 'NO_EM_RESTART': '1', 02:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:16 INFO - 'PWD': '/builds/slave/test', 02:10:16 INFO - 'SHELL': '/bin/bash', 02:10:16 INFO - 'SHLVL': '1', 02:10:16 INFO - 'TERM': 'linux', 02:10:16 INFO - 'TMOUT': '86400', 02:10:16 INFO - 'USER': 'cltbld', 02:10:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:16 INFO - '_': '/tools/buildbot/bin/python'} 02:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:17 INFO - Downloading/unpacking flake8 02:10:17 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 02:10:17 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 02:10:17 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 02:10:17 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 02:10:17 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 02:10:17 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 02:10:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:10:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:10:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:19 INFO - no previously-included directories found matching 'docs/_build' 02:10:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:10:19 INFO - Running setup.py install for pep8 02:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:19 INFO - no previously-included directories found matching 'docs/_build' 02:10:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:10:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:10:19 INFO - Cleaning up... 02:10:19 INFO - Return code: 0 02:10:19 INFO - Running post-action listener: _resource_record_post_action 02:10:19 INFO - Running post-action listener: _start_resource_monitoring 02:10:19 INFO - Starting resource monitoring. 02:10:19 INFO - ##### 02:10:19 INFO - ##### Finished create-virtualenv step (success) 02:10:19 INFO - ##### 02:10:19 INFO - ##### 02:10:19 INFO - ##### Running install step. 02:10:19 INFO - ##### 02:10:19 INFO - Running pre-action listener: _resource_record_pre_action 02:10:19 INFO - Running main action method: install 02:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:20 INFO - Reading from file tmpfile_stdout 02:10:20 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:20 INFO - Reading from file tmpfile_stdout 02:10:20 INFO - Output received: 02:10:20 INFO - Usage: mozinstall [options] installer 02:10:20 INFO - Options: 02:10:20 INFO - -h, --help show this help message and exit 02:10:20 INFO - -d DEST, --destination=DEST 02:10:20 INFO - Directory to install application into. [default: 02:10:20 INFO - "/builds/slave/test"] 02:10:20 INFO - --app=APP Application being installed. [default: firefox] 02:10:20 INFO - mkdir: /builds/slave/test/build/application 02:10:20 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'] 02:10:20 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 02:10:37 INFO - Reading from file tmpfile_stdout 02:10:37 INFO - Output received: 02:10:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:37 INFO - Running post-action listener: _resource_record_post_action 02:10:37 INFO - ##### 02:10:37 INFO - ##### Finished install step (success) 02:10:37 INFO - ##### 02:10:37 INFO - ##### 02:10:37 INFO - ##### Running run-tests step. 02:10:37 INFO - ##### 02:10:37 INFO - Running pre-action listener: _resource_record_pre_action 02:10:37 INFO - Running main action method: run_tests 02:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:37 INFO - Python 2.7.3 02:10:37 INFO - Return code: 0 02:10:37 INFO - grabbing minidump binary from tooltool 02:10:37 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')]} 02:10:37 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 0x2a26110>, '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 0x2992230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29926c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:37 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 02:10:37 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 02:10:37 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 02:10:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:37 INFO - Return code: 0 02:10:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:10:38 INFO - Return code: 0 02:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:10:38 INFO - Using env: {'DISPLAY': ':0', 02:10:38 INFO - 'HOME': '/home/cltbld', 02:10:38 INFO - 'LANG': 'en_US.UTF-8', 02:10:38 INFO - 'LANGUAGE': 'en_US:en', 02:10:38 INFO - 'LOGNAME': 'cltbld', 02:10:38 INFO - 'MAIL': '/var/mail/cltbld', 02:10:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:38 INFO - 'MOZ_NO_REMOTE': '1', 02:10:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:38 INFO - 'NO_EM_RESTART': '1', 02:10:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:38 INFO - 'PWD': '/builds/slave/test', 02:10:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:38 INFO - 'SHELL': '/bin/bash', 02:10:38 INFO - 'SHLVL': '1', 02:10:38 INFO - 'TERM': 'linux', 02:10:38 INFO - 'TMOUT': '86400', 02:10:38 INFO - 'USER': 'cltbld', 02:10:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897', 02:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:38 INFO - '_': '/tools/buildbot/bin/python'} 02:10:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:10:38 INFO - mozversion application_buildid: 20160609233020 02:10:38 INFO - mozversion application_changeset: ff9fd611d818116cfd47ee7d067c2642368cf3f9 02:10:38 INFO - mozversion application_display_name: Nightly 02:10:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:38 INFO - mozversion application_name: Firefox 02:10:38 INFO - mozversion application_remotingname: firefox 02:10:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:10:38 INFO - mozversion application_vendor: Mozilla 02:10:38 INFO - mozversion application_version: 50.0a1 02:10:38 INFO - mozversion platform_buildid: 20160609233020 02:10:38 INFO - mozversion platform_changeset: ff9fd611d818116cfd47ee7d067c2642368cf3f9 02:10:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:38 INFO - mozversion platform_version: 50.0a1 02:10:38 INFO - using testdate: 1465549838 02:10:38 INFO - actual date: 1465549838 02:10:38 INFO - starting webserver on 'localhost:44071' 02:10:38 INFO - SUITE-START | Running 2 tests 02:10:38 INFO - TEST-START | dromaeo_css 02:10:38 INFO - operating with platform_type : linux_ 02:10:38 INFO - Initialising browser for dromaeo_css test... 02:10:38 INFO - TEST-INFO | started process 4298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdnnmSk/profile http://localhost:44071/getInfo.html) 02:10:42 INFO - PROCESS | 4298 | __metrics Screen width/height:1600/1200 02:10:42 INFO - PROCESS | 4298 | colorDepth:24 02:10:42 INFO - PROCESS | 4298 | Browser inner width/height: 1024/697 02:10:42 INFO - PROCESS | 4298 | __metrics 02:10:43 ERROR - PROCESS | 4298 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:10:44 INFO - PROCESS | 4298 | console.error: PushService: 02:10:44 INFO - PROCESS | 4298 | stateChangeProcessEnqueue: Error transitioning state 02:10:44 INFO - PROCESS | 4298 | UnknownError 02:10:44 INFO - TEST-INFO | 4298: exit 0 02:10:44 INFO - Browser initialized. 02:10:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:44 INFO - TEST-INFO | started process 4379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdnnmSk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:10:56 INFO - PROCESS | 4379 | RSS: Main: 173694976 02:10:56 INFO - PROCESS | 4379 | 02:11:47 INFO - PROCESS | 4379 | 1465549907619 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] 02:13:56 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44071/tests/dromaeo/cssquery-ext.html) 02:13:57 INFO - PROCESS | 4379 | RSS: Main: 270254080 02:13:57 INFO - PROCESS | 4379 | 02:17:00 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-ext.html (next: http://localhost:44071/tests/dromaeo/cssquery-jquery.html) 02:17:00 INFO - PROCESS | 4379 | RSS: Main: 266981376 02:17:00 INFO - PROCESS | 4379 | 02:20:02 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44071/tests/dromaeo/cssquery-mootools.html) 02:20:03 INFO - PROCESS | 4379 | RSS: Main: 261156864 02:20:03 INFO - PROCESS | 4379 | 02:23:05 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44071/tests/dromaeo/cssquery-prototype.html) 02:23:06 INFO - PROCESS | 4379 | RSS: Main: 253771776 02:23:06 INFO - PROCESS | 4379 | 02:26:08 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44071/tests/dromaeo/cssquery-yui.html) 02:26:09 INFO - PROCESS | 4379 | RSS: Main: 241258496 02:26:09 INFO - PROCESS | 4379 | 02:29:11 INFO - PROCESS | 4379 | Cycle 1(1): loaded http://localhost:44071/tests/dromaeo/cssquery-yui.html (next: http://localhost:44071/tests/dromaeo/cssquery-dojo.html) 02:29:12 INFO - PROCESS | 4379 | RSS: Main: 323239936 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | __start_tp_report 02:29:12 INFO - PROCESS | 4379 | _x_x_mozilla_page_load 02:29:12 INFO - PROCESS | 4379 | _x_x_mozilla_page_load_details 02:29:12 INFO - PROCESS | 4379 | |i|pagename|runs| 02:29:12 INFO - PROCESS | 4379 | |0;dojo.html;3064.7701422393325;3089.443900097983;3104.906852794417;3123.6251649802025;3164.7151756341923;5249.370075590925;5311.282976798131;5332.306800115989;5431.891362172754;5440.265564148839;5370.355557333126;5381.381141168767;5413.458654134584;5435.972820135904;5468.644538105021;4830.227163653816;4920.286558449023;4927.482614325498;4937.185364414885;5106.208537676647;5027.4469808321055;5041.143005689023;5070.898582028357;5092.949070509285;5098.005888851657;4723.244280915054;4791.113643975876;4815.5906747926465;4860.854174374775;4905.068037072945;4832.9275060874115;4848.7090774553635;4855.126077306083;4860.465348811628;4901.01979604077;4781.521847815191;4818.734969576672;4836.733979631119;4845.927311090337;4871.56155945963;5304.681719096867;5387.272718183034;5470.972645136789;5477.863053423656;5478.780848766045;5820;5842.269716285465;5855.063189889597;5872.7063646817915;5874.823755287305;5603.691796951166;5783.88432231353;5902.675352855591;5918.40815918409;5922.1116832475045;5410.377806552218;5505.9724701376235;5528.9723551381985;5529.889402211974;5537.031019571599;6021.458068773743;6027.367126451747;6040.365761595057;6040.788572399945;6041.78853740117;5507.118860982304;5596.048671725816;5610.691411972381;5779.682117483579;5787.305523337226;5742.971285143548;5765.711714414347;5792.681402522818;5802.4197580241635;5806.738696758656;5701.458361455655;5714.171445140431;5717.542596592262;5747.770089196469;5779.393163717749;5550.888982220414;5722.856928576819;5775.047117225611;5777.826665200051;5783.074708046693;4460.843870464518;4460.955390446054;4462.129884672523;4465.687401881902;4502.774861256924;3953.78254196022;3973.543042550086;3979.1047014421524;3982.7411218270718;4014.2573623879675;5212.166053431432;5263.6841789492755;5281.815136470205;5326.893462130735;5329.626926115135;5737.483626473638;5758.88482230353;5765.365809760923;5765.85585360361;5807.041838096751;5366.517013468807;5376.758045887945;5377.0321342158;5379;5381.354237491526;4853.466118726938;4993.525615066563;5034.79860805571;5038.974805125951;5087.6947383156385;5980.760769569256;5981.282246130492;5994.040953447515;6003.459688628044;6008.729607167688;5588.273524441796;5837.824865254049;5854.531637468907;5860.560457965585;5861.443162899518;5766.221560089334;5766.8846623066465;5832.1543376209365;5892.175095486721;5897.64614123154;5655.519280861173;5689.032864412977;5693.5160511357;5701.4298570142655;5701.458361455655;5614;5686;5777.364489906191;5788.565857560616;5792.884142317046;5545.500904918576;5628.352739435018;5631.831045068655;5675.57433192504;5679.829605111853;5559.305086864142;5599.496045355938;5607.327120745536;5608.10270356741;5615.157726341082;5356.732163391737;5484.945150548443;5495.450454954473;5497.47773961473;5502.024995651755;5609.411011843697;5744.511716504144;5747.281589801275;5750;5751.482366587027;5503.669779813224;5513.972430137824;5543.556515478671;5545.750441230073;5586.52514536269 02:29:12 INFO - PROCESS | 4379 | |1;ext.html;581.9970900145498;604.9606775559591;621.7388696747365;636.6943866943867;646.0374042676414;32357.352852942957;35834.82082589587;41624.58375416245;42366.78816605913;42441.78779106108;44155.116897662025;44568.77715611417;44583.77708111463;44587.33119003209;44652.77673611636;8839.425437346568;8979.102089791035;8988.370814043019;8989.685361012365;8991.38155132076;8864.8670269946;8963.596638151299;8965.282777377826;8971.506567138806;8973;9021.413608115485;9081.591328390205;9084.318676099287;9088.818223635524;9097.181253687168;9007.54962251888;9030.006699263076;9055.501947392891;9056.184943355096;9060.456372617664;8880.1563851434;8928.419652722552;8932.240759535447;8933.196012358854;8952.776180595472;42101.15797684029;42383.57616423827;42507.14985700269;42528.57471425277;42559.787201063795;3424.7773894696766;3444.0356700124007;3598.2803439312243;3631.382664946965;3656.634336566349;31970.5117172148;32389.6761032389;32574.18564535882;33130;34188.48717269243;4295.248331541968;4328.63206627437;4331.631811296043;4446.510883802779;4480.395146655193;360040;363563;363594.9999999974;363816.18091909634;363891;33091.172720681694;33873.49189762106;56963;57067.71466142643;57474.7126264366;36270.8186459066;36442.81778591143;36483.4527482088;36524.81737591295;36540;15864.44474443389;16016;16018.839811601967;16022.75965860513;16023.839761602234;13303.201807891557;13524.526641567694;13575.932120339532;13627.931860340834;13633.522826701017;8221.054578723404;8221.876671849926;8287.62705678246;8322.791930201793;8357.247847693738;3179.9682003179673;3205.406999705062;3238.8704451822136;3258.6904244096772;3278.67213278675;965.4062751407834;1002.7292630989592;1018.9286749927583;1046;1114.8383484394878;31708.207294817814;31936.680633193835;32220.411377421235;32367;32619.673803261663;1114.3202646385698;1131.9490622921987;1147.1281825812275;1167.6146871532374;1228.6252692928742;16439.91780041116;17199;17246.82753172477;17334.30662773475;17392.3043078278;522842;524882;528746;529138;530442;59980.40019599835;60379.69810150921;60387.39612603818;60507.69746151241;60577.69711151416;1262.040848954801;1318.736252749454;1339.0827283310964;1351.209542417677;1380.6962468256968;32345.838270809436;33897.51475767706;33898.152546185556;33965;34103.31793364069;50235.74882125566;50235.74882125712;50837.74581127071;50887.2366914504;50945;396052;398439;400686;401229;402221;24411.26766197017;26190.607140893284;27134.592981104903;27252.72747272502;27701.30746731348;47316.52683473121;47681.761591191826;47727;48266.51733482761;48861.75569122132;39468;40493.39259911045;40599.128104627634;41015.1796964065;41051.384229237185;40233;40577.391339130525;40640;40786.59213407828;40984.385234220914;40215;41010.79494602508;41059.384109238985;41153.1769364617;41195.58804412038;34506.309873802886;36560.634393655724;36594.128873761976;37096;37197.628023719415;28048.774445441446;28238.57690966216;28490;28511.572326415535;28514.91281088085 02:29:12 INFO - PROCESS | 4379 | |2;jquery.html;390.20593093055635;393.57297332394353;400.76154687960656;400.77756844951057;411.6418715717326;14092.788608170886;16323.265453054611;17811.46565603031;19367.99999999998;19377.612447751053;14266.785998210034;17243.137843107826;17850.553736156602;17942.461726148205;18355.54111147222;5664.490195882359;5685.204071430003;5852.941470585303;5857.970710146444;5864.530837532987;4165.56261592533;5665.886682266352;5741.368449470555;5775.56683248756;6081.939180608204;6309.179806625132;6405.743770249184;6427.389398007182;6433.7426502939825;6439.130717353168;6343.936560634381;6366.395192456709;6404.391582799627;6517.706703198368;6521.641309727939;5570.1822054776;5685.260916080883;5698.059820129673;5702.971485142548;5710.457506536873;21276;21734.673979890315;21917.12331506738;21968.560628787494;22051.66922496164;2307.3424074138957;2334.159702507096;2451.7793398594035;2495.638132470782;2514.88683009265;12677.683057923534;13442.596722098353;13710;14036.859631403657;14485.78271325931;1879.2670858365248;1881.3039175505014;1919.2131226197332;1982.2754203842749;2010.2059686423927;72073.27926720718;74120;74834.62582687107;75410.62294688492;76937.61531192309;9560.665376711782;9638;10348.482575871176;10820.56717731282;10998.505067271992;14157.646058848406;14252.786208206886;14291.499797507246;14364.56906292792;14379.85620143806;7411.629418529052;7743.728969486041;7783.766487005399;8140.877886831702;8212.260896519223;7935.33357994816;8041.356691464669;8152.347812175011;8166.101728809826;8204.630791614392;6300.653464059429;6456.386643268882;6466.64433456155;6486.189226346707;6555.541112122106;1882.8870267783977;1910.837578805817;1921.9807801921802;1949.541857663448;1980.9009549522466;868.8740132680726;982;1015.7562185075528;1033.560736686905;1035.3477309295097;18529.258829646664;18785.53036174079;18861.151248193863;18984;19417;1009.3893194617151;1020.637673625867;1030.4332617060586;1069.0699091790193;1075.537518866879;10558.208134389797;10977.725556860983;10992.230543862013;10998.945005274922;11005.889941100646;450023;451502;452480;459657;484051;79588;80870.19129808627;81355.18644813476;81516;82360;985.261054209343;1005.8541511480794;1010.4392062405435;1024.3393011507535;1026.9691909242736;16678.416255431002;16789.580260493585;16879;16953.406630767862;17073.31706731717;35528.64471355253;36088.45867312045;36639.267214655025;37335;38416.23167536689;35333.409996550734;47121.528784711714;47200;47918;51010;8187.426880118334;8295.95852020736;8312.625931832961;8477.576121193792;8636.611352489279;12415.813762793385;12427.689307767378;12557.811632825698;12829.486820527447;13012.28432436225;10948.726281843017;11298.265612735146;11399.259048161843;11403.144764142557;11490.77018459643;6009.759609615567;9249.12133347331;11292.024124684023;11417.486213120263;11443.885561144614;11302.43487825622;11360;11550.59572914944;11669.183157178915;11826.52693892269;7449.106107267163;7612.429067820047;7630.351420129129;7919.326857216971;8697.434666746894;11023.393713345842;11181.217314787888;11419.828702569634;11497.655070347902;11678.06575473977 02:29:12 INFO - PROCESS | 4379 | |3;mootools.html;1347.2657401716065;1442.2932762946157;1507.562806786032;1600.5838481994679;1781.4032299179773;8602.354823388247;8904.688335908237;8919.241864441523;9071.274298056156;9171.037041110687;8907.599158037887;9082;9097.863532047024;9108.18026377626;9124.54377281135;2026.6656001759693;2287.885605719707;2330.417395651087;2343.3907184132163;2368.969498268259;2316.4903721181313;2329.650552417134;2331.825113116515;2332.148765700524;2338.251759436981;2336.9883150584224;2345.847519911209;2366.2428023032635;2368.9221404261107;2369.4431808524982;1963.18527810959;2209.2709405896017;2237.362351729749;2292.5758734634146;2300.907963681451;2274.6815445837597;2294.9885250573807;2299.1148407862925;2299.8160147188187;2301.6777651128855;9158.084191580789;9221.400608960395;9238.399504032217;9239.076092390775;9240.815183696355;5267.683938963674;5410.972945135289;5421.159720243369;5422.349318081816;5423.647462914937;3265.9183520411943;3281;3337.1156643489494;3359.4121028820105;3472.392331342005;1090.6564432203832;1113.8440618313443;1131.377742241772;1143.1426430177366;1165.2775279326872;13054.804177937338;13076.215427074407;13090.214587124708;13096.708076086741;13112.574173777786;4672.626189904868;4680.765961701902;4789.4971028041555;4795.520447955177;4810.278458231293;10660.20048496366;10679.412632305297;10705.411202383944;10783.6225732099;10783.946080269548;5289.153735402394;5335.306410166653;5339.733013349317;5339.851931834674;5346.91979620306;4286.121345124242;4722.95277047232;4933.333999910038;4934.383202099738;4938.407391113089;3968.4840970673627;3972.5828787977425;4039.3537034074407;4071.2468193383725;4132.896677583084;1239.6962744127566;1243.4715246020587;1275.8277632519678;1277.6869666931661;1286.7481906663338;954.6133815804471;974.6588693957058;975.7463059604412;988;1006.2905651515664;5845.795397161079;5988.820335389945;6123.234595675541;6188.226471691039;6266.060090986389;437.50343360285666;439.59996403273504;446.60921693518173;463.23334880772376;471.3565982434021;4098.426220329156;4247.830086796555;4271.722338048017;4288.764117973479;4293.549177336397;11102;11376.089912806956;11407.144464165222;11422.25755325901;11445.942770286096;10578.312409693346;10992.725181870357;11000.614978475714;11038.558457661764;11270.605528806453;8313.376496762767;8409.831803363899;8443.451175673561;8443.57782110892;8446.788830279293;5947.762089516371;6187.071939209155;6204.5967012144065;6228.657423841732;6271.686415679106;10233.181345492492;10402.167826574007;10471.94764026175;10480.63317783874;10502.894971050191;10197.439140847324;10413.375197488174;10688.786224275316;10695.679129626124;10731.248812583357;7255.891161632474;7499.850003000019;7503.174650788518;8102.7569172924905;8222.671093156207;8688.391812573313;8979.595918183566;9011.864822027806;9017.233535149586;9019.909800902169;7609.809754755954;7671.501352412075;7782.649780759993;7881.251281128284;7967.2431119043595;7651.196624354363;7653.272939070779;7748.14770375247;7823.530588164728;7940.205979402013;7299.087614048244;7330.047093877762;7353.558786472829;7356.852862942818;7362.3741981932135;5081.822136225214;5177.249298851721;5317.494837990384;5389.2067020257655;5424.918626220689;5126.256692779601;5162.870928226825;5327.893442131213;5515.806946756844;5550.500454959073 02:29:12 INFO - PROCESS | 4379 | |4;prototype.html;323.57611528897144;328.65819547670424;334.1062657391479;336.91071865955513;338.36894192331295;5339.946600533994;5379.3544774627;5392.433794451585;5406.135018397057;5407.351117865856;5004;5147.202183661539;5165.948340516594;5173.689578625285;5310.840674779763;4059.63463288304;4066.6746660267254;4088.632023117919;4173.5409104998425;4180.435641188446;4091.652209562176;4112.712110152291;4114.485689288839;4132.2355364257555;4163.333866581347;4050.574689657588;4081.9182916527143;4145.108801607654;4152.356384760367;4172.749635021908;4099.601732986207;4124.91750164998;4133.42132101506;4137.213929353413;4146.300016993034;3652.6712595866234;3675.7394202565497;3677.2093999790172;3677.2461645362637;3698.130939229279;5068.695878247317;5082.949170508285;5224.242484839715;5224.373075230958;5240.79036838526;4684.5549672781035;4694.225452800284;4696.661451486344;4701.247800351962;4716.481187069419;5501.257330260403;5504.669719816824;5505.807296744635;5511.255980442669;5519.337679478448;3889.183271512986;3977.34373828318;4009.959900400988;4010.197960407901;4019.2765302245584;5653.773849045992;5710.486056254916;5725.713714314267;5734.856628584277;5778.075507918713;4160.937585936153;4169.60388763067;4180;4187.497500299923;4187.5184353799095;4167.249895018926;4252.234597772431;4256.659467242614;4262.936055959163;4289.39948407217;4747.572718455286;4762.119007983534;4765.976170119127;4771.922110238946;4781.183150402825;5585.88282343533;5595;5611.158326251095;5635.774569017275;5644.745986430538;1354.9525766598122;1395.8763195627414;1442.834074081473;1458.8832893368506;1461.6272850423074;936.344558808823;954.7804005078871;963.4797209506928;963.5663951221838;964.1804466203671;4709.882252943636;4830.95169048305;4838.637102217348;4849.830255941025;4855.36880205571;5053.722045287471;5081.161608334657;5090.949090509048;5103.566196873233;5109.923351149736;4658.790354434059;4673;4691.460482044608;4786.760661966958;4793.688410253322;2684.315499547603;2690.63676403683;2702.810803243754;2724.6866610340066;2724.7002829688718;5129;5197.440767769654;5205.453427390145;5209.765560549784;5222.4255331913455;4916.72957987307;5147.7683504242395;5158.690478571298;5187.455317191716;5218.712970786567;5132.743362831843;5137.537621614073;5145.536901678867;5161.638685292069;5170.302009228782;4895.926561101515;5026.84919452417;5030.270610761346;5089.262057001788;5132.486751324837;5058.9494105058475;5087.939384549263;5098.2862399263395;5102.285680004728;5117.801374141161;5204.2714020036465;5215;5219.2953951216095;5225.869353266046;5236.528712415901;3733.495978043038;3846.8649899306156;3861.6910647147597;3864.5748967612976;3875.96124038756;5131.793328868623;5145.974270128625;5504.587155963399;5634.802781902614;5734.770609175586;5593.636413633101;5594.636348637326;5598.160275958476;5608.495235428831;5609.9158512621525;5536.197251398444;5558.416366281483;5572.4148964358155;5582.134769110794;5602.215689803349;5185.507376799198;5485.670859748268;5486.807961721321;5486.862828429321;5501.496818947449;5548.389677135431;5594.349706796246;5596.804111856066;5621.634593751393;5622.297212848394;5251.2123181523075;5490.615656903979;5508.338999320107;5524.8784436793085;5544.085225937675 02:29:12 INFO - PROCESS | 4379 | |5;yui.html;719.0616245799233;736.0762243384555;781.0510230070463;783.4537752305009;786.8111653203231;15225.619359516018;15240.314185861635;15351.769723454157;15371.231438428062;15582.766258506117;13407.731845363087;13635.659108522266;14845.406183752637;15015.47445839396;15185.392584296615;672.0725398949468;779.8440311937607;784.5959330944568;784.9136594974548;789.6604460082162;793.5119901260741;802.5585927739749;803.7267329108103;804.1154729797234;804.3645520039162;843.161054750521;847.3856454070781;850.3027517435705;851.1233429567525;851.1871163039314;686.7081490366625;802.3861745764494;822.5352675738188;844.2907957315854;845.1717317029315;597.3876776304279;597.9581429299951;600.6576251536626;601.122361352426;601.2604496469323;14851.554453366416;14868.702625947528;14911.478098266618;14922.925385373112;14928.62678433037;13363.33183340829;13957.092788968685;13985.370658320298;14017.793453277316;14020.509282175177;12672;12684.746305073939;12707;12762.106652534327;12865.4210560525;4354.129174165148;4412.779361031936;4498.955010449887;4530.79611417487;4673.976630116862;74467.25532744658;74506.62746686286;74510.62744686242;75378;76701.23298766997;10630.681079567625;10739.570417183226;10997.835032474519;11020.228583999044;11083.224174307721;19677.016149192485;19717.014149292478;19930.402087937386;20572.279970200972;20613.381598552067;8459.111793261742;8517.44636598619;8537.103604121477;8693.304535637133;8739.825203495895;4836.105320515646;4883.340748998839;4891.706497610155;4942.110420124341;5091.592672586185;3336.282699219679;3455.032590874559;3455.8272086395577;3458.6195518492946;3460.723142148622;544.8202093309199;555.2504119438726;558.8546977785805;559.5327901202542;588.4497994375273;494.5573711528162;554.500949145772;625.4621025917708;631.255118959632;643.9839004024843;9080.8637870432;9174.541272936327;9286.303527235485;9400.15398614128;9445.640339844289;631.8294060603612;651.7458191305394;663.349917081263;675.8952362383839;678.1963373402435;4390.8024138913825;4422.5356337584735;4447.68793206005;4452.287633978548;4527.592516673515;84792;84868;106643.4667826656;115790.42104789423;118149;91763;93781;95821;96691.51654241684;97850;85390;85642.57178714067;86194.13805861986;86771;86968;8354.62404191825;8364.87452688198;8394;8401.957990210254;8491.702790402307;48646.27030594615;49382;49833;50241.748791255806;50614.746926265136;59890.10164847444;62442.687786562594;69641;72112.63943680248;72407;11497;11587;11626.476808543466;11684.649460516199;11903.047756179312;13429.26139062361;13843.515476958259;13910.791338130139;14114.082584631966;14154.716905662035;7581.772546823604;12275.324857132944;13048.869511304765;13277.734445311233;13604.86395136036;13104.737905242033;13157.934210328887;13242.271675057964;13278.734425311633;14176.362063706953;13056.281904495345;13139;13339.599812005656;13457.125286856322;13567.660808479866;10562.15502759762;10594.15246780271;10868.94565527199;10908.61819836302;11090;11055;11371.715707107389;11515.53937842477;11552.711182220512;11652.417379131179 02:29:12 INFO - PROCESS | 4379 | __end_tp_report 02:29:12 INFO - PROCESS | 4379 | __start_cc_report 02:29:12 INFO - PROCESS | 4379 | _x_x_mozilla_cycle_collect,806 02:29:12 INFO - PROCESS | 4379 | __end_cc_report 02:29:12 INFO - PROCESS | 4379 | __startTimestamp1465550952242__endTimestamp 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | ------- Summary: start ------- 02:29:12 INFO - PROCESS | 4379 | Number of tests: 6 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#0] dojo.html Cycles:165 Average:5357.86 Median:5537.03 stddev:607.14 (11.0%) stddev-sans-first:581.74 02:29:12 INFO - PROCESS | 4379 | Values: 3064.8 3089.4 3104.9 3123.6 3164.7 5249.4 5311.3 5332.3 5431.9 5440.3 5370.4 5381.4 5413.5 5436.0 5468.6 4830.2 4920.3 4927.5 4937.2 5106.2 5027.4 5041.1 5070.9 5092.9 5098.0 4723.2 4791.1 4815.6 4860.9 4905.1 4832.9 4848.7 4855.1 4860.5 4901.0 4781.5 4818.7 4836.7 4845.9 4871.6 5304.7 5387.3 5471.0 5477.9 5478.8 5820.0 5842.3 5855.1 5872.7 5874.8 5603.7 5783.9 5902.7 5918.4 5922.1 5410.4 5506.0 5529.0 5529.9 5537.0 6021.5 6027.4 6040.4 6040.8 6041.8 5507.1 5596.0 5610.7 5779.7 5787.3 5743.0 5765.7 5792.7 5802.4 5806.7 5701.5 5714.2 5717.5 5747.8 5779.4 5550.9 5722.9 5775.0 5777.8 5783.1 4460.8 4461.0 4462.1 4465.7 4502.8 3953.8 3973.5 3979.1 3982.7 4014.3 5212.2 5263.7 5281.8 5326.9 5329.6 5737.5 5758.9 5765.4 5765.9 5807.0 5366.5 5376.8 5377.0 5379.0 5381.4 4853.5 4993.5 5034.8 5039.0 5087.7 5980.8 5981.3 5994.0 6003.5 6008.7 5588.3 5837.8 5854.5 5860.6 5861.4 5766.2 5766.9 5832.2 5892.2 5897.6 5655.5 5689.0 5693.5 5701.4 5701.5 5614.0 5686.0 5777.4 5788.6 5792.9 5545.5 5628.4 5631.8 5675.6 5679.8 5559.3 5599.5 5607.3 5608.1 5615.2 5356.7 5484.9 5495.5 5497.5 5502.0 5609.4 5744.5 5747.3 5750.0 5751.5 5503.7 5514.0 5543.6 5545.8 5586.5 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#1] ext.html Cycles:180 Average:57947.17 Median:40363.20 stddev:115608.78 (286.4%) stddev-sans-first:115852.86 02:29:12 INFO - PROCESS | 4379 | Values: 582.0 605.0 621.7 636.7 646.0 32357.4 35834.8 41624.6 42366.8 42441.8 44155.1 44568.8 44583.8 44587.3 44652.8 8839.4 8979.1 8988.4 8989.7 8991.4 8864.9 8963.6 8965.3 8971.5 8973.0 9021.4 9081.6 9084.3 9088.8 9097.2 9007.5 9030.0 9055.5 9056.2 9060.5 8880.2 8928.4 8932.2 8933.2 8952.8 42101.2 42383.6 42507.1 42528.6 42559.8 3424.8 3444.0 3598.3 3631.4 3656.6 31970.5 32389.7 32574.2 33130.0 34188.5 4295.2 4328.6 4331.6 4446.5 4480.4 360040.0 363563.0 363595.0 363816.2 363891.0 33091.2 33873.5 56963.0 57067.7 57474.7 36270.8 36442.8 36483.5 36524.8 36540.0 15864.4 16016.0 16018.8 16022.8 16023.8 13303.2 13524.5 13575.9 13627.9 13633.5 8221.1 8221.9 8287.6 8322.8 8357.2 3180.0 3205.4 3238.9 3258.7 3278.7 965.4 1002.7 1018.9 1046.0 1114.8 31708.2 31936.7 32220.4 32367.0 32619.7 1114.3 1131.9 1147.1 1167.6 1228.6 16439.9 17199.0 17246.8 17334.3 17392.3 522842.0 524882.0 528746.0 529138.0 530442.0 59980.4 60379.7 60387.4 60507.7 60577.7 1262.0 1318.7 1339.1 1351.2 1380.7 32345.8 33897.5 33898.2 33965.0 34103.3 50235.7 50235.7 50837.7 50887.2 50945.0 396052.0 398439.0 400686.0 401229.0 402221.0 24411.3 26190.6 27134.6 27252.7 27701.3 47316.5 47681.8 47727.0 48266.5 48861.8 39468.0 40493.4 40599.1 41015.2 41051.4 40233.0 40577.4 40640.0 40786.6 40984.4 40215.0 41010.8 41059.4 41153.2 41195.6 34506.3 36560.6 36594.1 37096.0 37197.6 28048.8 28238.6 28490.0 28511.6 28514.9 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#2] jquery.html Cycles:180 Average:27056.02 Median:2473.71 stddev:75507.61 (3052.4%) stddev-sans-first:75692.88 02:29:12 INFO - PROCESS | 4379 | Values: 390.2 393.6 400.8 400.8 411.6 14092.8 16323.3 17811.5 19368.0 19377.6 14266.8 17243.1 17850.6 17942.5 18355.5 5664.5 5685.2 5852.9 5858.0 5864.5 4165.6 5665.9 5741.4 5775.6 6081.9 6309.2 6405.7 6427.4 6433.7 6439.1 6343.9 6366.4 6404.4 6517.7 6521.6 5570.2 5685.3 5698.1 5703.0 5710.5 21276.0 21734.7 21917.1 21968.6 22051.7 2307.3 2334.2 2451.8 2495.6 2514.9 12677.7 13442.6 13710.0 14036.9 14485.8 1879.3 1881.3 1919.2 1982.3 2010.2 72073.3 74120.0 74834.6 75410.6 76937.6 9560.7 9638.0 10348.5 10820.6 10998.5 14157.6 14252.8 14291.5 14364.6 14379.9 7411.6 7743.7 7783.8 8140.9 8212.3 7935.3 8041.4 8152.3 8166.1 8204.6 6300.7 6456.4 6466.6 6486.2 6555.5 1882.9 1910.8 1922.0 1949.5 1980.9 868.9 982.0 1015.8 1033.6 1035.3 18529.3 18785.5 18861.2 18984.0 19417.0 1009.4 1020.6 1030.4 1069.1 1075.5 10558.2 10977.7 10992.2 10998.9 11005.9 450023.0 451502.0 452480.0 459657.0 484051.0 79588.0 80870.2 81355.2 81516.0 82360.0 985.3 1005.9 1010.4 1024.3 1027.0 16678.4 16789.6 16879.0 16953.4 17073.3 35528.6 36088.5 36639.3 37335.0 38416.2 35333.4 47121.5 47200.0 47918.0 51010.0 8187.4 8296.0 8312.6 8477.6 8636.6 12415.8 12427.7 12557.8 12829.5 13012.3 10948.7 11298.3 11399.3 11403.1 11490.8 6009.8 9249.1 11292.0 11417.5 11443.9 11302.4 11360.0 11550.6 11669.2 11826.5 7449.1 7612.4 7630.4 7919.3 8697.4 11023.4 11181.2 11419.8 11497.7 11678.1 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#3] mootools.html Cycles:180 Average:5939.05 Median:2567.93 stddev:3466.52 (135.0%) stddev-sans-first:3459.07 02:29:12 INFO - PROCESS | 4379 | Values: 1347.3 1442.3 1507.6 1600.6 1781.4 8602.4 8904.7 8919.2 9071.3 9171.0 8907.6 9082.0 9097.9 9108.2 9124.5 2026.7 2287.9 2330.4 2343.4 2369.0 2316.5 2329.7 2331.8 2332.1 2338.3 2337.0 2345.8 2366.2 2368.9 2369.4 1963.2 2209.3 2237.4 2292.6 2300.9 2274.7 2295.0 2299.1 2299.8 2301.7 9158.1 9221.4 9238.4 9239.1 9240.8 5267.7 5411.0 5421.2 5422.3 5423.6 3265.9 3281.0 3337.1 3359.4 3472.4 1090.7 1113.8 1131.4 1143.1 1165.3 13054.8 13076.2 13090.2 13096.7 13112.6 4672.6 4680.8 4789.5 4795.5 4810.3 10660.2 10679.4 10705.4 10783.6 10783.9 5289.2 5335.3 5339.7 5339.9 5346.9 4286.1 4723.0 4933.3 4934.4 4938.4 3968.5 3972.6 4039.4 4071.2 4132.9 1239.7 1243.5 1275.8 1277.7 1286.7 954.6 974.7 975.7 988.0 1006.3 5845.8 5988.8 6123.2 6188.2 6266.1 437.5 439.6 446.6 463.2 471.4 4098.4 4247.8 4271.7 4288.8 4293.5 11102.0 11376.1 11407.1 11422.3 11445.9 10578.3 10992.7 11000.6 11038.6 11270.6 8313.4 8409.8 8443.5 8443.6 8446.8 5947.8 6187.1 6204.6 6228.7 6271.7 10233.2 10402.2 10471.9 10480.6 10502.9 10197.4 10413.4 10688.8 10695.7 10731.2 7255.9 7499.9 7503.2 8102.8 8222.7 8688.4 8979.6 9011.9 9017.2 9019.9 7609.8 7671.5 7782.6 7881.3 7967.2 7651.2 7653.3 7748.1 7823.5 7940.2 7299.1 7330.0 7353.6 7356.9 7362.4 5081.8 5177.2 5317.5 5389.2 5424.9 5126.3 5162.9 5327.9 5515.8 5550.5 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#4] prototype.html Cycles:180 Average:4510.39 Median:5088.60 stddev:1290.05 (25.4%) stddev-sans-first:1254.81 02:29:12 INFO - PROCESS | 4379 | Values: 323.6 328.7 334.1 336.9 338.4 5339.9 5379.4 5392.4 5406.1 5407.4 5004.0 5147.2 5165.9 5173.7 5310.8 4059.6 4066.7 4088.6 4173.5 4180.4 4091.7 4112.7 4114.5 4132.2 4163.3 4050.6 4081.9 4145.1 4152.4 4172.7 4099.6 4124.9 4133.4 4137.2 4146.3 3652.7 3675.7 3677.2 3677.2 3698.1 5068.7 5082.9 5224.2 5224.4 5240.8 4684.6 4694.2 4696.7 4701.2 4716.5 5501.3 5504.7 5505.8 5511.3 5519.3 3889.2 3977.3 4010.0 4010.2 4019.3 5653.8 5710.5 5725.7 5734.9 5778.1 4160.9 4169.6 4180.0 4187.5 4187.5 4167.2 4252.2 4256.7 4262.9 4289.4 4747.6 4762.1 4766.0 4771.9 4781.2 5585.9 5595.0 5611.2 5635.8 5644.7 1355.0 1395.9 1442.8 1458.9 1461.6 936.3 954.8 963.5 963.6 964.2 4709.9 4831.0 4838.6 4849.8 4855.4 5053.7 5081.2 5090.9 5103.6 5109.9 4658.8 4673.0 4691.5 4786.8 4793.7 2684.3 2690.6 2702.8 2724.7 2724.7 5129.0 5197.4 5205.5 5209.8 5222.4 4916.7 5147.8 5158.7 5187.5 5218.7 5132.7 5137.5 5145.5 5161.6 5170.3 4895.9 5026.8 5030.3 5089.3 5132.5 5058.9 5087.9 5098.3 5102.3 5117.8 5204.3 5215.0 5219.3 5225.9 5236.5 3733.5 3846.9 3861.7 3864.6 3876.0 5131.8 5146.0 5504.6 5634.8 5734.8 5593.6 5594.6 5598.2 5608.5 5609.9 5536.2 5558.4 5572.4 5582.1 5602.2 5185.5 5485.7 5486.8 5486.9 5501.5 5548.4 5594.3 5596.8 5621.6 5622.3 5251.2 5490.6 5508.3 5524.9 5544.1 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - PROCESS | 4379 | [#5] yui.html Cycles:180 Average:19840.40 Median:27136.85 stddev:28243.99 (104.1%) stddev-sans-first:28286.73 02:29:12 INFO - PROCESS | 4379 | Values: 719.1 736.1 781.1 783.5 786.8 15225.6 15240.3 15351.8 15371.2 15582.8 13407.7 13635.7 14845.4 15015.5 15185.4 672.1 779.8 784.6 784.9 789.7 793.5 802.6 803.7 804.1 804.4 843.2 847.4 850.3 851.1 851.2 686.7 802.4 822.5 844.3 845.2 597.4 598.0 600.7 601.1 601.3 14851.6 14868.7 14911.5 14922.9 14928.6 13363.3 13957.1 13985.4 14017.8 14020.5 12672.0 12684.7 12707.0 12762.1 12865.4 4354.1 4412.8 4499.0 4530.8 4674.0 74467.3 74506.6 74510.6 75378.0 76701.2 10630.7 10739.6 10997.8 11020.2 11083.2 19677.0 19717.0 19930.4 20572.3 20613.4 8459.1 8517.4 8537.1 8693.3 8739.8 4836.1 4883.3 4891.7 4942.1 5091.6 3336.3 3455.0 3455.8 3458.6 3460.7 544.8 555.3 558.9 559.5 588.4 494.6 554.5 625.5 631.3 644.0 9080.9 9174.5 9286.3 9400.2 9445.6 631.8 651.7 663.3 675.9 678.2 4390.8 4422.5 4447.7 4452.3 4527.6 84792.0 84868.0 106643.5 115790.4 118149.0 91763.0 93781.0 95821.0 96691.5 97850.0 85390.0 85642.6 86194.1 86771.0 86968.0 8354.6 8364.9 8394.0 8402.0 8491.7 48646.3 49382.0 49833.0 50241.7 50614.7 59890.1 62442.7 69641.0 72112.6 72407.0 11497.0 11587.0 11626.5 11684.6 11903.0 13429.3 13843.5 13910.8 14114.1 14154.7 7581.8 12275.3 13048.9 13277.7 13604.9 13104.7 13157.9 13242.3 13278.7 14176.4 13056.3 13139.0 13339.6 13457.1 13567.7 10562.2 10594.2 10868.9 10908.6 11090.0 11055.0 11371.7 11515.5 11552.7 11652.4 02:29:12 INFO - PROCESS | 4379 | -------- Summary: end -------- 02:29:12 INFO - PROCESS | 4379 | 02:29:12 INFO - TEST-INFO | 4379: exit 0 02:29:13 INFO - TEST-OK | dromaeo_css | took 1114724ms 02:29:13 INFO - TEST-START | kraken 02:29:13 INFO - operating with platform_type : linux_ 02:29:13 INFO - Initialising browser for kraken test... 02:29:13 INFO - TEST-INFO | started process 4559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpViEZIv/profile http://localhost:44071/getInfo.html) 02:29:17 INFO - PROCESS | 4559 | __metrics Screen width/height:1600/1200 02:29:17 INFO - PROCESS | 4559 | colorDepth:24 02:29:17 INFO - PROCESS | 4559 | Browser inner width/height: 1024/697 02:29:17 INFO - PROCESS | 4559 | __metrics 02:29:18 ERROR - PROCESS | 4559 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:29:18 INFO - PROCESS | 4559 | console.error: PushService: 02:29:18 INFO - PROCESS | 4559 | stateChangeProcessEnqueue: Error transitioning state 02:29:18 INFO - PROCESS | 4559 | UnknownError 02:29:19 INFO - TEST-INFO | 4559: exit 0 02:29:19 INFO - Browser initialized. 02:29:19 INFO - Running cycle 1/1 for kraken test... 02:29:19 INFO - TEST-INFO | started process 4641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpViEZIv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:31 INFO - PROCESS | 4641 | RSS: Main: 176205824 02:29:31 INFO - PROCESS | 4641 | 02:29:33 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44071/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:34 INFO - PROCESS | 4641 | RSS: Main: 235393024 02:29:34 INFO - PROCESS | 4641 | 02:29:37 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44071/tests/kraken/driver.html?testName=audio-dft) 02:29:38 INFO - PROCESS | 4641 | RSS: Main: 223969280 02:29:38 INFO - PROCESS | 4641 | 02:29:41 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44071/tests/kraken/driver.html?testName=audio-fft) 02:29:41 INFO - PROCESS | 4641 | RSS: Main: 289107968 02:29:41 INFO - PROCESS | 4641 | 02:29:43 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44071/tests/kraken/driver.html?testName=audio-oscillator) 02:29:44 INFO - PROCESS | 4641 | RSS: Main: 200343552 02:29:44 INFO - PROCESS | 4641 | 02:29:46 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44071/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:47 INFO - PROCESS | 4641 | RSS: Main: 204419072 02:29:47 INFO - PROCESS | 4641 | 02:29:50 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44071/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:50 INFO - PROCESS | 4641 | RSS: Main: 240021504 02:29:50 INFO - PROCESS | 4641 | 02:29:54 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44071/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:54 INFO - PROCESS | 4641 | RSS: Main: 240324608 02:29:54 INFO - PROCESS | 4641 | 02:29:57 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44071/tests/kraken/driver.html?testName=json-parse-financial) 02:29:58 INFO - PROCESS | 4641 | RSS: Main: 240889856 02:29:58 INFO - PROCESS | 4641 | 02:29:59 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44071/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:00 INFO - PROCESS | 4641 | RSS: Main: 224030720 02:30:00 INFO - PROCESS | 4641 | 02:30:02 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:02 INFO - PROCESS | 4641 | RSS: Main: 230277120 02:30:02 INFO - PROCESS | 4641 | 02:30:04 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:05 INFO - PROCESS | 4641 | RSS: Main: 234827776 02:30:05 INFO - PROCESS | 4641 | 02:30:08 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:08 INFO - PROCESS | 4641 | RSS: Main: 239566848 02:30:08 INFO - PROCESS | 4641 | 02:30:11 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:12 INFO - PROCESS | 4641 | RSS: Main: 240934912 02:30:12 INFO - PROCESS | 4641 | 02:30:13 INFO - PROCESS | 4641 | Cycle 1(1): loaded http://localhost:44071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44071/tests/kraken/driver.html?testName=ai-astar) 02:30:13 INFO - PROCESS | 4641 | RSS: Main: 282710016 02:30:13 INFO - PROCESS | 4641 | 02:30:13 INFO - PROCESS | 4641 | __start_tp_report 02:30:13 INFO - PROCESS | 4641 | _x_x_mozilla_page_load 02:30:13 INFO - PROCESS | 4641 | _x_x_mozilla_page_load_details 02:30:13 INFO - PROCESS | 4641 | |i|pagename|runs| 02:30:13 INFO - PROCESS | 4641 | |0;ai-astar;112;112;110;109;114;110;112;111;112;111 02:30:13 INFO - PROCESS | 4641 | |1;audio-beat-detection;160;125;128;186;126;126;153;135;168;125 02:30:13 INFO - PROCESS | 4641 | |2;audio-dft;160;161;161;160;160;162;161;163;162;161 02:30:13 INFO - PROCESS | 4641 | |3;audio-fft;74;75;77;128;86;76;74;74;100;75 02:30:13 INFO - PROCESS | 4641 | |4;audio-oscillator;84;85;110;83;85;86;117;84;85;125 02:30:14 INFO - PROCESS | 4641 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;117;117 02:30:14 INFO - PROCESS | 4641 | |6;imaging-darkroom;147;147;147;145;147;146;146;145;147;145 02:30:14 INFO - PROCESS | 4641 | |7;imaging-desaturate;95;95;96;96;95;95;95;94;95;95 02:30:14 INFO - PROCESS | 4641 | |8;json-parse-financial;52;56;53;54;53;54;54;53;54;53 02:30:14 INFO - PROCESS | 4641 | |9;json-stringify-tinderbox;61;61;61;60;62;61;61;61;61;61 02:30:14 INFO - PROCESS | 4641 | |10;stanford-crypto-aes;82;80;79;79;81;82;81;82;133;81 02:30:14 INFO - PROCESS | 4641 | |11;stanford-crypto-ccm;131;135;120;141;140;127;121;124;125;121 02:30:14 INFO - PROCESS | 4641 | |12;stanford-crypto-pbkdf2;161;158;159;158;165;163;162;161;164;160 02:30:14 INFO - PROCESS | 4641 | |13;stanford-crypto-sha256-iterative;63;64;63;62;63;61;65;63;63;62 02:30:14 INFO - PROCESS | 4641 | __end_tp_report 02:30:14 INFO - PROCESS | 4641 | __start_cc_report 02:30:14 INFO - PROCESS | 4641 | _x_x_mozilla_cycle_collect,1629 02:30:14 INFO - PROCESS | 4641 | __end_cc_report 02:30:14 INFO - PROCESS | 4641 | __startTimestamp1465551013995__endTimestamp 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | ------- Summary: start ------- 02:30:14 INFO - PROCESS | 4641 | Number of tests: 14 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.48 02:30:14 INFO - PROCESS | 4641 | Values: 112.0 112.0 110.0 109.0 114.0 110.0 112.0 111.0 112.0 111.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:144.00 stddev:22.05 (15.3%) stddev-sans-first:22.54 02:30:14 INFO - PROCESS | 4641 | Values: 160.0 125.0 128.0 186.0 126.0 126.0 153.0 135.0 168.0 125.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 02:30:14 INFO - PROCESS | 4641 | Values: 160.0 161.0 161.0 160.0 160.0 162.0 161.0 163.0 162.0 161.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:17.55 (23.4%) stddev-sans-first:18.24 02:30:14 INFO - PROCESS | 4641 | Values: 74.0 75.0 77.0 128.0 86.0 76.0 74.0 74.0 100.0 75.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.50 stddev:16.24 (19.2%) stddev-sans-first:16.78 02:30:14 INFO - PROCESS | 4641 | Values: 84.0 85.0 110.0 83.0 85.0 86.0 117.0 84.0 85.0 125.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:30:14 INFO - PROCESS | 4641 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 02:30:14 INFO - PROCESS | 4641 | Values: 147.0 147.0 147.0 145.0 147.0 146.0 146.0 145.0 147.0 145.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:30:14 INFO - PROCESS | 4641 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.07 (2.0%) stddev-sans-first:0.97 02:30:14 INFO - PROCESS | 4641 | Values: 52.0 56.0 53.0 54.0 53.0 54.0 54.0 53.0 54.0 53.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 02:30:14 INFO - PROCESS | 4641 | Values: 61.0 61.0 61.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:81.00 stddev:16.55 (20.4%) stddev-sans-first:17.49 02:30:14 INFO - PROCESS | 4641 | Values: 82.0 80.0 79.0 79.0 81.0 82.0 81.0 82.0 133.0 81.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:129.00 stddev:7.86 (6.1%) stddev-sans-first:8.29 02:30:14 INFO - PROCESS | 4641 | Values: 131.0 135.0 120.0 141.0 140.0 127.0 121.0 124.0 125.0 121.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.42 (1.5%) stddev-sans-first:2.57 02:30:14 INFO - PROCESS | 4641 | Values: 161.0 158.0 159.0 158.0 165.0 163.0 162.0 161.0 164.0 160.0 02:30:14 INFO - PROCESS | 4641 | 02:30:14 INFO - PROCESS | 4641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 02:30:14 INFO - PROCESS | 4641 | Values: 63.0 64.0 63.0 62.0 63.0 61.0 65.0 63.0 63.0 62.0 02:30:14 INFO - PROCESS | 4641 | -------- Summary: end -------- 02:30:14 INFO - PROCESS | 4641 | 02:30:15 INFO - TEST-INFO | 4641: exit 0 02:30:15 INFO - TEST-OK | kraken | took 62060ms 02:30:15 INFO - SUITE-END | took 1176s 02:30:15 INFO - Completed test suite (00:19:36) 02:30:15 INFO - javascript benchmark 02:30:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.7701422393325, 3089.443900097983, 3104.906852794417, 3123.6251649802025, 3164.7151756341923, 5249.370075590925, 5311.282976798131, 5332.306800115989, 5431.891362172754, 5440.265564148839, 5370.355557333126, 5381.381141168767, 5413.458654134584, 5435.972820135904, 5468.644538105021, 4830.227163653816, 4920.286558449023, 4927.482614325498, 4937.185364414885, 5106.208537676647, 5027.4469808321055, 5041.143005689023, 5070.898582028357, 5092.949070509285, 5098.005888851657, 4723.244280915054, 4791.113643975876, 4815.5906747926465, 4860.854174374775, 4905.068037072945, 4832.9275060874115, 4848.7090774553635, 4855.126077306083, 4860.465348811628, 4901.01979604077, 4781.521847815191, 4818.734969576672, 4836.733979631119, 4845.927311090337, 4871.56155945963, 5304.681719096867, 5387.272718183034, 5470.972645136789, 5477.863053423656, 5478.780848766045, 5820.0, 5842.269716285465, 5855.063189889597, 5872.7063646817915, 5874.823755287305, 5603.691796951166, 5783.88432231353, 5902.675352855591, 5918.40815918409, 5922.1116832475045, 5410.377806552218, 5505.9724701376235, 5528.9723551381985, 5529.889402211974, 5537.031019571599, 6021.458068773743, 6027.367126451747, 6040.365761595057, 6040.788572399945, 6041.78853740117, 5507.118860982304, 5596.048671725816, 5610.691411972381, 5779.682117483579, 5787.305523337226, 5742.971285143548, 5765.711714414347, 5792.681402522818, 5802.4197580241635, 5806.738696758656, 5701.458361455655, 5714.171445140431, 5717.542596592262, 5747.770089196469, 5779.393163717749, 5550.888982220414, 5722.856928576819, 5775.047117225611, 5777.826665200051, 5783.074708046693, 4460.843870464518, 4460.955390446054, 4462.129884672523, 4465.687401881902, 4502.774861256924, 3953.78254196022, 3973.543042550086, 3979.1047014421524, 3982.7411218270718, 4014.2573623879675, 5212.166053431432, 5263.6841789492755, 5281.815136470205, 5326.893462130735, 5329.626926115135, 5737.483626473638, 5758.88482230353, 5765.365809760923, 5765.85585360361, 5807.041838096751, 5366.517013468807, 5376.758045887945, 5377.0321342158, 5379.0, 5381.354237491526, 4853.466118726938, 4993.525615066563, 5034.79860805571, 5038.974805125951, 5087.6947383156385, 5980.760769569256, 5981.282246130492, 5994.040953447515, 6003.459688628044, 6008.729607167688, 5588.273524441796, 5837.824865254049, 5854.531637468907, 5860.560457965585, 5861.443162899518, 5766.221560089334, 5766.8846623066465, 5832.1543376209365, 5892.175095486721, 5897.64614123154, 5655.519280861173, 5689.032864412977, 5693.5160511357, 5701.4298570142655, 5701.458361455655, 5614.0, 5686.0, 5777.364489906191, 5788.565857560616, 5792.884142317046, 5545.500904918576, 5628.352739435018, 5631.831045068655, 5675.57433192504, 5679.829605111853, 5559.305086864142, 5599.496045355938, 5607.327120745536, 5608.10270356741, 5615.157726341082, 5356.732163391737, 5484.945150548443, 5495.450454954473, 5497.47773961473, 5502.024995651755, 5609.411011843697, 5744.511716504144, 5747.281589801275, 5750.0, 5751.482366587027, 5503.669779813224, 5513.972430137824, 5543.556515478671, 5545.750441230073, 5586.52514536269], "value": 5317.048128709181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.9970900145498, 604.9606775559591, 621.7388696747365, 636.6943866943867, 646.0374042676414, 32357.352852942957, 35834.82082589587, 41624.58375416245, 42366.78816605913, 42441.78779106108, 44155.116897662025, 44568.77715611417, 44583.77708111463, 44587.33119003209, 44652.77673611636, 8839.425437346568, 8979.102089791035, 8988.370814043019, 8989.685361012365, 8991.38155132076, 8864.8670269946, 8963.596638151299, 8965.282777377826, 8971.506567138806, 8973.0, 9021.413608115485, 9081.591328390205, 9084.318676099287, 9088.818223635524, 9097.181253687168, 9007.54962251888, 9030.006699263076, 9055.501947392891, 9056.184943355096, 9060.456372617664, 8880.1563851434, 8928.419652722552, 8932.240759535447, 8933.196012358854, 8952.776180595472, 42101.15797684029, 42383.57616423827, 42507.14985700269, 42528.57471425277, 42559.787201063795, 3424.7773894696766, 3444.0356700124007, 3598.2803439312243, 3631.382664946965, 3656.634336566349, 31970.5117172148, 32389.6761032389, 32574.18564535882, 33130.0, 34188.48717269243, 4295.248331541968, 4328.63206627437, 4331.631811296043, 4446.510883802779, 4480.395146655193, 360040.0, 363563.0, 363594.9999999974, 363816.18091909634, 363891.0, 33091.172720681694, 33873.49189762106, 56963.0, 57067.71466142643, 57474.7126264366, 36270.8186459066, 36442.81778591143, 36483.4527482088, 36524.81737591295, 36540.0, 15864.44474443389, 16016.0, 16018.839811601967, 16022.75965860513, 16023.839761602234, 13303.201807891557, 13524.526641567694, 13575.932120339532, 13627.931860340834, 13633.522826701017, 8221.054578723404, 8221.876671849926, 8287.62705678246, 8322.791930201793, 8357.247847693738, 3179.9682003179673, 3205.406999705062, 3238.8704451822136, 3258.6904244096772, 3278.67213278675, 965.4062751407834, 1002.7292630989592, 1018.9286749927583, 1046.0, 1114.8383484394878, 31708.207294817814, 31936.680633193835, 32220.411377421235, 32367.0, 32619.673803261663, 1114.3202646385698, 1131.9490622921987, 1147.1281825812275, 1167.6146871532374, 1228.6252692928742, 16439.91780041116, 17199.0, 17246.82753172477, 17334.30662773475, 17392.3043078278, 522842.0, 524882.0, 528746.0, 529138.0, 530442.0, 59980.40019599835, 60379.69810150921, 60387.39612603818, 60507.69746151241, 60577.69711151416, 1262.040848954801, 1318.736252749454, 1339.0827283310964, 1351.209542417677, 1380.6962468256968, 32345.838270809436, 33897.51475767706, 33898.152546185556, 33965.0, 34103.31793364069, 50235.74882125566, 50235.74882125712, 50837.74581127071, 50887.2366914504, 50945.0, 396052.0, 398439.0, 400686.0, 401229.0, 402221.0, 24411.26766197017, 26190.607140893284, 27134.592981104903, 27252.72747272502, 27701.30746731348, 47316.52683473121, 47681.761591191826, 47727.0, 48266.51733482761, 48861.75569122132, 39468.0, 40493.39259911045, 40599.128104627634, 41015.1796964065, 41051.384229237185, 40233.0, 40577.391339130525, 40640.0, 40786.59213407828, 40984.385234220914, 40215.0, 41010.79494602508, 41059.384109238985, 41153.1769364617, 41195.58804412038, 34506.309873802886, 36560.634393655724, 36594.128873761976, 37096.0, 37197.628023719415, 28048.774445441446, 28238.57690966216, 28490.0, 28511.572326415535, 28514.91281088085], "value": 18864.653722873267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.20593093055635, 393.57297332394353, 400.76154687960656, 400.77756844951057, 411.6418715717326, 14092.788608170886, 16323.265453054611, 17811.46565603031, 19367.99999999998, 19377.612447751053, 14266.785998210034, 17243.137843107826, 17850.553736156602, 17942.461726148205, 18355.54111147222, 5664.490195882359, 5685.204071430003, 5852.941470585303, 5857.970710146444, 5864.530837532987, 4165.56261592533, 5665.886682266352, 5741.368449470555, 5775.56683248756, 6081.939180608204, 6309.179806625132, 6405.743770249184, 6427.389398007182, 6433.7426502939825, 6439.130717353168, 6343.936560634381, 6366.395192456709, 6404.391582799627, 6517.706703198368, 6521.641309727939, 5570.1822054776, 5685.260916080883, 5698.059820129673, 5702.971485142548, 5710.457506536873, 21276.0, 21734.673979890315, 21917.12331506738, 21968.560628787494, 22051.66922496164, 2307.3424074138957, 2334.159702507096, 2451.7793398594035, 2495.638132470782, 2514.88683009265, 12677.683057923534, 13442.596722098353, 13710.0, 14036.859631403657, 14485.78271325931, 1879.2670858365248, 1881.3039175505014, 1919.2131226197332, 1982.2754203842749, 2010.2059686423927, 72073.27926720718, 74120.0, 74834.62582687107, 75410.62294688492, 76937.61531192309, 9560.665376711782, 9638.0, 10348.482575871176, 10820.56717731282, 10998.505067271992, 14157.646058848406, 14252.786208206886, 14291.499797507246, 14364.56906292792, 14379.85620143806, 7411.629418529052, 7743.728969486041, 7783.766487005399, 8140.877886831702, 8212.260896519223, 7935.33357994816, 8041.356691464669, 8152.347812175011, 8166.101728809826, 8204.630791614392, 6300.653464059429, 6456.386643268882, 6466.64433456155, 6486.189226346707, 6555.541112122106, 1882.8870267783977, 1910.837578805817, 1921.9807801921802, 1949.541857663448, 1980.9009549522466, 868.8740132680726, 982.0, 1015.7562185075528, 1033.560736686905, 1035.3477309295097, 18529.258829646664, 18785.53036174079, 18861.151248193863, 18984.0, 19417.0, 1009.3893194617151, 1020.637673625867, 1030.4332617060586, 1069.0699091790193, 1075.537518866879, 10558.208134389797, 10977.725556860983, 10992.230543862013, 10998.945005274922, 11005.889941100646, 450023.0, 451502.0, 452480.0, 459657.0, 484051.0, 79588.0, 80870.19129808627, 81355.18644813476, 81516.0, 82360.0, 985.261054209343, 1005.8541511480794, 1010.4392062405435, 1024.3393011507535, 1026.9691909242736, 16678.416255431002, 16789.580260493585, 16879.0, 16953.406630767862, 17073.31706731717, 35528.64471355253, 36088.45867312045, 36639.267214655025, 37335.0, 38416.23167536689, 35333.409996550734, 47121.528784711714, 47200.0, 47918.0, 51010.0, 8187.426880118334, 8295.95852020736, 8312.625931832961, 8477.576121193792, 8636.611352489279, 12415.813762793385, 12427.689307767378, 12557.811632825698, 12829.486820527447, 13012.28432436225, 10948.726281843017, 11298.265612735146, 11399.259048161843, 11403.144764142557, 11490.77018459643, 6009.759609615567, 9249.12133347331, 11292.024124684023, 11417.486213120263, 11443.885561144614, 11302.43487825622, 11360.0, 11550.59572914944, 11669.183157178915, 11826.52693892269, 7449.106107267163, 7612.429067820047, 7630.351420129129, 7919.326857216971, 8697.434666746894, 11023.393713345842, 11181.217314787888, 11419.828702569634, 11497.655070347902, 11678.06575473977], "value": 9070.042935752555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.2657401716065, 1442.2932762946157, 1507.562806786032, 1600.5838481994679, 1781.4032299179773, 8602.354823388247, 8904.688335908237, 8919.241864441523, 9071.274298056156, 9171.037041110687, 8907.599158037887, 9082.0, 9097.863532047024, 9108.18026377626, 9124.54377281135, 2026.6656001759693, 2287.885605719707, 2330.417395651087, 2343.3907184132163, 2368.969498268259, 2316.4903721181313, 2329.650552417134, 2331.825113116515, 2332.148765700524, 2338.251759436981, 2336.9883150584224, 2345.847519911209, 2366.2428023032635, 2368.9221404261107, 2369.4431808524982, 1963.18527810959, 2209.2709405896017, 2237.362351729749, 2292.5758734634146, 2300.907963681451, 2274.6815445837597, 2294.9885250573807, 2299.1148407862925, 2299.8160147188187, 2301.6777651128855, 9158.084191580789, 9221.400608960395, 9238.399504032217, 9239.076092390775, 9240.815183696355, 5267.683938963674, 5410.972945135289, 5421.159720243369, 5422.349318081816, 5423.647462914937, 3265.9183520411943, 3281.0, 3337.1156643489494, 3359.4121028820105, 3472.392331342005, 1090.6564432203832, 1113.8440618313443, 1131.377742241772, 1143.1426430177366, 1165.2775279326872, 13054.804177937338, 13076.215427074407, 13090.214587124708, 13096.708076086741, 13112.574173777786, 4672.626189904868, 4680.765961701902, 4789.4971028041555, 4795.520447955177, 4810.278458231293, 10660.20048496366, 10679.412632305297, 10705.411202383944, 10783.6225732099, 10783.946080269548, 5289.153735402394, 5335.306410166653, 5339.733013349317, 5339.851931834674, 5346.91979620306, 4286.121345124242, 4722.95277047232, 4933.333999910038, 4934.383202099738, 4938.407391113089, 3968.4840970673627, 3972.5828787977425, 4039.3537034074407, 4071.2468193383725, 4132.896677583084, 1239.6962744127566, 1243.4715246020587, 1275.8277632519678, 1277.6869666931661, 1286.7481906663338, 954.6133815804471, 974.6588693957058, 975.7463059604412, 988.0, 1006.2905651515664, 5845.795397161079, 5988.820335389945, 6123.234595675541, 6188.226471691039, 6266.060090986389, 437.50343360285666, 439.59996403273504, 446.60921693518173, 463.23334880772376, 471.3565982434021, 4098.426220329156, 4247.830086796555, 4271.722338048017, 4288.764117973479, 4293.549177336397, 11102.0, 11376.089912806956, 11407.144464165222, 11422.25755325901, 11445.942770286096, 10578.312409693346, 10992.725181870357, 11000.614978475714, 11038.558457661764, 11270.605528806453, 8313.376496762767, 8409.831803363899, 8443.451175673561, 8443.57782110892, 8446.788830279293, 5947.762089516371, 6187.071939209155, 6204.5967012144065, 6228.657423841732, 6271.686415679106, 10233.181345492492, 10402.167826574007, 10471.94764026175, 10480.63317783874, 10502.894971050191, 10197.439140847324, 10413.375197488174, 10688.786224275316, 10695.679129626124, 10731.248812583357, 7255.891161632474, 7499.850003000019, 7503.174650788518, 8102.7569172924905, 8222.671093156207, 8688.391812573313, 8979.595918183566, 9011.864822027806, 9017.233535149586, 9019.909800902169, 7609.809754755954, 7671.501352412075, 7782.649780759993, 7881.251281128284, 7967.2431119043595, 7651.196624354363, 7653.272939070779, 7748.14770375247, 7823.530588164728, 7940.205979402013, 7299.087614048244, 7330.047093877762, 7353.558786472829, 7356.852862942818, 7362.3741981932135, 5081.822136225214, 5177.249298851721, 5317.494837990384, 5389.2067020257655, 5424.918626220689, 5126.256692779601, 5162.870928226825, 5327.893442131213, 5515.806946756844, 5550.500454959073], "value": 4626.585698543773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.57611528897144, 328.65819547670424, 334.1062657391479, 336.91071865955513, 338.36894192331295, 5339.946600533994, 5379.3544774627, 5392.433794451585, 5406.135018397057, 5407.351117865856, 5004.0, 5147.202183661539, 5165.948340516594, 5173.689578625285, 5310.840674779763, 4059.63463288304, 4066.6746660267254, 4088.632023117919, 4173.5409104998425, 4180.435641188446, 4091.652209562176, 4112.712110152291, 4114.485689288839, 4132.2355364257555, 4163.333866581347, 4050.574689657588, 4081.9182916527143, 4145.108801607654, 4152.356384760367, 4172.749635021908, 4099.601732986207, 4124.91750164998, 4133.42132101506, 4137.213929353413, 4146.300016993034, 3652.6712595866234, 3675.7394202565497, 3677.2093999790172, 3677.2461645362637, 3698.130939229279, 5068.695878247317, 5082.949170508285, 5224.242484839715, 5224.373075230958, 5240.79036838526, 4684.5549672781035, 4694.225452800284, 4696.661451486344, 4701.247800351962, 4716.481187069419, 5501.257330260403, 5504.669719816824, 5505.807296744635, 5511.255980442669, 5519.337679478448, 3889.183271512986, 3977.34373828318, 4009.959900400988, 4010.197960407901, 4019.2765302245584, 5653.773849045992, 5710.486056254916, 5725.713714314267, 5734.856628584277, 5778.075507918713, 4160.937585936153, 4169.60388763067, 4180.0, 4187.497500299923, 4187.5184353799095, 4167.249895018926, 4252.234597772431, 4256.659467242614, 4262.936055959163, 4289.39948407217, 4747.572718455286, 4762.119007983534, 4765.976170119127, 4771.922110238946, 4781.183150402825, 5585.88282343533, 5595.0, 5611.158326251095, 5635.774569017275, 5644.745986430538, 1354.9525766598122, 1395.8763195627414, 1442.834074081473, 1458.8832893368506, 1461.6272850423074, 936.344558808823, 954.7804005078871, 963.4797209506928, 963.5663951221838, 964.1804466203671, 4709.882252943636, 4830.95169048305, 4838.637102217348, 4849.830255941025, 4855.36880205571, 5053.722045287471, 5081.161608334657, 5090.949090509048, 5103.566196873233, 5109.923351149736, 4658.790354434059, 4673.0, 4691.460482044608, 4786.760661966958, 4793.688410253322, 2684.315499547603, 2690.63676403683, 2702.810803243754, 2724.6866610340066, 2724.7002829688718, 5129.0, 5197.440767769654, 5205.453427390145, 5209.765560549784, 5222.4255331913455, 4916.72957987307, 5147.7683504242395, 5158.690478571298, 5187.455317191716, 5218.712970786567, 5132.743362831843, 5137.537621614073, 5145.536901678867, 5161.638685292069, 5170.302009228782, 4895.926561101515, 5026.84919452417, 5030.270610761346, 5089.262057001788, 5132.486751324837, 5058.9494105058475, 5087.939384549263, 5098.2862399263395, 5102.285680004728, 5117.801374141161, 5204.2714020036465, 5215.0, 5219.2953951216095, 5225.869353266046, 5236.528712415901, 3733.495978043038, 3846.8649899306156, 3861.6910647147597, 3864.5748967612976, 3875.96124038756, 5131.793328868623, 5145.974270128625, 5504.587155963399, 5634.802781902614, 5734.770609175586, 5593.636413633101, 5594.636348637326, 5598.160275958476, 5608.495235428831, 5609.9158512621525, 5536.197251398444, 5558.416366281483, 5572.4148964358155, 5582.134769110794, 5602.215689803349, 5185.507376799198, 5485.670859748268, 5486.807961721321, 5486.862828429321, 5501.496818947449, 5548.389677135431, 5594.349706796246, 5596.804111856066, 5621.634593751393, 5622.297212848394, 5251.2123181523075, 5490.615656903979, 5508.338999320107, 5524.8784436793085, 5544.085225937675], "value": 4104.773834920827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.0616245799233, 736.0762243384555, 781.0510230070463, 783.4537752305009, 786.8111653203231, 15225.619359516018, 15240.314185861635, 15351.769723454157, 15371.231438428062, 15582.766258506117, 13407.731845363087, 13635.659108522266, 14845.406183752637, 15015.47445839396, 15185.392584296615, 672.0725398949468, 779.8440311937607, 784.5959330944568, 784.9136594974548, 789.6604460082162, 793.5119901260741, 802.5585927739749, 803.7267329108103, 804.1154729797234, 804.3645520039162, 843.161054750521, 847.3856454070781, 850.3027517435705, 851.1233429567525, 851.1871163039314, 686.7081490366625, 802.3861745764494, 822.5352675738188, 844.2907957315854, 845.1717317029315, 597.3876776304279, 597.9581429299951, 600.6576251536626, 601.122361352426, 601.2604496469323, 14851.554453366416, 14868.702625947528, 14911.478098266618, 14922.925385373112, 14928.62678433037, 13363.33183340829, 13957.092788968685, 13985.370658320298, 14017.793453277316, 14020.509282175177, 12672.0, 12684.746305073939, 12707.0, 12762.106652534327, 12865.4210560525, 4354.129174165148, 4412.779361031936, 4498.955010449887, 4530.79611417487, 4673.976630116862, 74467.25532744658, 74506.62746686286, 74510.62744686242, 75378.0, 76701.23298766997, 10630.681079567625, 10739.570417183226, 10997.835032474519, 11020.228583999044, 11083.224174307721, 19677.016149192485, 19717.014149292478, 19930.402087937386, 20572.279970200972, 20613.381598552067, 8459.111793261742, 8517.44636598619, 8537.103604121477, 8693.304535637133, 8739.825203495895, 4836.105320515646, 4883.340748998839, 4891.706497610155, 4942.110420124341, 5091.592672586185, 3336.282699219679, 3455.032590874559, 3455.8272086395577, 3458.6195518492946, 3460.723142148622, 544.8202093309199, 555.2504119438726, 558.8546977785805, 559.5327901202542, 588.4497994375273, 494.5573711528162, 554.500949145772, 625.4621025917708, 631.255118959632, 643.9839004024843, 9080.8637870432, 9174.541272936327, 9286.303527235485, 9400.15398614128, 9445.640339844289, 631.8294060603612, 651.7458191305394, 663.349917081263, 675.8952362383839, 678.1963373402435, 4390.8024138913825, 4422.5356337584735, 4447.68793206005, 4452.287633978548, 4527.592516673515, 84792.0, 84868.0, 106643.4667826656, 115790.42104789423, 118149.0, 91763.0, 93781.0, 95821.0, 96691.51654241684, 97850.0, 85390.0, 85642.57178714067, 86194.13805861986, 86771.0, 86968.0, 8354.62404191825, 8364.87452688198, 8394.0, 8401.957990210254, 8491.702790402307, 48646.27030594615, 49382.0, 49833.0, 50241.748791255806, 50614.746926265136, 59890.10164847444, 62442.687786562594, 69641.0, 72112.63943680248, 72407.0, 11497.0, 11587.0, 11626.476808543466, 11684.649460516199, 11903.047756179312, 13429.26139062361, 13843.515476958259, 13910.791338130139, 14114.082584631966, 14154.716905662035, 7581.772546823604, 12275.324857132944, 13048.869511304765, 13277.734445311233, 13604.86395136036, 13104.737905242033, 13157.934210328887, 13242.271675057964, 13278.734425311633, 14176.362063706953, 13056.281904495345, 13139.0, 13339.599812005656, 13457.125286856322, 13567.660808479866, 10562.15502759762, 10594.15246780271, 10868.94565527199, 10908.61819836302, 11090.0, 11055.0, 11371.715707107389, 11515.53937842477, 11552.711182220512, 11652.417379131179], "value": 7279.504967660018, "unit": "score"}], "name": "dromaeo_css", "value": 7078.43703350542, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 109.0, 114.0, 110.0, 112.0, 111.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 128.0, 186.0, 126.0, 126.0, 153.0, 135.0, 168.0, 125.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 163.0, 162.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 128.0, 86.0, 76.0, 74.0, 74.0, 100.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 83.0, 85.0, 86.0, 117.0, 84.0, 85.0, 125.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 79.0, 81.0, 82.0, 81.0, 82.0, 133.0, 81.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 135.0, 120.0, 141.0, 140.0, 127.0, 121.0, 124.0, 125.0, 121.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 159.0, 158.0, 165.0, 163.0, 162.0, 161.0, 164.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 63.0, 61.0, 65.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1504.9, "alertThreshold": 2.0}]} 02:30:15 INFO - Return code: 0 02:30:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:15 ERROR - # TBPL SUCCESS # 02:30:15 INFO - Running post-action listener: _resource_record_post_action 02:30:15 INFO - ##### 02:30:15 INFO - ##### Finished run-tests step (success) 02:30:15 INFO - ##### 02:30:15 INFO - Running post-run listener: _resource_record_post_run 02:30:15 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 305647616; Read time: 388; Write time: 388900 02:30:15 INFO - TinderboxPrint: CPU usage
13.3% 02:30:15 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 388 02:30:15 INFO - TinderboxPrint: I/O write bytes / time
305,647,616 / 388,900 02:30:15 INFO - TinderboxPrint: CPU idle
8,268.3 (86.7%) 02:30:15 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 02:30:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 17494016; Read time: 0; Write time: 6896 02:30:15 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288153600; Read time: 388; Write time: 382004 02:30:15 INFO - Running post-run listener: _upload_blobber_files 02:30:15 INFO - Blob upload gear active. 02:30:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:15 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 02:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:30:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:19 INFO - (blobuploader) - INFO - Done attempting. 02:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:21 INFO - (blobuploader) - INFO - Done attempting. 02:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:21 INFO - (blobuploader) - INFO - Done attempting. 02:30:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:21 INFO - Return code: 0 02:30:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50da907b015c4aa55fe4ed80dd76351d0a249641671338c26bff5f2c70909a362581c03deab562336531ef9d51c3384ca0785889540f22185b08d38e04203838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d177c3dec43aca659865ce0eb2a2f1608e65bc552e1d853d14e2bf410ed70cbbfa352d6f38a2e3acf54427eeeb1c69bf271077aa0a663ba781b09556073901e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a617e85606d7d39b588e50ad2ff19438b2fa46206eed24446c37026360d4b75e2da48cc437110cdf37e9cb795bf0993f57e346886e691fd75cea306df0dec07"} 02:30:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:21 INFO - Contents: 02:30:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50da907b015c4aa55fe4ed80dd76351d0a249641671338c26bff5f2c70909a362581c03deab562336531ef9d51c3384ca0785889540f22185b08d38e04203838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d177c3dec43aca659865ce0eb2a2f1608e65bc552e1d853d14e2bf410ed70cbbfa352d6f38a2e3acf54427eeeb1c69bf271077aa0a663ba781b09556073901e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a617e85606d7d39b588e50ad2ff19438b2fa46206eed24446c37026360d4b75e2da48cc437110cdf37e9cb795bf0993f57e346886e691fd75cea306df0dec07"} 02:30:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:21 INFO - Copying logs to upload dir... 02:30:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.503842 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-10 02:30:21.663118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 02:30:21.667029) ========= 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=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50da907b015c4aa55fe4ed80dd76351d0a249641671338c26bff5f2c70909a362581c03deab562336531ef9d51c3384ca0785889540f22185b08d38e04203838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d177c3dec43aca659865ce0eb2a2f1608e65bc552e1d853d14e2bf410ed70cbbfa352d6f38a2e3acf54427eeeb1c69bf271077aa0a663ba781b09556073901e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a617e85606d7d39b588e50ad2ff19438b2fa46206eed24446c37026360d4b75e2da48cc437110cdf37e9cb795bf0993f57e346886e691fd75cea306df0dec07"} build_url:https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/FPBihWaIQWCnEQtkCpO24A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50da907b015c4aa55fe4ed80dd76351d0a249641671338c26bff5f2c70909a362581c03deab562336531ef9d51c3384ca0785889540f22185b08d38e04203838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d177c3dec43aca659865ce0eb2a2f1608e65bc552e1d853d14e2bf410ed70cbbfa352d6f38a2e3acf54427eeeb1c69bf271077aa0a663ba781b09556073901e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a617e85606d7d39b588e50ad2ff19438b2fa46206eed24446c37026360d4b75e2da48cc437110cdf37e9cb795bf0993f57e346886e691fd75cea306df0dec07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 02:30:21.693128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:30:21.693472) ========= 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=fa44defc139c4ba8574fe040000001db-1465549624.336269-530549897 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 02:30:21.778444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 02:30:21.778773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 02:30:21.779070) ========= ========= Total master_lag: 0.16 =========