builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1465623279.0 results: success (0) buildid: 20160610200603 builduid: 11886aa819d74142ae66259d7d2a0c8a revision: 618a8336136754762b1002f9838fa574ffc60937 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.001008) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.001640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.001983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.028076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.028488) ========= 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-1465619629.800314-369750013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 22:34:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-06-10 22:34:40 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.176942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.177370) ========= 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-1465619629.800314-369750013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019611 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.227521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.227892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 618a8336136754762b1002f9838fa574ffc60937 --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 618a8336136754762b1002f9838fa574ffc60937 --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-1465619629.800314-369750013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 22:34:40,949 truncating revision to first 12 chars 2016-06-10 22:34:40,949 Setting DEBUG logging. 2016-06-10 22:34:40,949 attempt 1/10 2016-06-10 22:34:40,949 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/618a83361367?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 22:34:41,283 unpacking tar archive at: fx-team-618a83361367/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.921180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.921541) ========= script_repo_revision: 618a8336136754762b1002f9838fa574ffc60937 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.921992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.922304) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 22:34:39.931513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-10 22:34:39.931840) ========= /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-1465619629.800314-369750013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:34:41 INFO - MultiFileLogger online at 20160610 22:34:41 in /builds/slave/test 22:34:41 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 22:34:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:34:41 INFO - {'append_to_log': False, 22:34:41 INFO - 'base_work_dir': '/builds/slave/test', 22:34:41 INFO - 'blob_upload_branch': 'Fx-Team', 22:34:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:34:41 INFO - 'branch': 'Fx-Team', 22:34:41 INFO - 'buildbot_json_path': 'buildprops.json', 22:34:41 INFO - 'config_files': ('talos/linux_config.py',), 22:34:41 INFO - 'default_actions': ('clobber', 22:34:41 INFO - 'read-buildbot-config', 22:34:41 INFO - 'download-and-extract', 22:34:41 INFO - 'populate-webroot', 22:34:41 INFO - 'create-virtualenv', 22:34:41 INFO - 'install', 22:34:41 INFO - 'run-tests'), 22:34:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:34:41 INFO - 'download_minidump_stackwalk': True, 22:34:41 INFO - 'download_symbols': 'ondemand', 22:34:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:34:41 INFO - 'tooltool.py': '/tools/tooltool.py', 22:34:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:34:41 INFO - '/tools/misc-python/virtualenv.py')}, 22:34:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:34:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:34:41 INFO - 'installer_path': 'installer.exe', 22:34:41 INFO - 'log_level': 'info', 22:34:41 INFO - 'log_name': 'talos', 22:34:41 INFO - 'log_to_console': True, 22:34:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:34:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:34:41 INFO - 'opt_config_files': (), 22:34:41 INFO - 'pip_index': False, 22:34:41 INFO - 'sps_profile': False, 22:34:41 INFO - 'sps_profile_interval': 0, 22:34:41 INFO - 'suite': 'dromaeojs', 22:34:41 INFO - 'system_bits': '32', 22:34:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:34:41 INFO - 'title': 'talos-linux64-ix-048', 22:34:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:34:41 INFO - 'use_talos_json': True, 22:34:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:34:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:34:41 INFO - 'work_dir': 'build'} 22:34:41 INFO - ##### 22:34:41 INFO - ##### Running clobber step. 22:34:41 INFO - ##### 22:34:41 INFO - Running pre-action listener: _resource_record_pre_action 22:34:41 INFO - Running main action method: clobber 22:34:41 INFO - rmtree: /builds/slave/test/build 22:34:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:34:42 INFO - Running post-action listener: _resource_record_post_action 22:34:42 INFO - ##### 22:34:42 INFO - ##### Finished clobber step (success) 22:34:42 INFO - ##### 22:34:42 INFO - ##### 22:34:42 INFO - ##### Running read-buildbot-config step. 22:34:42 INFO - ##### 22:34:42 INFO - Running pre-action listener: _resource_record_pre_action 22:34:42 INFO - Running main action method: read_buildbot_config 22:34:42 INFO - Using buildbot properties: 22:34:42 INFO - { 22:34:42 INFO - "project": "", 22:34:42 INFO - "product": "firefox", 22:34:42 INFO - "script_repo_revision": "production", 22:34:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:34:42 INFO - "repository": "", 22:34:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:34:42 INFO - "buildid": "20160610200603", 22:34:42 INFO - "pgo_build": "True", 22:34:42 INFO - "basedir": "/builds/slave/test", 22:34:42 INFO - "buildnumber": 1249, 22:34:42 INFO - "slavename": "talos-linux64-ix-048", 22:34:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:34:42 INFO - "platform": "ubuntu64_hw", 22:34:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:34:42 INFO - "branch": "fx-team", 22:34:42 INFO - "repo_path": "integration/fx-team", 22:34:42 INFO - "revision": "618a8336136754762b1002f9838fa574ffc60937", 22:34:42 INFO - "stage_platform": "linux64-pgo", 22:34:42 INFO - "builduid": "11886aa819d74142ae66259d7d2a0c8a", 22:34:42 INFO - "slavebuilddir": "test" 22:34:42 INFO - } 22:34:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:34:42 INFO - Running post-action listener: _resource_record_post_action 22:34:42 INFO - ##### 22:34:42 INFO - ##### Finished read-buildbot-config step (success) 22:34:42 INFO - ##### 22:34:42 INFO - ##### 22:34:42 INFO - ##### Running download-and-extract step. 22:34:42 INFO - ##### 22:34:42 INFO - Running pre-action listener: _resource_record_pre_action 22:34:42 INFO - Running main action method: download_and_extract 22:34:42 INFO - mkdir: /builds/slave/test/build/tests 22:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:42 INFO - https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:34:48 INFO - Downloaded 1361 bytes. 22:34:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:34:48 INFO - Using the following test package requirements: 22:34:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:34:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:34:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:34:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'jsshell-linux-x86_64.zip'], 22:34:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:34:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:34:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:34:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:34:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:34:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:34:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:34:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:48 INFO - https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:34:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:34:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:34:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:34:57 INFO - Downloaded 24463940 bytes. 22:34:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:34:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:34:58 INFO - Return code: 0 22:34:58 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 22:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:58 INFO - https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:34:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:34:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:34:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:01 INFO - Downloaded 24463940 bytes. 22:35:01 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'] 22:35:01 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 22:35:03 INFO - Return code: 0 22:35: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')]} 22:35:03 INFO - https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:35:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:35:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:04 INFO - Downloaded 10833377 bytes. 22:35:04 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'] 22:35:04 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 22:35:04 INFO - Return code: 0 22:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:04 INFO - https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:06 INFO - Downloaded 59324925 bytes. 22:35:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:35:06 INFO - mkdir: /builds/slave/test/properties 22:35:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:35:06 INFO - Writing to file /builds/slave/test/properties/build_url 22:35:06 INFO - Contents: 22:35:06 INFO - build_url:https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:35:07 INFO - Running post-action listener: _resource_record_post_action 22:35:07 INFO - Running post-action listener: set_extra_try_arguments 22:35:07 INFO - ##### 22:35:07 INFO - ##### Finished download-and-extract step (success) 22:35:07 INFO - ##### 22:35:07 INFO - ##### 22:35:07 INFO - ##### Running populate-webroot step. 22:35:07 INFO - ##### 22:35:07 INFO - Running pre-action listener: _resource_record_pre_action 22:35:07 INFO - Running main action method: populate_webroot 22:35:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:35:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:35:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:35:07 INFO - '--tppagecycles', 22:35:07 INFO - '7'], 22:35:07 INFO - 'tests': ['tsvgm']}}, 22:35:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:35:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:35:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:35:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:35:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['damp', 'tps']}, 22:35:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'tests': ['damp', 'tps']}, 22:35:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['dromaeo_dom']}, 22:35:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:35:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'other-e10s': {'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['a11yr', 22:35:07 INFO - 'ts_paint', 22:35:07 INFO - 'tpaint', 22:35:07 INFO - 'sessionrestore', 22:35:07 INFO - 'sessionrestore_no_auto_restore', 22:35:07 INFO - 'tabpaint']}, 22:35:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['tsvgx', 22:35:07 INFO - 'tsvgr_opacity', 22:35:07 INFO - 'tart', 22:35:07 INFO - 'tscrollx', 22:35:07 INFO - 'cart']}, 22:35:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:35:07 INFO - 'tsvgr_opacity', 22:35:07 INFO - 'tart', 22:35:07 INFO - 'tscrollx', 22:35:07 INFO - 'cart']}, 22:35:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'talos_options': ['--disable-e10s'], 22:35:07 INFO - 'tests': ['tp5o']}, 22:35:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'tests': ['tp5o']}, 22:35:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'talos_options': ['--disable-e10s', 22:35:07 INFO - '--xperf_path', 22:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:07 INFO - 'tests': ['tp5n']}, 22:35:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:07 INFO - 'talos_options': ['--xperf_path', 22:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:07 INFO - 'tests': ['tp5n']}}, 22:35:07 INFO - 'talos.zip': {'path': '', 22:35:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:35:07 INFO - Running post-action listener: _resource_record_post_action 22:35:07 INFO - ##### 22:35:07 INFO - ##### Finished populate-webroot step (success) 22:35:07 INFO - ##### 22:35:07 INFO - ##### 22:35:07 INFO - ##### Running create-virtualenv step. 22:35:07 INFO - ##### 22:35:07 INFO - Running pre-action listener: _resource_record_pre_action 22:35:07 INFO - Running main action method: create_virtualenv 22:35:07 INFO - Creating virtualenv /builds/slave/test/build/venv 22:35:07 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 22:35:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:35:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:35:07 INFO - Using real prefix '/usr' 22:35:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:35:08 INFO - Installing distribute.............................................................................................................................................................................................done. 22:35:10 INFO - Installing pip.................done. 22:35:10 INFO - Return code: 0 22:35:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:35:10 INFO - Using env: {'DISPLAY': ':0', 22:35:10 INFO - 'HOME': '/home/cltbld', 22:35:10 INFO - 'LANG': 'en_US.UTF-8', 22:35:10 INFO - 'LANGUAGE': 'en_US:en', 22:35:10 INFO - 'LOGNAME': 'cltbld', 22:35:10 INFO - 'MAIL': '/var/mail/cltbld', 22:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:10 INFO - 'MOZ_NO_REMOTE': '1', 22:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:10 INFO - 'NO_EM_RESTART': '1', 22:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:10 INFO - 'PWD': '/builds/slave/test', 22:35:10 INFO - 'SHELL': '/bin/bash', 22:35:10 INFO - 'SHLVL': '1', 22:35:10 INFO - 'TERM': 'linux', 22:35:10 INFO - 'TMOUT': '86400', 22:35:10 INFO - 'USER': 'cltbld', 22:35:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:10 INFO - '_': '/tools/buildbot/bin/python'} 22:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:10 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 22:35:10 INFO - Cleaning up... 22:35:10 INFO - Return code: 0 22:35:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:35:10 INFO - Using env: {'DISPLAY': ':0', 22:35:10 INFO - 'HOME': '/home/cltbld', 22:35:10 INFO - 'LANG': 'en_US.UTF-8', 22:35:10 INFO - 'LANGUAGE': 'en_US:en', 22:35:10 INFO - 'LOGNAME': 'cltbld', 22:35:10 INFO - 'MAIL': '/var/mail/cltbld', 22:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:10 INFO - 'MOZ_NO_REMOTE': '1', 22:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:10 INFO - 'NO_EM_RESTART': '1', 22:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:10 INFO - 'PWD': '/builds/slave/test', 22:35:10 INFO - 'SHELL': '/bin/bash', 22:35:10 INFO - 'SHLVL': '1', 22:35:10 INFO - 'TERM': 'linux', 22:35:10 INFO - 'TMOUT': '86400', 22:35:10 INFO - 'USER': 'cltbld', 22:35:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:10 INFO - '_': '/tools/buildbot/bin/python'} 22:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:10 INFO - Downloading/unpacking psutil>=3.1.1 22:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:35:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:35:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:35:12 INFO - Installing collected packages: psutil 22:35:12 INFO - Running setup.py install for psutil 22:35:12 INFO - building 'psutil._psutil_linux' extension 22:35:12 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 22:35:12 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 22:35:12 INFO - building 'psutil._psutil_posix' extension 22:35:12 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 22:35:13 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 22:35:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:35:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:35:13 INFO - Successfully installed psutil 22:35:13 INFO - Cleaning up... 22:35:13 INFO - Return code: 0 22:35:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:13 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:13 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 22:35:13 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 22:35:13 INFO - Using env: {'DISPLAY': ':0', 22:35:13 INFO - 'HOME': '/home/cltbld', 22:35:13 INFO - 'LANG': 'en_US.UTF-8', 22:35:13 INFO - 'LANGUAGE': 'en_US:en', 22:35:13 INFO - 'LOGNAME': 'cltbld', 22:35:13 INFO - 'MAIL': '/var/mail/cltbld', 22:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:13 INFO - 'MOZ_NO_REMOTE': '1', 22:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:13 INFO - 'NO_EM_RESTART': '1', 22:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:13 INFO - 'PWD': '/builds/slave/test', 22:35:13 INFO - 'SHELL': '/bin/bash', 22:35:13 INFO - 'SHLVL': '1', 22:35:13 INFO - 'TERM': 'linux', 22:35:13 INFO - 'TMOUT': '86400', 22:35:13 INFO - 'USER': 'cltbld', 22:35:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:13 INFO - '_': '/tools/buildbot/bin/python'} 22:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:35:15 INFO - Installing collected packages: mozsystemmonitor 22:35:15 INFO - Running setup.py install for mozsystemmonitor 22:35:15 INFO - Successfully installed mozsystemmonitor 22:35:15 INFO - Cleaning up... 22:35:15 INFO - Return code: 0 22:35:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:35:15 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')]} 22:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:15 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')]} 22:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:15 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:15 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 22:35:15 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 22:35:15 INFO - Using env: {'DISPLAY': ':0', 22:35:15 INFO - 'HOME': '/home/cltbld', 22:35:15 INFO - 'LANG': 'en_US.UTF-8', 22:35:15 INFO - 'LANGUAGE': 'en_US:en', 22:35:15 INFO - 'LOGNAME': 'cltbld', 22:35:15 INFO - 'MAIL': '/var/mail/cltbld', 22:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:15 INFO - 'MOZ_NO_REMOTE': '1', 22:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:15 INFO - 'NO_EM_RESTART': '1', 22:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:15 INFO - 'PWD': '/builds/slave/test', 22:35:15 INFO - 'SHELL': '/bin/bash', 22:35:15 INFO - 'SHLVL': '1', 22:35:15 INFO - 'TERM': 'linux', 22:35:15 INFO - 'TMOUT': '86400', 22:35:15 INFO - 'USER': 'cltbld', 22:35:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:15 INFO - '_': '/tools/buildbot/bin/python'} 22:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:15 INFO - Downloading/unpacking jsonschema==2.5.1 22:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:35:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:35: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 22:35: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 22:35: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 22:35: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 22:35: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 22:35: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 22:35:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:35:18 INFO - warning: no files found matching '*.txt' 22:35:18 INFO - no previously-included directories found matching 'build' 22:35:18 INFO - no previously-included directories found matching 'dist' 22:35:18 INFO - no previously-included directories found matching '.git*' 22:35:18 INFO - Installing collected packages: jsonschema, functools32 22:35:18 INFO - Running setup.py install for functools32 22:35:18 INFO - warning: no files found matching '*.txt' 22:35:18 INFO - no previously-included directories found matching 'build' 22:35:18 INFO - no previously-included directories found matching 'dist' 22:35:18 INFO - no previously-included directories found matching '.git*' 22:35:18 INFO - Successfully installed jsonschema functools32 22:35:18 INFO - Cleaning up... 22:35:18 INFO - Return code: 0 22:35:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:35:18 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')]} 22:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:18 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')]} 22:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:18 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:18 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 22:35:18 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 22:35:18 INFO - Using env: {'DISPLAY': ':0', 22:35:18 INFO - 'HOME': '/home/cltbld', 22:35:18 INFO - 'LANG': 'en_US.UTF-8', 22:35:18 INFO - 'LANGUAGE': 'en_US:en', 22:35:18 INFO - 'LOGNAME': 'cltbld', 22:35:18 INFO - 'MAIL': '/var/mail/cltbld', 22:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:18 INFO - 'MOZ_NO_REMOTE': '1', 22:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:18 INFO - 'NO_EM_RESTART': '1', 22:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:18 INFO - 'PWD': '/builds/slave/test', 22:35:18 INFO - 'SHELL': '/bin/bash', 22:35:18 INFO - 'SHLVL': '1', 22:35:18 INFO - 'TERM': 'linux', 22:35:18 INFO - 'TMOUT': '86400', 22:35:18 INFO - 'USER': 'cltbld', 22:35:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:18 INFO - '_': '/tools/buildbot/bin/python'} 22:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:35: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 22:35: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 22:35: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 22:35: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 22:35: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 22:35: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 22:35:20 INFO - Downloading blobuploader-1.2.4.tar.gz 22:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:35:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:35:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:21 INFO - Downloading docopt-0.6.1.tar.gz 22:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:35:21 INFO - Installing collected packages: blobuploader, requests, docopt 22:35:21 INFO - Running setup.py install for blobuploader 22:35:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:35:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:35:21 INFO - Running setup.py install for requests 22:35:21 INFO - Running setup.py install for docopt 22:35:21 INFO - Successfully installed blobuploader requests docopt 22:35:21 INFO - Cleaning up... 22:35:21 INFO - Return code: 0 22:35:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:21 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:21 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 22:35:21 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 22:35:21 INFO - Using env: {'DISPLAY': ':0', 22:35:21 INFO - 'HOME': '/home/cltbld', 22:35:21 INFO - 'LANG': 'en_US.UTF-8', 22:35:21 INFO - 'LANGUAGE': 'en_US:en', 22:35:21 INFO - 'LOGNAME': 'cltbld', 22:35:21 INFO - 'MAIL': '/var/mail/cltbld', 22:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:21 INFO - 'MOZ_NO_REMOTE': '1', 22:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:21 INFO - 'NO_EM_RESTART': '1', 22:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:21 INFO - 'PWD': '/builds/slave/test', 22:35:21 INFO - 'SHELL': '/bin/bash', 22:35:21 INFO - 'SHLVL': '1', 22:35:21 INFO - 'TERM': 'linux', 22:35:21 INFO - 'TMOUT': '86400', 22:35:21 INFO - 'USER': 'cltbld', 22:35:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:21 INFO - '_': '/tools/buildbot/bin/python'} 22:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:35:21 INFO - Running setup.py (path:/tmp/pip-gsmJrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:35:22 INFO - Running setup.py (path:/tmp/pip-xky_cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:35:22 INFO - Running setup.py (path:/tmp/pip-1fYkY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:35:22 INFO - Running setup.py (path:/tmp/pip-_7ThO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:35:22 INFO - Running setup.py (path:/tmp/pip-zD2PiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:35:22 INFO - Running setup.py (path:/tmp/pip-7gW4Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:35:22 INFO - Running setup.py (path:/tmp/pip-zt6m_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:35:22 INFO - Running setup.py (path:/tmp/pip-FXl0Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:35:22 INFO - Running setup.py (path:/tmp/pip-IlrP2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:35:22 INFO - Running setup.py (path:/tmp/pip-l5C8IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:35:22 INFO - Running setup.py (path:/tmp/pip-4_8Yp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:35:22 INFO - Running setup.py (path:/tmp/pip-Emi4YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:35:22 INFO - Running setup.py (path:/tmp/pip-BMcyb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:35:22 INFO - Running setup.py (path:/tmp/pip-BGzyws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:22 INFO - Running setup.py (path:/tmp/pip-JWZIVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:35:23 INFO - Running setup.py (path:/tmp/pip-YYaRvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:35:23 INFO - Running setup.py (path:/tmp/pip-aG9QVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:35:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:35:23 INFO - Running setup.py install for manifestparser 22:35:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Running setup.py install for mozcrash 22:35:23 INFO - Running setup.py install for mozdebug 22:35:23 INFO - Running setup.py install for mozdevice 22:35:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Running setup.py install for mozfile 22:35:23 INFO - Running setup.py install for mozhttpd 22:35:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Running setup.py install for mozinfo 22:35:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Running setup.py install for mozInstall 22:35:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:35:23 INFO - Running setup.py install for mozleak 22:35:24 INFO - Running setup.py install for mozlog 22:35:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Running setup.py install for moznetwork 22:35:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Running setup.py install for mozprocess 22:35:24 INFO - Running setup.py install for mozprofile 22:35:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Running setup.py install for mozrunner 22:35:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Running setup.py install for mozscreenshot 22:35:24 INFO - Running setup.py install for moztest 22:35:24 INFO - Running setup.py install for mozversion 22:35:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:35:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:35:24 INFO - Cleaning up... 22:35:24 INFO - Return code: 0 22:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:24 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:24 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 22:35:24 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 22:35:24 INFO - Using env: {'DISPLAY': ':0', 22:35:24 INFO - 'HOME': '/home/cltbld', 22:35:24 INFO - 'LANG': 'en_US.UTF-8', 22:35:24 INFO - 'LANGUAGE': 'en_US:en', 22:35:24 INFO - 'LOGNAME': 'cltbld', 22:35:24 INFO - 'MAIL': '/var/mail/cltbld', 22:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:24 INFO - 'MOZ_NO_REMOTE': '1', 22:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:24 INFO - 'NO_EM_RESTART': '1', 22:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:24 INFO - 'PWD': '/builds/slave/test', 22:35:24 INFO - 'SHELL': '/bin/bash', 22:35:24 INFO - 'SHLVL': '1', 22:35:24 INFO - 'TERM': 'linux', 22:35:24 INFO - 'TMOUT': '86400', 22:35:24 INFO - 'USER': 'cltbld', 22:35:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:24 INFO - '_': '/tools/buildbot/bin/python'} 22:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:35:25 INFO - Running setup.py (path:/tmp/pip-BpNnbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:35:25 INFO - Running setup.py (path:/tmp/pip-3Xm97a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:35:25 INFO - Running setup.py (path:/tmp/pip-v6LpXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:35:25 INFO - Running setup.py (path:/tmp/pip-n7zZ1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:35:25 INFO - Running setup.py (path:/tmp/pip-aPI_TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:35:25 INFO - Running setup.py (path:/tmp/pip-U26ks6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:35:25 INFO - Running setup.py (path:/tmp/pip-JvVZu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:35:25 INFO - Running setup.py (path:/tmp/pip-Z7Qt9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:35:25 INFO - Running setup.py (path:/tmp/pip-JNzrh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:35:25 INFO - Running setup.py (path:/tmp/pip-auE3KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:35:25 INFO - Running setup.py (path:/tmp/pip-RQWwfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:35:25 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)) 22:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:35:25 INFO - Running setup.py (path:/tmp/pip-y6diDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:35:26 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)) 22:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:35:26 INFO - Running setup.py (path:/tmp/pip-hVcF9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:35:26 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)) 22:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:35:26 INFO - Running setup.py (path:/tmp/pip-Ar8wrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:35:26 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)) 22:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:26 INFO - Running setup.py (path:/tmp/pip-boTpgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:26 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)) 22:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:35:26 INFO - Running setup.py (path:/tmp/pip-PyezV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:35:26 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)) 22:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:35:26 INFO - Running setup.py (path:/tmp/pip-RcHItJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:35:26 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)) 22:35:26 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)) 22:35:26 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)) 22:35:26 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)) 22:35:26 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)) 22:35:26 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)) 22:35:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:28 INFO - Downloading blessings-1.6.tar.gz 22:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:35:28 INFO - Installing collected packages: blessings 22:35:28 INFO - Running setup.py install for blessings 22:35:28 INFO - Successfully installed blessings 22:35:28 INFO - Cleaning up... 22:35:28 INFO - Return code: 0 22:35:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:35:28 INFO - Reading from file tmpfile_stdout 22:35:28 INFO - Current package versions: 22:35:28 INFO - argparse == 1.2.1 22:35:28 INFO - blessings == 1.6 22:35:28 INFO - blobuploader == 1.2.4 22:35:28 INFO - docopt == 0.6.1 22:35:28 INFO - functools32 == 3.2.3-2 22:35:28 INFO - jsonschema == 2.5.1 22:35:28 INFO - manifestparser == 1.1 22:35:28 INFO - mozInstall == 1.12 22:35:28 INFO - mozcrash == 0.17 22:35:28 INFO - mozdebug == 0.1 22:35:28 INFO - mozdevice == 0.48 22:35:28 INFO - mozfile == 1.2 22:35:28 INFO - mozhttpd == 0.7 22:35:28 INFO - mozinfo == 0.9 22:35:28 INFO - mozleak == 0.1 22:35:28 INFO - mozlog == 3.2 22:35:28 INFO - moznetwork == 0.27 22:35:28 INFO - mozprocess == 0.22 22:35:28 INFO - mozprofile == 0.28 22:35:28 INFO - mozrunner == 6.11 22:35:28 INFO - mozscreenshot == 0.1 22:35:28 INFO - mozsystemmonitor == 0.3 22:35:28 INFO - moztest == 0.7 22:35:28 INFO - mozversion == 1.4 22:35:28 INFO - psutil == 3.1.1 22:35:28 INFO - requests == 1.2.3 22:35:28 INFO - wsgiref == 0.1.2 22:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35:28 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')]} 22:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:28 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')]} 22:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:28 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:28 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 22:35:28 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 22:35:28 INFO - Using env: {'DISPLAY': ':0', 22:35:28 INFO - 'HOME': '/home/cltbld', 22:35:28 INFO - 'LANG': 'en_US.UTF-8', 22:35:28 INFO - 'LANGUAGE': 'en_US:en', 22:35:28 INFO - 'LOGNAME': 'cltbld', 22:35:28 INFO - 'MAIL': '/var/mail/cltbld', 22:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:28 INFO - 'MOZ_NO_REMOTE': '1', 22:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:28 INFO - 'NO_EM_RESTART': '1', 22:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:28 INFO - 'PWD': '/builds/slave/test', 22:35:28 INFO - 'SHELL': '/bin/bash', 22:35:28 INFO - 'SHLVL': '1', 22:35:28 INFO - 'TERM': 'linux', 22:35:28 INFO - 'TMOUT': '86400', 22:35:28 INFO - 'USER': 'cltbld', 22:35:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:28 INFO - '_': '/tools/buildbot/bin/python'} 22:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 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)) 22:35:28 INFO - Cleaning up... 22:35:28 INFO - Return code: 0 22:35:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:35:28 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')]} 22:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:28 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')]} 22:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:28 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:28 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 22:35:28 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 22:35:28 INFO - Using env: {'DISPLAY': ':0', 22:35:28 INFO - 'HOME': '/home/cltbld', 22:35:28 INFO - 'LANG': 'en_US.UTF-8', 22:35:28 INFO - 'LANGUAGE': 'en_US:en', 22:35:28 INFO - 'LOGNAME': 'cltbld', 22:35:28 INFO - 'MAIL': '/var/mail/cltbld', 22:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:28 INFO - 'MOZ_NO_REMOTE': '1', 22:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:28 INFO - 'NO_EM_RESTART': '1', 22:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:28 INFO - 'PWD': '/builds/slave/test', 22:35:28 INFO - 'SHELL': '/bin/bash', 22:35:28 INFO - 'SHLVL': '1', 22:35:28 INFO - 'TERM': 'linux', 22:35:28 INFO - 'TMOUT': '86400', 22:35:28 INFO - 'USER': 'cltbld', 22:35:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:28 INFO - '_': '/tools/buildbot/bin/python'} 22:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:35:29 INFO - Cleaning up... 22:35:29 INFO - Return code: 0 22:35:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:35:29 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')]} 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:29 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')]} 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:29 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 0x7f92ebbe8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, '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-1465619629.800314-369750013', '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 22:35:29 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 22:35:29 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 22:35:29 INFO - Using env: {'DISPLAY': ':0', 22:35:29 INFO - 'HOME': '/home/cltbld', 22:35:29 INFO - 'LANG': 'en_US.UTF-8', 22:35:29 INFO - 'LANGUAGE': 'en_US:en', 22:35:29 INFO - 'LOGNAME': 'cltbld', 22:35:29 INFO - 'MAIL': '/var/mail/cltbld', 22:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:29 INFO - 'MOZ_NO_REMOTE': '1', 22:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:29 INFO - 'NO_EM_RESTART': '1', 22:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:29 INFO - 'PWD': '/builds/slave/test', 22:35:29 INFO - 'SHELL': '/bin/bash', 22:35:29 INFO - 'SHLVL': '1', 22:35:29 INFO - 'TERM': 'linux', 22:35:29 INFO - 'TMOUT': '86400', 22:35:29 INFO - 'USER': 'cltbld', 22:35:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:29 INFO - '_': '/tools/buildbot/bin/python'} 22:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:29 INFO - Downloading/unpacking flake8 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:35:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:35:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 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 22:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:35:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:35:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:35:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:35:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:35:31 INFO - no previously-included directories found matching 'docs/_build' 22:35:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:35:32 INFO - Running setup.py install for pep8 22:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:35:32 INFO - no previously-included directories found matching 'docs/_build' 22:35:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:35:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:35:32 INFO - Cleaning up... 22:35:32 INFO - Return code: 0 22:35:32 INFO - Running post-action listener: _resource_record_post_action 22:35:32 INFO - Running post-action listener: _start_resource_monitoring 22:35:32 INFO - Starting resource monitoring. 22:35:32 INFO - ##### 22:35:32 INFO - ##### Finished create-virtualenv step (success) 22:35:32 INFO - ##### 22:35:32 INFO - ##### 22:35:32 INFO - ##### Running install step. 22:35:32 INFO - ##### 22:35:32 INFO - Running pre-action listener: _resource_record_pre_action 22:35:32 INFO - Running main action method: install 22:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:35:32 INFO - Reading from file tmpfile_stdout 22:35:32 INFO - Detecting whether we're running mozinstall >=1.0... 22:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:35:32 INFO - Reading from file tmpfile_stdout 22:35:32 INFO - Output received: 22:35:32 INFO - Usage: mozinstall [options] installer 22:35:32 INFO - Options: 22:35:32 INFO - -h, --help show this help message and exit 22:35:32 INFO - -d DEST, --destination=DEST 22:35:32 INFO - Directory to install application into. [default: 22:35:32 INFO - "/builds/slave/test"] 22:35:32 INFO - --app=APP Application being installed. [default: firefox] 22:35:32 INFO - mkdir: /builds/slave/test/build/application 22:35:32 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'] 22:35:32 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 22:35:49 INFO - Reading from file tmpfile_stdout 22:35:49 INFO - Output received: 22:35:49 INFO - /builds/slave/test/build/application/firefox/firefox 22:35:49 INFO - Running post-action listener: _resource_record_post_action 22:35:49 INFO - ##### 22:35:49 INFO - ##### Finished install step (success) 22:35:49 INFO - ##### 22:35:49 INFO - ##### 22:35:49 INFO - ##### Running run-tests step. 22:35:49 INFO - ##### 22:35:49 INFO - Running pre-action listener: _resource_record_pre_action 22:35:49 INFO - Running main action method: run_tests 22:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:35:49 INFO - Python 2.7.3 22:35:49 INFO - Return code: 0 22:35:49 INFO - grabbing minidump binary from tooltool 22:35:49 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')]} 22:35:49 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 0x17ae1c0>, '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 0x17af0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17af550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:35:49 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 22:35:49 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 22:35:49 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 22:35:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:35:49 INFO - Return code: 0 22:35:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:35:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:35:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:35:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:35:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:35:50 INFO - Return code: 0 22:35:50 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/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:50 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/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:50 INFO - Using env: {'DISPLAY': ':0', 22:35:50 INFO - 'HOME': '/home/cltbld', 22:35:50 INFO - 'LANG': 'en_US.UTF-8', 22:35:50 INFO - 'LANGUAGE': 'en_US:en', 22:35:50 INFO - 'LOGNAME': 'cltbld', 22:35:50 INFO - 'MAIL': '/var/mail/cltbld', 22:35:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:35:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:50 INFO - 'MOZ_NO_REMOTE': '1', 22:35:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:35:50 INFO - 'NO_EM_RESTART': '1', 22:35:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:50 INFO - 'PWD': '/builds/slave/test', 22:35:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:35:50 INFO - 'SHELL': '/bin/bash', 22:35:50 INFO - 'SHLVL': '1', 22:35:50 INFO - 'TERM': 'linux', 22:35:50 INFO - 'TMOUT': '86400', 22:35:50 INFO - 'USER': 'cltbld', 22:35:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465619629.800314-369750013', 22:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:50 INFO - '_': '/tools/buildbot/bin/python'} 22:35:50 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/LI0V7BWaTHemh6Il3k8V_Q/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 22:35:50 INFO - mozversion application_buildid: 20160610200603 22:35:50 INFO - mozversion application_changeset: 618a8336136754762b1002f9838fa574ffc60937 22:35:50 INFO - mozversion application_display_name: Nightly 22:35:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:35:50 INFO - mozversion application_name: Firefox 22:35:50 INFO - mozversion application_remotingname: firefox 22:35:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:35:50 INFO - mozversion application_vendor: Mozilla 22:35:50 INFO - mozversion application_version: 50.0a1 22:35:50 INFO - mozversion platform_buildid: 20160610200603 22:35:50 INFO - mozversion platform_changeset: 618a8336136754762b1002f9838fa574ffc60937 22:35:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:35:50 INFO - mozversion platform_version: 50.0a1 22:35:50 INFO - using testdate: 1465623350 22:35:50 INFO - actual date: 1465623350 22:35:50 INFO - starting webserver on 'localhost:50966' 22:35:50 INFO - SUITE-START | Running 2 tests 22:35:50 INFO - TEST-START | dromaeo_css 22:35:50 INFO - operating with platform_type : linux_ 22:35:50 INFO - Initialising browser for dromaeo_css test... 22:35:50 INFO - TEST-INFO | started process 15125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD19pKw/profile http://localhost:50966/getInfo.html) 22:35:54 INFO - PROCESS | 15125 | __metrics Screen width/height:1600/1200 22:35:54 INFO - PROCESS | 15125 | colorDepth:24 22:35:54 INFO - PROCESS | 15125 | Browser inner width/height: 1024/697 22:35:54 INFO - PROCESS | 15125 | __metrics 22:35:55 INFO - PROCESS | 15125 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:35:56 INFO - PROCESS | 15125 | console.error: PushService: 22:35:56 INFO - PROCESS | 15125 | stateChangeProcessEnqueue: Error transitioning state 22:35:56 INFO - PROCESS | 15125 | UnknownError 22:35:56 INFO - TEST-INFO | 15125: exit 0 22:35:56 INFO - Browser initialized. 22:35:56 INFO - Running cycle 1/1 for dromaeo_css test... 22:35:56 INFO - TEST-INFO | started process 15207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD19pKw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:36:08 INFO - PROCESS | 15207 | RSS: Main: 173637632 22:36:08 INFO - PROCESS | 15207 | 22:36:59 INFO - PROCESS | 15207 | 1465623419641 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] 22:39:08 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50966/tests/dromaeo/cssquery-ext.html) 22:39:09 INFO - PROCESS | 15207 | RSS: Main: 303362048 22:39:09 INFO - PROCESS | 15207 | 22:42:12 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-ext.html (next: http://localhost:50966/tests/dromaeo/cssquery-jquery.html) 22:42:12 INFO - PROCESS | 15207 | RSS: Main: 262410240 22:42:12 INFO - PROCESS | 15207 | 22:45:14 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50966/tests/dromaeo/cssquery-mootools.html) 22:45:15 INFO - PROCESS | 15207 | RSS: Main: 260841472 22:45:15 INFO - PROCESS | 15207 | 22:48:17 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50966/tests/dromaeo/cssquery-prototype.html) 22:48:18 INFO - PROCESS | 15207 | RSS: Main: 255410176 22:48:18 INFO - PROCESS | 15207 | 22:51:20 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50966/tests/dromaeo/cssquery-yui.html) 22:51:21 INFO - PROCESS | 15207 | RSS: Main: 238583808 22:51:21 INFO - PROCESS | 15207 | 22:54:23 INFO - PROCESS | 15207 | Cycle 1(1): loaded http://localhost:50966/tests/dromaeo/cssquery-yui.html (next: http://localhost:50966/tests/dromaeo/cssquery-dojo.html) 22:54:24 INFO - PROCESS | 15207 | RSS: Main: 293638144 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | __start_tp_report 22:54:24 INFO - PROCESS | 15207 | _x_x_mozilla_page_load 22:54:24 INFO - PROCESS | 15207 | _x_x_mozilla_page_load_details 22:54:24 INFO - PROCESS | 15207 | |i|pagename|runs| 22:54:24 INFO - PROCESS | 15207 | |0;dojo.html;3062.433449811785;3078.0458058002023;3101.968980310197;3123.547085672576;3131.8120912745235;5083.212102124167;5211.166213405856;5257.789688412464;5320.840374788753;5358.0623390906585;5253.395859476162;5288.418273989858;5334.626576139672;5337.386200586933;5424.647397919132;4842.1042107210105;4856.247281671346;4868.0750657375165;4883.340748998884;4959.826406075788;4786.066716990188;4958.30829513457;4991.126552853254;5002.2996780450585;5008.24876268559;4731.952680473186;4909.435414927293;4911.189653707134;4943.431505376891;4945.208766597345;4734.19518681825;4782.713037217778;4817.494163112893;4838.080764654705;4843.39457567804;4798.160321943646;4821.686590371614;4884.535969082967;4891.608671306322;4925.482824303468;5143.305653736735;5317.335333083364;5390.137577987503;5407.080796264644;5417.241586177938;5557.055300598908;5567.8608034799045;5581.079121944874;5643.463870932255;5694.658320500742;5655.66066036035;5670.262865827416;5678.176664383641;5715.913976344481;5723.484886360247;5222.294990176316;5278.261043453919;5279.392869819982;5322.121849894801;5323.361196656426;5798.855028624318;5842.977478941169;5850.2102216200265;5900.321463031721;5903.380145084704;5607.719614019283;5621.213030175697;5626.268585083994;5671.432856714296;5675.148727690879;5532.197831314437;5548;5552.750126244328;5751.798687045934;5755.884882302331;5524.281843360337;5538.556915446755;5543.057680194376;5544.750486228048;5585.134304182858;5546.91679624806;5556.805511807067;5559.944400555943;5561.499465048165;5588.133839254922;4252.532221455637;4288;4291.742495450283;4334.848280310174;4345.283028300359;3862.478565393692;3873.0123818426123;3887.611238876146;3919.5492518360184;3923.195744872294;5395.946040539623;5403.83788486346;5404.459554044564;5404.594655400782;5405.108157154104;5575.581831362583;5584.329880414376;5589.580781441408;5594.580406469531;5644.6330988485615;5343.67937923718;5350.27771250884;5351.384590772033;5351.438098999627;5360.115580929181;4727.220008698595;4754.477007529169;4760.09558183944;4762.857114286577;4764.571188593043;5802.912956305574;5852.531797456193;5859.472647461749;5871.765129394862;5882.882342353215;5657.3776884543495;5663.490285874291;5667.489925906688;5668.773249069991;5673.744681489426;5821.155932389865;5889.646621202742;5900.675462849413;5901.911471327848;5907.852303692442;5545.279113715191;5635.88728225425;5637.718114094361;5643.097104463431;5656.688882111359;5719.942800571941;5739.225204597493;5740.942590574041;5746;5747.310322761128;5487.588430867621;5513.807016754395;5535.584831137761;5617.382087970238;5634.690092044977;5544.112941929272;5547.389787123332;5549.694766787866;5555.388907220284;5584.274044374205;5410.83767486976;5412.566994640498;5423.29497165366;5456.017916775018;5464.18037294409;5328.227407025882;5443.972780136074;5480.3971563127225;5523.199136125159;5577.581681373995;5416.079266524779;5424.1321388577635;5429.728513574384;5430.51125398716;5438.537724293479 22:54:24 INFO - PROCESS | 15207 | |1;ext.html;582.7727186397306;636.3572791480603;640.9711562979667;646.5441863486243;659.3999460490953;30375.848120759394;42877.35683964739;43619.56380436195;43627.78186109073;43649.7817510912;43449;43960;44074.559254407446;44113;44157.337639935344;8061.556614386206;8785.472871627691;8963.596638151266;10477.79044419115;10771.62299319524;10611;10717.517711702953;10723.892761072406;10726.570937162503;10733.83899241512;10806.621768238114;10834.079103276232;10848.349099054081;10856.511456984455;10858.402787846666;8139.674413023472;10641.946790266038;10909.945450272699;10911.618093366773;10913.945430272797;10439.634612788592;10455.52950117239;10504.159667226604;10807.67576972692;10817.675469735921;42143;42706.14587708259;42749.35875961863;42761;42819.785901070296;3509.5788505379264;3594.101474631342;4122.361034039729;4141.337386018223;4243.766592837393;31903.202419939455;32433.67566324354;32661.673383266338;32700.509492357633;32714;4395.978020109911;4456.55434456555;4529.411176547028;4635.443746750378;4635.930461043087;345554;345585;346581;350113;350149.99999999744;61922.69038654778;61928.38071619316;62115;62325.37674623286;62355;66679.33320666732;67048.32951670518;67073;67094;67159;14546.636334091521;15965.361385544447;16071.839281607268;16097.517074487783;16097.919510402373;11159.665210043711;11571.363575003455;11572.47923843429;11846.407679615984;12176.634700958986;16850.245368956585;19349.51626209356;19405.2237910482;19561.510962226057;19594.70607940882;7229.674664640103;7239.746608868664;7273.254274048869;7357.41140708742;7518.47392166757;976.9902300977042;1018.7860549284733;1021.279997601689;1073.2111897755144;1076.531708706715;32464.675353246166;32603.83698081542;32783.180420489676;32969.67030329666;33531.16172095668;1070.2133931560297;1123.5505797680994;1153.2446247707765;1174.4714878304796;1205.7166565857017;17101.743473847902;17345.826541734674;17432.738508922375;17448.389306374214;17541.824581754274;480227;485961;487622;488143;489085;57291.42708572861;58699.70650146722;58900;59177.40822591719;59207.40792592019;1221.7800795856654;1243.7574672938872;1259.1626568331956;1326.2440408966797;1341.2690083904295;28072.719272807826;33680;33921.66078339185;33985.32029359449;34071.65928340685;50732.492675072775;51457.22814157716;51469.48530514647;51480.22779658383;51590.74204628953;384532;389300;389593;392472;392547;37103.44344834884;41504.377434337905;42930.35604465873;43120.56879431166;43213.97502174944;47820.28269576029;48053.75973120112;48457;48731.26903096386;49262.26106608476;40838.79580602078;41255.1748965013;41869.37195942002;42232.36651450292;42791.57208428001;40903.1819363617;40918.59485705815;41139;41542;42076;40485.59514404818;40767;42032.78983605062;42138.367924480546;42139.1572168561;35066;36102.27795444024;36243;36295.001747640476;37112.25775484421;28431.431371372044;28477.288067798472;28867;28948;28961 22:54:24 INFO - PROCESS | 15207 | |2;jquery.html;371.2056199732571;385.27183622952623;386.55353067207386;398.5197836606889;398.5237641018983;14516.709665806677;14908.105513669187;17187.82812171878;19177.42467725969;19299.903500482476;16451.506454806346;18664.44006679802;19027.714584281246;19049;19102.71345929812;5460.754266058037;5686.175504551838;5706.543476521868;5707.62900411474;5731.598788084836;4073.674106071507;5658.122990936411;5913.201717768111;6247.312795592481;6253.624782513041;6219.844503887393;6281.026440901667;6295.181626388563;6305.6216627002295;6346.6509341986175;6298.46463050639;6342.365763423667;6353.047042943573;6405.935940640627;6413;5397.541208997201;5554.527865131468;5575.275214222125;5591.552675785927;5678.687672178028;22442.43893902649;22649.433764155863;23041.654375184386;23088.07647694107;23121.653175202217;2387.3196139100273;2404.050400091954;2459.6187590923437;2525.4696513732138;2712.294803351143;13813.723725525433;14057.156570605797;14338.569842904626;14475.131492110508;14995.32521036556;1948.1784531463127;2008.7991200879942;2018.4335006242309;2027.3912435864186;2105.5788842231464;52869;74025.6298718503;76510.61744691241;81843;83908.58045709733;16144.919275403783;17202.655946880994;17207.741883871753;17252.396166134124;17366.21852016662;30701;30909.845450772602;31143.68856311408;31353.529697054564;31390.529142062886;9032.32257580684;9229.769255768526;9271.860922086174;9396.624135034523;9772.755681107887;7644.235576442311;7754.612269386508;8113.350931925432;8290.834183316421;8342.249197572126;8593.785155371166;8748.518831464204;8759.853835810267;8879.289656827568;8983.955080224558;3277.311764529428;3294.258791771832;3316.6849149330774;3371.561696979377;3536.469529570585;768.4620765464198;874.8425283448913;936.4849332867033;985.8718366612294;1076.8219309080873;18452.07739613014;18913.33803316905;19617.90191049064;19693.310734124236;19736.111874965372;984.5520288268821;986.0780170540568;992.4739887859446;1025.7230547752215;1033.2921948465325;10303.433311167957;10769;10806.891931080589;10830.729231769268;10865.619703310345;489976;490821;493231;495977;499304;88249.55875220583;90073.54963225142;94119;94630.05369946212;98186.5090674542;471.54260367443527;480.83170890188154;491.4765774450199;493.92838038484217;497.26206906860034;10708.89291107079;10738.087262582456;11266.436678166223;11380.54477820911;11512.94243528777;41384.793076034424;41776.16447670969;42323;42686.146277074906;43076;51271;51736.74131629318;52926.735366324465;60015.39984600273;60164;8075.152109028468;8555.657773689232;8606.913930860612;8615.181557752003;8691.26124279418;8484.575771211537;9032.45805251687;9588.232941364813;12748.936255318664;12796.232226066466;11032.28290161137;11238.719032024264;11267.436628168723;11272.774544509228;11717.06263498901;10434.321769084985;10468.110210632181;10520.579176832842;10626.946865265625;10666.306690065121;6336.366363363627;11295;11458.140639452242;11666;11930.463129159036;8047.718329858427;8214.958925205336;8372.372072094495;8407.3694472916;8522.10517895612;8431.915680843113;10620.415877126832;11192.216544841784;11360.318380897173;11475.426228688366 22:54:24 INFO - PROCESS | 15207 | |3;mootools.html;1299.948002079917;1427.6074079628102;1495.035701972228;1586.4606033948462;1735.2191513818784;8753.824923501526;9127.406718563298;9149.40528865624;9396.38923469974;9414.71755847324;9109.59006844692;9310.068993100704;9320.67377641781;9332.860007099898;9338.533073346323;2082.1775398717496;2325;2389.104085967762;2397.280815755271;2429.2955043037496;2392.9162479313227;2401.2076014915037;2401.651760494727;2403.1949296985445;2405.855648661086;2401.03958416633;2421.9273421797375;2426.284246147382;2426.3085020769086;2427.186892391051;2029.6245194638966;2304.919327823518;2359.504504054151;2366.5621859955963;2390.0439824070336;2383.0825132324007;2387.6179811230295;2398.97601023991;2400.8559486430872;2403.25499095281;9028.8645670315;9118.179363857218;9120.042395548504;9123.042080581576;9138.862917056249;5406.621536492447;5532.225488431623;5533.671918739514;5539.723013849291;5541.2796336476;3417.5215469834243;3522.771019883725;3548.503209550665;3594.712423006153;3597.964020359789;1104.8950349716763;1121.7532142928624;1130.9264897781618;1147.8966892979588;1155.422288855572;13238.53665121716;13318.067735258535;13371.598852034454;13404.329783510786;13440.529581464602;4818.7831547580445;4944.629152813553;4944.975275123673;4994.775235114428;5028.622853285945;10891.945540272407;10934.945325273482;10964.835527467094;11024.889751102546;11026.669199924016;5447.918281225706;5515.531179849758;5548.361938377138;5587.27365442498;5593.608447408724;4265.53079161292;4845;4973.154563724175;4992.026554821775;5069.923951140736;4061.5126184858004;4106.7535947842625;4167;4209.789510524462;4235.7035007549175;1272.7518133963788;1308.738252349534;1313.6190504753706;1319.8284223051135;1336.8796808287107;866.2463656618656;894.8926128864578;974.1135566634471;977.5796407544824;992.5831150916632;5944.256967879015;6042.3655516170165;6092.75628974836;6094.390560943959;6136.23297087864;477.25309890022004;484.5759960034969;488.2139754994456;1024.1908891975256;1076.7361996310954;4266.338717498793;4339.934900976488;4345.3699213613845;4353.912921741611;4372.890677733082;11500.194986350874;11685.298882066932;11723.941380293043;11799.88200118005;11806.232594881478;10850.728731781768;11550.306981581132;11568.305901645928;11666.591669291534;11737.119716021332;8295.294899933453;8762.211400973816;8770.649174032967;8773.473591584398;8776.78058048554;5953.374895635896;6183.5671502994355;6220.595661282002;6252.937470625236;6282.946856533509;10303.3817970922;10608.56784334136;10664.946675266885;10728.839067414152;10844.728881778019;10716.410597417216;10836.891631083588;10959.50682219318;11054.502547385548;11210.439478025903;7171.49799514029;7336.413086953137;7339.229380914927;8297.419180657538;8461.111583283666;7927.16764739694;8615.310775137848;8882.60028298741;8896.110388961311;9128.817423651357;8025.398095142771;8272.420930534805;8288.171182881664;8357.95821020891;8386.329093672613;7746.341560967156;7896.486728362638;7925.365970722443;8052.83894322122;8246.670133194844;7413.703451861865;7433.070866141732;7509.699612015458;7521.435892307989;7527.059117610299;5266.578673706018;5302.443243459381;5344;5370.919436208382;5422.457754224546;5155.767990440364;5201.063808514353;5264.815731449381;5411.485908838654;5549.44505549458 22:54:24 INFO - PROCESS | 15207 | |4;prototype.html;336.58936097960486;337.83952622504313;346.9566304211972;348.5729980773551;348.90230735394084;5281.313429254196;5310.6017048721405;5311.973440132803;5338.652987555806;5353.170258609922;5208.583313334933;5210.426853046171;5222.798756286056;5251.317328747257;5258.973705131479;3882.8058597070103;4034.354503279476;4125.91748165038;4145.709800313979;4149.439825623547;4117.279476091687;4158.5009798824185;4162.895927601804;4191.392248124035;4192.161567686475;3951.3677811550015;4122.855700050499;4141.979290103545;4155.62599366057;4195.916081678364;4051.372037334218;4150.91698166035;4159.896002599929;4174.436451079111;4179.143275628519;3664.468652045465;3682.815859207056;3688.907777305562;3696.741228114033;3729.5524537055458;5147.996140752554;5154;5170.353705786777;5192.1952097424955;5205.349331333583;4479.753613551254;4675.275332323496;4685.016146609216;4742.596879265267;4752.336682161251;5477.123660214386;5493.423190565013;5546;5549.944500554983;5579.972100139474;4009.87723437438;4034.576369481221;4038.858639947617;4041.6968727345566;4048.5141782985934;5550.9453203891135;5736.651886806597;5745.655260684331;5767.279090113736;5785.4379317584435;4060.4112403701297;4063;4065.4105154752397;4071.89820254496;4074.8166332515107;4064.3293856513937;4070.0260373718725;4094.344904815215;4101.159262351211;4108.5275193352545;4578.427696537933;4667.806131118369;4685.20351540239;4719.976400117977;4730.952690473051;5500.3949565547755;5534.446555344514;5539.529140023144;5588.692621905834;5609.878024395137;1390.7149034447914;1397.2385050147693;1400.6288333591606;1414.285785678226;1417.2417756500222;864.4726716702806;889.4618755652866;908.2824568590871;908.3596064774318;922.2852289475576;5319.707416092075;5333.706646134422;5343.984642917833;5375.731213439312;5380.78476860929;5565.805196818092;5590.105583106765;5605.831825045255;5630.690312032795;5647.463490968352;5078.469581512228;5323.30796996388;5332.92000619991;5337.558859108097;5348.331458567679;2982.776291778125;2989.8953536626113;2990.5065664165604;3025.4251692178414;3031.8484075796123;5912.320083190402;5929.822105336847;5933.169356290123;5934.37689042653;5934.703264836741;5626;5756.856078597984;5769.480746732815;5877.882442351129;5884.47039766423;5951.404859514014;5955.196048533479;5986.970065149733;6014.909776353271;6028.09578563219;5563.833085007456;5762.193292938908;5767.961766881834;5791.449812267828;5799.188113664175;5727.510847179847;5732.59231122921;5735.197072409949;5757.568182386254;5773.422657734193;5755.798547050833;5946.702664866652;5966.910496342645;5999.220101386792;6017.909731354121;4115.506139263308;4136.669066474735;4178.206140833232;4200.726952748061;4232;5666.744996475086;5680.801171958961;5706.657600543981;5748.856278593069;5749.626274292157;5365.436629153883;5385.4076051635075;5511.842513072139;5545.694986775605;5608.10270356741;5484;5504.9449505504435;5506.91739623914;5515.862103447446;5519.39286678473;5264.947350526599;5450.482204190595;5460.645058071213;5462.289902312674;5505.834824955257;5579.69311687861;5583.050881350099;5583.832485025456;5585.301837270341;5593.916091258716;5421.831267493034;5442.23808666779;5451.890962180655;5472.972635136958;5482.314710661168 22:54:24 INFO - PROCESS | 15207 | |5;yui.html;708.3200127877234;765.9391742436727;771.8803585444258;775.0544335910189;783.8745800671894;14912.254387280633;15047;15396.69206615867;15765.448209312677;15771.763423548657;13710.314484275772;13769.65575860604;13778.724425511484;13785.862141378584;13793.51722689706;671.4058058618109;783.3733013589134;807.8465091632601;814.1004190369645;816.5264146794874;815.0341844913796;816.7753867686404;817.4196320612342;817.8037271054964;819.5205804604313;853.2747164909839;855.1491266190119;855.5508358111979;855.7047818502607;855.7603870916122;693.972241110355;820.995895020524;848.4569875279826;849.2569002123142;850.0691742541907;620.7734177025353;623.4451338308909;625.0062400782778;625.7715933684218;626.1296797451546;14327.57017289483;14402.135871847619;14420.783688244685;14424.423023079169;14428.927855360656;13843.723125537534;13883.652908677263;13962.441502339894;14271.14373137615;14584.416623335053;11474.254173478697;11850.288982661068;11904.523819047228;12069.879301206964;12147;4366.323219900921;4412.376443555241;4457.732536047847;4467.463904331468;4591.081783643252;67756.6612166936;67802.66098669525;67952.98070528996;68043.31956680468;68226.65886670584;10725.08836748885;10891.128709703205;10891.509882055327;10926.836097458545;10988.670339889815;19193.424197274104;19358.225670973003;19360.4191874244;19377.4186774397;19383.612327753366;8191.959040204761;8204.712835050745;8215.671373145127;8432.494050356998;8498.617562209716;4397.142557201315;4454.28731402974;4576.931346029813;4653.627709783209;4722.456917454537;3379.898603041913;3475.58293004841;3492.738044646662;3496.4405695088662;3501.8599256029474;574.873527823878;578.2222910185793;578.9102689083198;585.1281590430228;589.7434615942079;565.5475619504463;622.8941080016408;625.5558553427118;628.9308176100625;637.4931929116271;9096.135867092615;9443.90556094444;9728.367656102331;9732.061897786978;9835.528438736515;628.5505863307757;640.9359064093553;665.5407768639623;678.2268214235775;706.3325157726002;4447.132809102259;4463.955360446419;4525.954740452619;4528.298113792367;4627.95372046282;64508.35491645117;65936.67031664906;65998.67000665062;94181.5290923541;99995.50002250087;73516.63241683865;83708.58145709232;94612.52693736488;95228.52385738026;96278;81955;81987.5900620505;82436;82739.17260827436;82798;9433.198178154658;9536.904630953602;9651.806963860543;9707.271954603575;9824.557894894604;48578.27132592943;49261;49431.50568494269;50235;50355.496445036544;68598.31401685919;74072.62963685147;75326.24673753192;75685;76725.61637191779;12553.623391298275;12872.871271287167;12897.935510322388;13133.868661313265;13169.407376667881;13695.520656776966;13899.37452814646;14029.228392438514;14176.645583860485;14844.257787110817;13784.793228101385;13988.230647314496;14075.366608502847;14613.19627420502;14636.04865683727;13516;13969;14010.509632162826;14336.354864030935;14347.139171649735;13310.866891330963;13623.571019401837;13691.589252322447;14051.859481405463;14104.435822567393;10426.791464170523;10818.729531761768;10869.565217391215;10914.836277455686;11146.164037697043;11526.59656912004;11704.531818727155;11757.176997610086;11818.586349477728;12094.75810483803 22:54:24 INFO - PROCESS | 15207 | __end_tp_report 22:54:24 INFO - PROCESS | 15207 | __start_cc_report 22:54:24 INFO - PROCESS | 15207 | _x_x_mozilla_cycle_collect,1145 22:54:24 INFO - PROCESS | 15207 | __end_cc_report 22:54:24 INFO - PROCESS | 15207 | __startTimestamp1465624464199__endTimestamp 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | ------- Summary: start ------- 22:54:24 INFO - PROCESS | 15207 | Number of tests: 6 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#0] dojo.html Cycles:165 Average:5264.53 Median:5430.51 stddev:588.24 (10.8%) stddev-sans-first:564.10 22:54:24 INFO - PROCESS | 15207 | Values: 3062.4 3078.0 3102.0 3123.5 3131.8 5083.2 5211.2 5257.8 5320.8 5358.1 5253.4 5288.4 5334.6 5337.4 5424.6 4842.1 4856.2 4868.1 4883.3 4959.8 4786.1 4958.3 4991.1 5002.3 5008.2 4732.0 4909.4 4911.2 4943.4 4945.2 4734.2 4782.7 4817.5 4838.1 4843.4 4798.2 4821.7 4884.5 4891.6 4925.5 5143.3 5317.3 5390.1 5407.1 5417.2 5557.1 5567.9 5581.1 5643.5 5694.7 5655.7 5670.3 5678.2 5715.9 5723.5 5222.3 5278.3 5279.4 5322.1 5323.4 5798.9 5843.0 5850.2 5900.3 5903.4 5607.7 5621.2 5626.3 5671.4 5675.1 5532.2 5548.0 5552.8 5751.8 5755.9 5524.3 5538.6 5543.1 5544.8 5585.1 5546.9 5556.8 5559.9 5561.5 5588.1 4252.5 4288.0 4291.7 4334.8 4345.3 3862.5 3873.0 3887.6 3919.5 3923.2 5395.9 5403.8 5404.5 5404.6 5405.1 5575.6 5584.3 5589.6 5594.6 5644.6 5343.7 5350.3 5351.4 5351.4 5360.1 4727.2 4754.5 4760.1 4762.9 4764.6 5802.9 5852.5 5859.5 5871.8 5882.9 5657.4 5663.5 5667.5 5668.8 5673.7 5821.2 5889.6 5900.7 5901.9 5907.9 5545.3 5635.9 5637.7 5643.1 5656.7 5719.9 5739.2 5740.9 5746.0 5747.3 5487.6 5513.8 5535.6 5617.4 5634.7 5544.1 5547.4 5549.7 5555.4 5584.3 5410.8 5412.6 5423.3 5456.0 5464.2 5328.2 5444.0 5480.4 5523.2 5577.6 5416.1 5424.1 5429.7 5430.5 5438.5 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#1] ext.html Cycles:180 Average:58422.07 Median:389446.50 stddev:108621.69 (27.9%) stddev-sans-first:108839.60 22:54:24 INFO - PROCESS | 15207 | Values: 582.8 636.4 641.0 646.5 659.4 30375.8 42877.4 43619.6 43627.8 43649.8 43449.0 43960.0 44074.6 44113.0 44157.3 8061.6 8785.5 8963.6 10477.8 10771.6 10611.0 10717.5 10723.9 10726.6 10733.8 10806.6 10834.1 10848.3 10856.5 10858.4 8139.7 10641.9 10909.9 10911.6 10913.9 10439.6 10455.5 10504.2 10807.7 10817.7 42143.0 42706.1 42749.4 42761.0 42819.8 3509.6 3594.1 4122.4 4141.3 4243.8 31903.2 32433.7 32661.7 32700.5 32714.0 4396.0 4456.6 4529.4 4635.4 4635.9 345554.0 345585.0 346581.0 350113.0 350150.0 61922.7 61928.4 62115.0 62325.4 62355.0 66679.3 67048.3 67073.0 67094.0 67159.0 14546.6 15965.4 16071.8 16097.5 16097.9 11159.7 11571.4 11572.5 11846.4 12176.6 16850.2 19349.5 19405.2 19561.5 19594.7 7229.7 7239.7 7273.3 7357.4 7518.5 977.0 1018.8 1021.3 1073.2 1076.5 32464.7 32603.8 32783.2 32969.7 33531.2 1070.2 1123.6 1153.2 1174.5 1205.7 17101.7 17345.8 17432.7 17448.4 17541.8 480227.0 485961.0 487622.0 488143.0 489085.0 57291.4 58699.7 58900.0 59177.4 59207.4 1221.8 1243.8 1259.2 1326.2 1341.3 28072.7 33680.0 33921.7 33985.3 34071.7 50732.5 51457.2 51469.5 51480.2 51590.7 384532.0 389300.0 389593.0 392472.0 392547.0 37103.4 41504.4 42930.4 43120.6 43214.0 47820.3 48053.8 48457.0 48731.3 49262.3 40838.8 41255.2 41869.4 42232.4 42791.6 40903.2 40918.6 41139.0 41542.0 42076.0 40485.6 40767.0 42032.8 42138.4 42139.2 35066.0 36102.3 36243.0 36295.0 37112.3 28431.4 28477.3 28867.0 28948.0 28961.0 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#2] jquery.html Cycles:180 Average:29357.08 Median:42049.58 stddev:81255.19 (193.2%) stddev-sans-first:81453.98 22:54:24 INFO - PROCESS | 15207 | Values: 371.2 385.3 386.6 398.5 398.5 14516.7 14908.1 17187.8 19177.4 19299.9 16451.5 18664.4 19027.7 19049.0 19102.7 5460.8 5686.2 5706.5 5707.6 5731.6 4073.7 5658.1 5913.2 6247.3 6253.6 6219.8 6281.0 6295.2 6305.6 6346.7 6298.5 6342.4 6353.0 6405.9 6413.0 5397.5 5554.5 5575.3 5591.6 5678.7 22442.4 22649.4 23041.7 23088.1 23121.7 2387.3 2404.1 2459.6 2525.5 2712.3 13813.7 14057.2 14338.6 14475.1 14995.3 1948.2 2008.8 2018.4 2027.4 2105.6 52869.0 74025.6 76510.6 81843.0 83908.6 16144.9 17202.7 17207.7 17252.4 17366.2 30701.0 30909.8 31143.7 31353.5 31390.5 9032.3 9229.8 9271.9 9396.6 9772.8 7644.2 7754.6 8113.4 8290.8 8342.2 8593.8 8748.5 8759.9 8879.3 8984.0 3277.3 3294.3 3316.7 3371.6 3536.5 768.5 874.8 936.5 985.9 1076.8 18452.1 18913.3 19617.9 19693.3 19736.1 984.6 986.1 992.5 1025.7 1033.3 10303.4 10769.0 10806.9 10830.7 10865.6 489976.0 490821.0 493231.0 495977.0 499304.0 88249.6 90073.5 94119.0 94630.1 98186.5 471.5 480.8 491.5 493.9 497.3 10708.9 10738.1 11266.4 11380.5 11512.9 41384.8 41776.2 42323.0 42686.1 43076.0 51271.0 51736.7 52926.7 60015.4 60164.0 8075.2 8555.7 8606.9 8615.2 8691.3 8484.6 9032.5 9588.2 12748.9 12796.2 11032.3 11238.7 11267.4 11272.8 11717.1 10434.3 10468.1 10520.6 10626.9 10666.3 6336.4 11295.0 11458.1 11666.0 11930.5 8047.7 8215.0 8372.4 8407.4 8522.1 8431.9 10620.4 11192.2 11360.3 11475.4 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#3] mootools.html Cycles:180 Average:6073.21 Median:2664.79 stddev:3540.58 (132.9%) stddev-sans-first:3532.34 22:54:24 INFO - PROCESS | 15207 | Values: 1299.9 1427.6 1495.0 1586.5 1735.2 8753.8 9127.4 9149.4 9396.4 9414.7 9109.6 9310.1 9320.7 9332.9 9338.5 2082.2 2325.0 2389.1 2397.3 2429.3 2392.9 2401.2 2401.7 2403.2 2405.9 2401.0 2421.9 2426.3 2426.3 2427.2 2029.6 2304.9 2359.5 2366.6 2390.0 2383.1 2387.6 2399.0 2400.9 2403.3 9028.9 9118.2 9120.0 9123.0 9138.9 5406.6 5532.2 5533.7 5539.7 5541.3 3417.5 3522.8 3548.5 3594.7 3598.0 1104.9 1121.8 1130.9 1147.9 1155.4 13238.5 13318.1 13371.6 13404.3 13440.5 4818.8 4944.6 4945.0 4994.8 5028.6 10891.9 10934.9 10964.8 11024.9 11026.7 5447.9 5515.5 5548.4 5587.3 5593.6 4265.5 4845.0 4973.2 4992.0 5069.9 4061.5 4106.8 4167.0 4209.8 4235.7 1272.8 1308.7 1313.6 1319.8 1336.9 866.2 894.9 974.1 977.6 992.6 5944.3 6042.4 6092.8 6094.4 6136.2 477.3 484.6 488.2 1024.2 1076.7 4266.3 4339.9 4345.4 4353.9 4372.9 11500.2 11685.3 11723.9 11799.9 11806.2 10850.7 11550.3 11568.3 11666.6 11737.1 8295.3 8762.2 8770.6 8773.5 8776.8 5953.4 6183.6 6220.6 6252.9 6282.9 10303.4 10608.6 10664.9 10728.8 10844.7 10716.4 10836.9 10959.5 11054.5 11210.4 7171.5 7336.4 7339.2 8297.4 8461.1 7927.2 8615.3 8882.6 8896.1 9128.8 8025.4 8272.4 8288.2 8358.0 8386.3 7746.3 7896.5 7925.4 8052.8 8246.7 7413.7 7433.1 7509.7 7521.4 7527.1 5266.6 5302.4 5344.0 5370.9 5422.5 5155.8 5201.1 5264.8 5411.5 5549.4 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#4] prototype.html Cycles:180 Average:4683.10 Median:5341.32 stddev:1380.77 (25.9%) stddev-sans-first:1345.55 22:54:24 INFO - PROCESS | 15207 | Values: 336.6 337.8 347.0 348.6 348.9 5281.3 5310.6 5312.0 5338.7 5353.2 5208.6 5210.4 5222.8 5251.3 5259.0 3882.8 4034.4 4125.9 4145.7 4149.4 4117.3 4158.5 4162.9 4191.4 4192.2 3951.4 4122.9 4142.0 4155.6 4195.9 4051.4 4150.9 4159.9 4174.4 4179.1 3664.5 3682.8 3688.9 3696.7 3729.6 5148.0 5154.0 5170.4 5192.2 5205.3 4479.8 4675.3 4685.0 4742.6 4752.3 5477.1 5493.4 5546.0 5549.9 5580.0 4009.9 4034.6 4038.9 4041.7 4048.5 5550.9 5736.7 5745.7 5767.3 5785.4 4060.4 4063.0 4065.4 4071.9 4074.8 4064.3 4070.0 4094.3 4101.2 4108.5 4578.4 4667.8 4685.2 4720.0 4731.0 5500.4 5534.4 5539.5 5588.7 5609.9 1390.7 1397.2 1400.6 1414.3 1417.2 864.5 889.5 908.3 908.4 922.3 5319.7 5333.7 5344.0 5375.7 5380.8 5565.8 5590.1 5605.8 5630.7 5647.5 5078.5 5323.3 5332.9 5337.6 5348.3 2982.8 2989.9 2990.5 3025.4 3031.8 5912.3 5929.8 5933.2 5934.4 5934.7 5626.0 5756.9 5769.5 5877.9 5884.5 5951.4 5955.2 5987.0 6014.9 6028.1 5563.8 5762.2 5768.0 5791.4 5799.2 5727.5 5732.6 5735.2 5757.6 5773.4 5755.8 5946.7 5966.9 5999.2 6017.9 4115.5 4136.7 4178.2 4200.7 4232.0 5666.7 5680.8 5706.7 5748.9 5749.6 5365.4 5385.4 5511.8 5545.7 5608.1 5484.0 5504.9 5506.9 5515.9 5519.4 5264.9 5450.5 5460.6 5462.3 5505.8 5579.7 5583.1 5583.8 5585.3 5593.9 5421.8 5442.2 5451.9 5473.0 5482.3 22:54:24 INFO - PROCESS | 15207 | 22:54:24 INFO - PROCESS | 15207 | [#5] yui.html Cycles:180 Average:18979.38 Median:48919.64 stddev:25723.26 (52.6%) stddev-sans-first:25758.83 22:54:24 INFO - PROCESS | 15207 | Values: 708.3 765.9 771.9 775.1 783.9 14912.3 15047.0 15396.7 15765.4 15771.8 13710.3 13769.7 13778.7 13785.9 13793.5 671.4 783.4 807.8 814.1 816.5 815.0 816.8 817.4 817.8 819.5 853.3 855.1 855.6 855.7 855.8 694.0 821.0 848.5 849.3 850.1 620.8 623.4 625.0 625.8 626.1 14327.6 14402.1 14420.8 14424.4 14428.9 13843.7 13883.7 13962.4 14271.1 14584.4 11474.3 11850.3 11904.5 12069.9 12147.0 4366.3 4412.4 4457.7 4467.5 4591.1 67756.7 67802.7 67953.0 68043.3 68226.7 10725.1 10891.1 10891.5 10926.8 10988.7 19193.4 19358.2 19360.4 19377.4 19383.6 8192.0 8204.7 8215.7 8432.5 8498.6 4397.1 4454.3 4576.9 4653.6 4722.5 3379.9 3475.6 3492.7 3496.4 3501.9 574.9 578.2 578.9 585.1 589.7 565.5 622.9 625.6 628.9 637.5 9096.1 9443.9 9728.4 9732.1 9835.5 628.6 640.9 665.5 678.2 706.3 4447.1 4464.0 4526.0 4528.3 4628.0 64508.4 65936.7 65998.7 94181.5 99995.5 73516.6 83708.6 94612.5 95228.5 96278.0 81955.0 81987.6 82436.0 82739.2 82798.0 9433.2 9536.9 9651.8 9707.3 9824.6 48578.3 49261.0 49431.5 50235.0 50355.5 68598.3 74072.6 75326.2 75685.0 76725.6 12553.6 12872.9 12897.9 13133.9 13169.4 13695.5 13899.4 14029.2 14176.6 14844.3 13784.8 13988.2 14075.4 14613.2 14636.0 13516.0 13969.0 14010.5 14336.4 14347.1 13310.9 13623.6 13691.6 14051.9 14104.4 10426.8 10818.7 10869.6 10914.8 11146.2 11526.6 11704.5 11757.2 11818.6 12094.8 22:54:24 INFO - PROCESS | 15207 | -------- Summary: end -------- 22:54:24 INFO - PROCESS | 15207 | 22:54:25 INFO - TEST-INFO | 15207: exit 0 22:54:25 INFO - TEST-OK | dromaeo_css | took 1114400ms 22:54:25 INFO - TEST-START | kraken 22:54:25 INFO - operating with platform_type : linux_ 22:54:25 INFO - Initialising browser for kraken test... 22:54:25 INFO - TEST-INFO | started process 15386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIh49ry/profile http://localhost:50966/getInfo.html) 22:54:29 INFO - PROCESS | 15386 | __metrics Screen width/height:1600/1200 22:54:29 INFO - PROCESS | 15386 | colorDepth:24 22:54:29 INFO - PROCESS | 15386 | Browser inner width/height: 1024/697 22:54:29 INFO - PROCESS | 15386 | __metrics 22:54:30 INFO - PROCESS | 15386 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:54:30 INFO - PROCESS | 15386 | console.error: PushService: 22:54:30 INFO - PROCESS | 15386 | stateChangeProcessEnqueue: Error transitioning state 22:54:30 INFO - PROCESS | 15386 | UnknownError 22:54:31 INFO - TEST-INFO | 15386: exit 0 22:54:31 INFO - Browser initialized. 22:54:31 INFO - Running cycle 1/1 for kraken test... 22:54:31 INFO - TEST-INFO | started process 15468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIh49ry/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:43 INFO - PROCESS | 15468 | RSS: Main: 173211648 22:54:43 INFO - PROCESS | 15468 | 22:54:45 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50966/tests/kraken/driver.html?testName=audio-beat-detection) 22:54:46 INFO - PROCESS | 15468 | RSS: Main: 232861696 22:54:46 INFO - PROCESS | 15468 | 22:54:49 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50966/tests/kraken/driver.html?testName=audio-dft) 22:54:49 INFO - PROCESS | 15468 | RSS: Main: 217137152 22:54:49 INFO - PROCESS | 15468 | 22:54:53 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50966/tests/kraken/driver.html?testName=audio-fft) 22:54:53 INFO - PROCESS | 15468 | RSS: Main: 286494720 22:54:53 INFO - PROCESS | 15468 | 22:54:55 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50966/tests/kraken/driver.html?testName=audio-oscillator) 22:54:56 INFO - PROCESS | 15468 | RSS: Main: 197062656 22:54:56 INFO - PROCESS | 15468 | 22:54:58 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50966/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:54:59 INFO - PROCESS | 15468 | RSS: Main: 201703424 22:54:59 INFO - PROCESS | 15468 | 22:55:02 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50966/tests/kraken/driver.html?testName=imaging-darkroom) 22:55:02 INFO - PROCESS | 15468 | RSS: Main: 237961216 22:55:02 INFO - PROCESS | 15468 | 22:55:06 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50966/tests/kraken/driver.html?testName=imaging-desaturate) 22:55:06 INFO - PROCESS | 15468 | RSS: Main: 238743552 22:55:06 INFO - PROCESS | 15468 | 22:55:09 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50966/tests/kraken/driver.html?testName=json-parse-financial) 22:55:10 INFO - PROCESS | 15468 | RSS: Main: 238747648 22:55:10 INFO - PROCESS | 15468 | 22:55:11 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50966/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:55:12 INFO - PROCESS | 15468 | RSS: Main: 225943552 22:55:12 INFO - PROCESS | 15468 | 22:55:14 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:55:14 INFO - PROCESS | 15468 | RSS: Main: 230178816 22:55:14 INFO - PROCESS | 15468 | 22:55:16 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:55:17 INFO - PROCESS | 15468 | RSS: Main: 238526464 22:55:17 INFO - PROCESS | 15468 | 22:55:19 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:55:20 INFO - PROCESS | 15468 | RSS: Main: 239861760 22:55:20 INFO - PROCESS | 15468 | 22:55:23 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:55:23 INFO - PROCESS | 15468 | RSS: Main: 240144384 22:55:23 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:50966/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50966/tests/kraken/driver.html?testName=ai-astar) 22:55:25 INFO - PROCESS | 15468 | RSS: Main: 282304512 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | __start_tp_report 22:55:25 INFO - PROCESS | 15468 | _x_x_mozilla_page_load 22:55:25 INFO - PROCESS | 15468 | _x_x_mozilla_page_load_details 22:55:25 INFO - PROCESS | 15468 | |i|pagename|runs| 22:55:25 INFO - PROCESS | 15468 | |0;ai-astar;112;105;109;110;108;110;110;111;109;109 22:55:25 INFO - PROCESS | 15468 | |1;audio-beat-detection;154;132;128;183;126;128;149;128;162;129 22:55:25 INFO - PROCESS | 15468 | |2;audio-dft;161;161;162;161;161;161;162;164;160;160 22:55:25 INFO - PROCESS | 15468 | |3;audio-fft;75;76;75;105;75;76;75;75;98;75 22:55:25 INFO - PROCESS | 15468 | |4;audio-oscillator;85;86;113;86;85;86;115;85;86;125 22:55:25 INFO - PROCESS | 15468 | |5;imaging-gaussian-blur;117;117;116;116;117;117;116;116;116;116 22:55:25 INFO - PROCESS | 15468 | |6;imaging-darkroom;147;146;147;146;146;146;147;146;145;146 22:55:25 INFO - PROCESS | 15468 | |7;imaging-desaturate;94;95;95;94;95;94;94;95;95;94 22:55:25 INFO - PROCESS | 15468 | |8;json-parse-financial;55;54;55;53;57;58;54;53;52;54 22:55:25 INFO - PROCESS | 15468 | |9;json-stringify-tinderbox;63;64;63;63;63;64;63;63;63;63 22:55:25 INFO - PROCESS | 15468 | |10;stanford-crypto-aes;80;79;78;79;78;78;79;80;111;80 22:55:25 INFO - PROCESS | 15468 | |11;stanford-crypto-ccm;128;129;130;126;121;118;118;121;125;132 22:55:25 INFO - PROCESS | 15468 | |12;stanford-crypto-pbkdf2;159;156;158;159;155;156;160;160;156;165 22:55:25 INFO - PROCESS | 15468 | |13;stanford-crypto-sha256-iterative;63;62;63;62;64;62;63;63;66;63 22:55:25 INFO - PROCESS | 15468 | __end_tp_report 22:55:25 INFO - PROCESS | 15468 | __start_cc_report 22:55:25 INFO - PROCESS | 15468 | _x_x_mozilla_cycle_collect,1614 22:55:25 INFO - PROCESS | 15468 | __end_cc_report 22:55:25 INFO - PROCESS | 15468 | __startTimestamp1465624525755__endTimestamp 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | ------- Summary: start ------- 22:55:25 INFO - PROCESS | 15468 | Number of tests: 14 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:1.73 22:55:25 INFO - PROCESS | 15468 | Values: 112.0 105.0 109.0 110.0 108.0 110.0 110.0 111.0 109.0 109.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:140.50 stddev:19.40 (13.8%) stddev-sans-first:20.08 22:55:25 INFO - PROCESS | 15468 | Values: 154.0 132.0 128.0 183.0 126.0 128.0 149.0 128.0 162.0 129.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 22:55:25 INFO - PROCESS | 15468 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 162.0 164.0 160.0 160.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.20 (14.9%) stddev-sans-first:11.70 22:55:25 INFO - PROCESS | 15468 | Values: 75.0 76.0 75.0 105.0 75.0 76.0 75.0 75.0 98.0 75.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:85.50 stddev:15.80 (18.5%) stddev-sans-first:16.32 22:55:25 INFO - PROCESS | 15468 | Values: 85.0 86.0 113.0 86.0 85.0 86.0 115.0 85.0 86.0 125.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:55:25 INFO - PROCESS | 15468 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 116.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 22:55:25 INFO - PROCESS | 15468 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 22:55:25 INFO - PROCESS | 15468 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.84 (3.4%) stddev-sans-first:1.94 22:55:25 INFO - PROCESS | 15468 | Values: 55.0 54.0 55.0 53.0 57.0 58.0 54.0 53.0 52.0 54.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 22:55:25 INFO - PROCESS | 15468 | Values: 63.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:79.00 stddev:10.15 (12.9%) stddev-sans-first:10.74 22:55:25 INFO - PROCESS | 15468 | Values: 80.0 79.0 78.0 79.0 78.0 78.0 79.0 80.0 111.0 80.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.00 stddev:5.05 (4.0%) stddev-sans-first:5.22 22:55:25 INFO - PROCESS | 15468 | Values: 128.0 129.0 130.0 126.0 121.0 118.0 118.0 121.0 125.0 132.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:2.95 (1.9%) stddev-sans-first:3.12 22:55:25 INFO - PROCESS | 15468 | Values: 159.0 156.0 158.0 159.0 155.0 156.0 160.0 160.0 156.0 165.0 22:55:25 INFO - PROCESS | 15468 | 22:55:25 INFO - PROCESS | 15468 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 22:55:25 INFO - PROCESS | 15468 | Values: 63.0 62.0 63.0 62.0 64.0 62.0 63.0 63.0 66.0 63.0 22:55:25 INFO - PROCESS | 15468 | -------- Summary: end -------- 22:55:25 INFO - PROCESS | 15468 | 22:55:26 INFO - TEST-INFO | 15468: exit 0 22:55:26 INFO - TEST-OK | kraken | took 61736ms 22:55:26 INFO - SUITE-END | took 1176s 22:55:26 INFO - Completed test suite (00:19:36) 22:55:26 INFO - javascript benchmark 22:55:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.433449811785, 3078.0458058002023, 3101.968980310197, 3123.547085672576, 3131.8120912745235, 5083.212102124167, 5211.166213405856, 5257.789688412464, 5320.840374788753, 5358.0623390906585, 5253.395859476162, 5288.418273989858, 5334.626576139672, 5337.386200586933, 5424.647397919132, 4842.1042107210105, 4856.247281671346, 4868.0750657375165, 4883.340748998884, 4959.826406075788, 4786.066716990188, 4958.30829513457, 4991.126552853254, 5002.2996780450585, 5008.24876268559, 4731.952680473186, 4909.435414927293, 4911.189653707134, 4943.431505376891, 4945.208766597345, 4734.19518681825, 4782.713037217778, 4817.494163112893, 4838.080764654705, 4843.39457567804, 4798.160321943646, 4821.686590371614, 4884.535969082967, 4891.608671306322, 4925.482824303468, 5143.305653736735, 5317.335333083364, 5390.137577987503, 5407.080796264644, 5417.241586177938, 5557.055300598908, 5567.8608034799045, 5581.079121944874, 5643.463870932255, 5694.658320500742, 5655.66066036035, 5670.262865827416, 5678.176664383641, 5715.913976344481, 5723.484886360247, 5222.294990176316, 5278.261043453919, 5279.392869819982, 5322.121849894801, 5323.361196656426, 5798.855028624318, 5842.977478941169, 5850.2102216200265, 5900.321463031721, 5903.380145084704, 5607.719614019283, 5621.213030175697, 5626.268585083994, 5671.432856714296, 5675.148727690879, 5532.197831314437, 5548.0, 5552.750126244328, 5751.798687045934, 5755.884882302331, 5524.281843360337, 5538.556915446755, 5543.057680194376, 5544.750486228048, 5585.134304182858, 5546.91679624806, 5556.805511807067, 5559.944400555943, 5561.499465048165, 5588.133839254922, 4252.532221455637, 4288.0, 4291.742495450283, 4334.848280310174, 4345.283028300359, 3862.478565393692, 3873.0123818426123, 3887.611238876146, 3919.5492518360184, 3923.195744872294, 5395.946040539623, 5403.83788486346, 5404.459554044564, 5404.594655400782, 5405.108157154104, 5575.581831362583, 5584.329880414376, 5589.580781441408, 5594.580406469531, 5644.6330988485615, 5343.67937923718, 5350.27771250884, 5351.384590772033, 5351.438098999627, 5360.115580929181, 4727.220008698595, 4754.477007529169, 4760.09558183944, 4762.857114286577, 4764.571188593043, 5802.912956305574, 5852.531797456193, 5859.472647461749, 5871.765129394862, 5882.882342353215, 5657.3776884543495, 5663.490285874291, 5667.489925906688, 5668.773249069991, 5673.744681489426, 5821.155932389865, 5889.646621202742, 5900.675462849413, 5901.911471327848, 5907.852303692442, 5545.279113715191, 5635.88728225425, 5637.718114094361, 5643.097104463431, 5656.688882111359, 5719.942800571941, 5739.225204597493, 5740.942590574041, 5746.0, 5747.310322761128, 5487.588430867621, 5513.807016754395, 5535.584831137761, 5617.382087970238, 5634.690092044977, 5544.112941929272, 5547.389787123332, 5549.694766787866, 5555.388907220284, 5584.274044374205, 5410.83767486976, 5412.566994640498, 5423.29497165366, 5456.017916775018, 5464.18037294409, 5328.227407025882, 5443.972780136074, 5480.3971563127225, 5523.199136125159, 5577.581681373995, 5416.079266524779, 5424.1321388577635, 5429.728513574384, 5430.51125398716, 5438.537724293479], "value": 5225.533663121595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7727186397306, 636.3572791480603, 640.9711562979667, 646.5441863486243, 659.3999460490953, 30375.848120759394, 42877.35683964739, 43619.56380436195, 43627.78186109073, 43649.7817510912, 43449.0, 43960.0, 44074.559254407446, 44113.0, 44157.337639935344, 8061.556614386206, 8785.472871627691, 8963.596638151266, 10477.79044419115, 10771.62299319524, 10611.0, 10717.517711702953, 10723.892761072406, 10726.570937162503, 10733.83899241512, 10806.621768238114, 10834.079103276232, 10848.349099054081, 10856.511456984455, 10858.402787846666, 8139.674413023472, 10641.946790266038, 10909.945450272699, 10911.618093366773, 10913.945430272797, 10439.634612788592, 10455.52950117239, 10504.159667226604, 10807.67576972692, 10817.675469735921, 42143.0, 42706.14587708259, 42749.35875961863, 42761.0, 42819.785901070296, 3509.5788505379264, 3594.101474631342, 4122.361034039729, 4141.337386018223, 4243.766592837393, 31903.202419939455, 32433.67566324354, 32661.673383266338, 32700.509492357633, 32714.0, 4395.978020109911, 4456.55434456555, 4529.411176547028, 4635.443746750378, 4635.930461043087, 345554.0, 345585.0, 346581.0, 350113.0, 350149.99999999744, 61922.69038654778, 61928.38071619316, 62115.0, 62325.37674623286, 62355.0, 66679.33320666732, 67048.32951670518, 67073.0, 67094.0, 67159.0, 14546.636334091521, 15965.361385544447, 16071.839281607268, 16097.517074487783, 16097.919510402373, 11159.665210043711, 11571.363575003455, 11572.47923843429, 11846.407679615984, 12176.634700958986, 16850.245368956585, 19349.51626209356, 19405.2237910482, 19561.510962226057, 19594.70607940882, 7229.674664640103, 7239.746608868664, 7273.254274048869, 7357.41140708742, 7518.47392166757, 976.9902300977042, 1018.7860549284733, 1021.279997601689, 1073.2111897755144, 1076.531708706715, 32464.675353246166, 32603.83698081542, 32783.180420489676, 32969.67030329666, 33531.16172095668, 1070.2133931560297, 1123.5505797680994, 1153.2446247707765, 1174.4714878304796, 1205.7166565857017, 17101.743473847902, 17345.826541734674, 17432.738508922375, 17448.389306374214, 17541.824581754274, 480227.0, 485961.0, 487622.0, 488143.0, 489085.0, 57291.42708572861, 58699.70650146722, 58900.0, 59177.40822591719, 59207.40792592019, 1221.7800795856654, 1243.7574672938872, 1259.1626568331956, 1326.2440408966797, 1341.2690083904295, 28072.719272807826, 33680.0, 33921.66078339185, 33985.32029359449, 34071.65928340685, 50732.492675072775, 51457.22814157716, 51469.48530514647, 51480.22779658383, 51590.74204628953, 384532.0, 389300.0, 389593.0, 392472.0, 392547.0, 37103.44344834884, 41504.377434337905, 42930.35604465873, 43120.56879431166, 43213.97502174944, 47820.28269576029, 48053.75973120112, 48457.0, 48731.26903096386, 49262.26106608476, 40838.79580602078, 41255.1748965013, 41869.37195942002, 42232.36651450292, 42791.57208428001, 40903.1819363617, 40918.59485705815, 41139.0, 41542.0, 42076.0, 40485.59514404818, 40767.0, 42032.78983605062, 42138.367924480546, 42139.1572168561, 35066.0, 36102.27795444024, 36243.0, 36295.001747640476, 37112.25775484421, 28431.431371372044, 28477.288067798472, 28867.0, 28948.0, 28961.0], "value": 20835.534342280887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.2056199732571, 385.27183622952623, 386.55353067207386, 398.5197836606889, 398.5237641018983, 14516.709665806677, 14908.105513669187, 17187.82812171878, 19177.42467725969, 19299.903500482476, 16451.506454806346, 18664.44006679802, 19027.714584281246, 19049.0, 19102.71345929812, 5460.754266058037, 5686.175504551838, 5706.543476521868, 5707.62900411474, 5731.598788084836, 4073.674106071507, 5658.122990936411, 5913.201717768111, 6247.312795592481, 6253.624782513041, 6219.844503887393, 6281.026440901667, 6295.181626388563, 6305.6216627002295, 6346.6509341986175, 6298.46463050639, 6342.365763423667, 6353.047042943573, 6405.935940640627, 6413.0, 5397.541208997201, 5554.527865131468, 5575.275214222125, 5591.552675785927, 5678.687672178028, 22442.43893902649, 22649.433764155863, 23041.654375184386, 23088.07647694107, 23121.653175202217, 2387.3196139100273, 2404.050400091954, 2459.6187590923437, 2525.4696513732138, 2712.294803351143, 13813.723725525433, 14057.156570605797, 14338.569842904626, 14475.131492110508, 14995.32521036556, 1948.1784531463127, 2008.7991200879942, 2018.4335006242309, 2027.3912435864186, 2105.5788842231464, 52869.0, 74025.6298718503, 76510.61744691241, 81843.0, 83908.58045709733, 16144.919275403783, 17202.655946880994, 17207.741883871753, 17252.396166134124, 17366.21852016662, 30701.0, 30909.845450772602, 31143.68856311408, 31353.529697054564, 31390.529142062886, 9032.32257580684, 9229.769255768526, 9271.860922086174, 9396.624135034523, 9772.755681107887, 7644.235576442311, 7754.612269386508, 8113.350931925432, 8290.834183316421, 8342.249197572126, 8593.785155371166, 8748.518831464204, 8759.853835810267, 8879.289656827568, 8983.955080224558, 3277.311764529428, 3294.258791771832, 3316.6849149330774, 3371.561696979377, 3536.469529570585, 768.4620765464198, 874.8425283448913, 936.4849332867033, 985.8718366612294, 1076.8219309080873, 18452.07739613014, 18913.33803316905, 19617.90191049064, 19693.310734124236, 19736.111874965372, 984.5520288268821, 986.0780170540568, 992.4739887859446, 1025.7230547752215, 1033.2921948465325, 10303.433311167957, 10769.0, 10806.891931080589, 10830.729231769268, 10865.619703310345, 489976.0, 490821.0, 493231.0, 495977.0, 499304.0, 88249.55875220583, 90073.54963225142, 94119.0, 94630.05369946212, 98186.5090674542, 471.54260367443527, 480.83170890188154, 491.4765774450199, 493.92838038484217, 497.26206906860034, 10708.89291107079, 10738.087262582456, 11266.436678166223, 11380.54477820911, 11512.94243528777, 41384.793076034424, 41776.16447670969, 42323.0, 42686.146277074906, 43076.0, 51271.0, 51736.74131629318, 52926.735366324465, 60015.39984600273, 60164.0, 8075.152109028468, 8555.657773689232, 8606.913930860612, 8615.181557752003, 8691.26124279418, 8484.575771211537, 9032.45805251687, 9588.232941364813, 12748.936255318664, 12796.232226066466, 11032.28290161137, 11238.719032024264, 11267.436628168723, 11272.774544509228, 11717.06263498901, 10434.321769084985, 10468.110210632181, 10520.579176832842, 10626.946865265625, 10666.306690065121, 6336.366363363627, 11295.0, 11458.140639452242, 11666.0, 11930.463129159036, 8047.718329858427, 8214.958925205336, 8372.372072094495, 8407.3694472916, 8522.10517895612, 8431.915680843113, 10620.415877126832, 11192.216544841784, 11360.318380897173, 11475.426228688366], "value": 9465.886899054109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.948002079917, 1427.6074079628102, 1495.035701972228, 1586.4606033948462, 1735.2191513818784, 8753.824923501526, 9127.406718563298, 9149.40528865624, 9396.38923469974, 9414.71755847324, 9109.59006844692, 9310.068993100704, 9320.67377641781, 9332.860007099898, 9338.533073346323, 2082.1775398717496, 2325.0, 2389.104085967762, 2397.280815755271, 2429.2955043037496, 2392.9162479313227, 2401.2076014915037, 2401.651760494727, 2403.1949296985445, 2405.855648661086, 2401.03958416633, 2421.9273421797375, 2426.284246147382, 2426.3085020769086, 2427.186892391051, 2029.6245194638966, 2304.919327823518, 2359.504504054151, 2366.5621859955963, 2390.0439824070336, 2383.0825132324007, 2387.6179811230295, 2398.97601023991, 2400.8559486430872, 2403.25499095281, 9028.8645670315, 9118.179363857218, 9120.042395548504, 9123.042080581576, 9138.862917056249, 5406.621536492447, 5532.225488431623, 5533.671918739514, 5539.723013849291, 5541.2796336476, 3417.5215469834243, 3522.771019883725, 3548.503209550665, 3594.712423006153, 3597.964020359789, 1104.8950349716763, 1121.7532142928624, 1130.9264897781618, 1147.8966892979588, 1155.422288855572, 13238.53665121716, 13318.067735258535, 13371.598852034454, 13404.329783510786, 13440.529581464602, 4818.7831547580445, 4944.629152813553, 4944.975275123673, 4994.775235114428, 5028.622853285945, 10891.945540272407, 10934.945325273482, 10964.835527467094, 11024.889751102546, 11026.669199924016, 5447.918281225706, 5515.531179849758, 5548.361938377138, 5587.27365442498, 5593.608447408724, 4265.53079161292, 4845.0, 4973.154563724175, 4992.026554821775, 5069.923951140736, 4061.5126184858004, 4106.7535947842625, 4167.0, 4209.789510524462, 4235.7035007549175, 1272.7518133963788, 1308.738252349534, 1313.6190504753706, 1319.8284223051135, 1336.8796808287107, 866.2463656618656, 894.8926128864578, 974.1135566634471, 977.5796407544824, 992.5831150916632, 5944.256967879015, 6042.3655516170165, 6092.75628974836, 6094.390560943959, 6136.23297087864, 477.25309890022004, 484.5759960034969, 488.2139754994456, 1024.1908891975256, 1076.7361996310954, 4266.338717498793, 4339.934900976488, 4345.3699213613845, 4353.912921741611, 4372.890677733082, 11500.194986350874, 11685.298882066932, 11723.941380293043, 11799.88200118005, 11806.232594881478, 10850.728731781768, 11550.306981581132, 11568.305901645928, 11666.591669291534, 11737.119716021332, 8295.294899933453, 8762.211400973816, 8770.649174032967, 8773.473591584398, 8776.78058048554, 5953.374895635896, 6183.5671502994355, 6220.595661282002, 6252.937470625236, 6282.946856533509, 10303.3817970922, 10608.56784334136, 10664.946675266885, 10728.839067414152, 10844.728881778019, 10716.410597417216, 10836.891631083588, 10959.50682219318, 11054.502547385548, 11210.439478025903, 7171.49799514029, 7336.413086953137, 7339.229380914927, 8297.419180657538, 8461.111583283666, 7927.16764739694, 8615.310775137848, 8882.60028298741, 8896.110388961311, 9128.817423651357, 8025.398095142771, 8272.420930534805, 8288.171182881664, 8357.95821020891, 8386.329093672613, 7746.341560967156, 7896.486728362638, 7925.365970722443, 8052.83894322122, 8246.670133194844, 7413.703451861865, 7433.070866141732, 7509.699612015458, 7521.435892307989, 7527.059117610299, 5266.578673706018, 5302.443243459381, 5344.0, 5370.919436208382, 5422.457754224546, 5155.767990440364, 5201.063808514353, 5264.815731449381, 5411.485908838654, 5549.44505549458], "value": 4776.244410218358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.58936097960486, 337.83952622504313, 346.9566304211972, 348.5729980773551, 348.90230735394084, 5281.313429254196, 5310.6017048721405, 5311.973440132803, 5338.652987555806, 5353.170258609922, 5208.583313334933, 5210.426853046171, 5222.798756286056, 5251.317328747257, 5258.973705131479, 3882.8058597070103, 4034.354503279476, 4125.91748165038, 4145.709800313979, 4149.439825623547, 4117.279476091687, 4158.5009798824185, 4162.895927601804, 4191.392248124035, 4192.161567686475, 3951.3677811550015, 4122.855700050499, 4141.979290103545, 4155.62599366057, 4195.916081678364, 4051.372037334218, 4150.91698166035, 4159.896002599929, 4174.436451079111, 4179.143275628519, 3664.468652045465, 3682.815859207056, 3688.907777305562, 3696.741228114033, 3729.5524537055458, 5147.996140752554, 5154.0, 5170.353705786777, 5192.1952097424955, 5205.349331333583, 4479.753613551254, 4675.275332323496, 4685.016146609216, 4742.596879265267, 4752.336682161251, 5477.123660214386, 5493.423190565013, 5546.0, 5549.944500554983, 5579.972100139474, 4009.87723437438, 4034.576369481221, 4038.858639947617, 4041.6968727345566, 4048.5141782985934, 5550.9453203891135, 5736.651886806597, 5745.655260684331, 5767.279090113736, 5785.4379317584435, 4060.4112403701297, 4063.0, 4065.4105154752397, 4071.89820254496, 4074.8166332515107, 4064.3293856513937, 4070.0260373718725, 4094.344904815215, 4101.159262351211, 4108.5275193352545, 4578.427696537933, 4667.806131118369, 4685.20351540239, 4719.976400117977, 4730.952690473051, 5500.3949565547755, 5534.446555344514, 5539.529140023144, 5588.692621905834, 5609.878024395137, 1390.7149034447914, 1397.2385050147693, 1400.6288333591606, 1414.285785678226, 1417.2417756500222, 864.4726716702806, 889.4618755652866, 908.2824568590871, 908.3596064774318, 922.2852289475576, 5319.707416092075, 5333.706646134422, 5343.984642917833, 5375.731213439312, 5380.78476860929, 5565.805196818092, 5590.105583106765, 5605.831825045255, 5630.690312032795, 5647.463490968352, 5078.469581512228, 5323.30796996388, 5332.92000619991, 5337.558859108097, 5348.331458567679, 2982.776291778125, 2989.8953536626113, 2990.5065664165604, 3025.4251692178414, 3031.8484075796123, 5912.320083190402, 5929.822105336847, 5933.169356290123, 5934.37689042653, 5934.703264836741, 5626.0, 5756.856078597984, 5769.480746732815, 5877.882442351129, 5884.47039766423, 5951.404859514014, 5955.196048533479, 5986.970065149733, 6014.909776353271, 6028.09578563219, 5563.833085007456, 5762.193292938908, 5767.961766881834, 5791.449812267828, 5799.188113664175, 5727.510847179847, 5732.59231122921, 5735.197072409949, 5757.568182386254, 5773.422657734193, 5755.798547050833, 5946.702664866652, 5966.910496342645, 5999.220101386792, 6017.909731354121, 4115.506139263308, 4136.669066474735, 4178.206140833232, 4200.726952748061, 4232.0, 5666.744996475086, 5680.801171958961, 5706.657600543981, 5748.856278593069, 5749.626274292157, 5365.436629153883, 5385.4076051635075, 5511.842513072139, 5545.694986775605, 5608.10270356741, 5484.0, 5504.9449505504435, 5506.91739623914, 5515.862103447446, 5519.39286678473, 5264.947350526599, 5450.482204190595, 5460.645058071213, 5462.289902312674, 5505.834824955257, 5579.69311687861, 5583.050881350099, 5583.832485025456, 5585.301837270341, 5593.916091258716, 5421.831267493034, 5442.23808666779, 5451.890962180655, 5472.972635136958, 5482.314710661168], "value": 4241.799260838103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.3200127877234, 765.9391742436727, 771.8803585444258, 775.0544335910189, 783.8745800671894, 14912.254387280633, 15047.0, 15396.69206615867, 15765.448209312677, 15771.763423548657, 13710.314484275772, 13769.65575860604, 13778.724425511484, 13785.862141378584, 13793.51722689706, 671.4058058618109, 783.3733013589134, 807.8465091632601, 814.1004190369645, 816.5264146794874, 815.0341844913796, 816.7753867686404, 817.4196320612342, 817.8037271054964, 819.5205804604313, 853.2747164909839, 855.1491266190119, 855.5508358111979, 855.7047818502607, 855.7603870916122, 693.972241110355, 820.995895020524, 848.4569875279826, 849.2569002123142, 850.0691742541907, 620.7734177025353, 623.4451338308909, 625.0062400782778, 625.7715933684218, 626.1296797451546, 14327.57017289483, 14402.135871847619, 14420.783688244685, 14424.423023079169, 14428.927855360656, 13843.723125537534, 13883.652908677263, 13962.441502339894, 14271.14373137615, 14584.416623335053, 11474.254173478697, 11850.288982661068, 11904.523819047228, 12069.879301206964, 12147.0, 4366.323219900921, 4412.376443555241, 4457.732536047847, 4467.463904331468, 4591.081783643252, 67756.6612166936, 67802.66098669525, 67952.98070528996, 68043.31956680468, 68226.65886670584, 10725.08836748885, 10891.128709703205, 10891.509882055327, 10926.836097458545, 10988.670339889815, 19193.424197274104, 19358.225670973003, 19360.4191874244, 19377.4186774397, 19383.612327753366, 8191.959040204761, 8204.712835050745, 8215.671373145127, 8432.494050356998, 8498.617562209716, 4397.142557201315, 4454.28731402974, 4576.931346029813, 4653.627709783209, 4722.456917454537, 3379.898603041913, 3475.58293004841, 3492.738044646662, 3496.4405695088662, 3501.8599256029474, 574.873527823878, 578.2222910185793, 578.9102689083198, 585.1281590430228, 589.7434615942079, 565.5475619504463, 622.8941080016408, 625.5558553427118, 628.9308176100625, 637.4931929116271, 9096.135867092615, 9443.90556094444, 9728.367656102331, 9732.061897786978, 9835.528438736515, 628.5505863307757, 640.9359064093553, 665.5407768639623, 678.2268214235775, 706.3325157726002, 4447.132809102259, 4463.955360446419, 4525.954740452619, 4528.298113792367, 4627.95372046282, 64508.35491645117, 65936.67031664906, 65998.67000665062, 94181.5290923541, 99995.50002250087, 73516.63241683865, 83708.58145709232, 94612.52693736488, 95228.52385738026, 96278.0, 81955.0, 81987.5900620505, 82436.0, 82739.17260827436, 82798.0, 9433.198178154658, 9536.904630953602, 9651.806963860543, 9707.271954603575, 9824.557894894604, 48578.27132592943, 49261.0, 49431.50568494269, 50235.0, 50355.496445036544, 68598.31401685919, 74072.62963685147, 75326.24673753192, 75685.0, 76725.61637191779, 12553.623391298275, 12872.871271287167, 12897.935510322388, 13133.868661313265, 13169.407376667881, 13695.520656776966, 13899.37452814646, 14029.228392438514, 14176.645583860485, 14844.257787110817, 13784.793228101385, 13988.230647314496, 14075.366608502847, 14613.19627420502, 14636.04865683727, 13516.0, 13969.0, 14010.509632162826, 14336.354864030935, 14347.139171649735, 13310.866891330963, 13623.571019401837, 13691.589252322447, 14051.859481405463, 14104.435822567393, 10426.791464170523, 10818.729531761768, 10869.565217391215, 10914.836277455686, 11146.164037697043, 11526.59656912004, 11704.531818727155, 11757.176997610086, 11818.586349477728, 12094.75810483803], "value": 7301.193655776782, "unit": "score"}], "name": "dromaeo_css", "value": 7309.071414736569, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 109.0, 110.0, 108.0, 110.0, 110.0, 111.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 128.0, 183.0, 126.0, 128.0, 149.0, 128.0, 162.0, 129.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 164.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 105.0, 75.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 113.0, 86.0, 85.0, 86.0, 115.0, 85.0, 86.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 57.0, 58.0, 54.0, 53.0, 52.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 78.0, 78.0, 79.0, 80.0, 111.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 130.0, 126.0, 121.0, 118.0, 118.0, 121.0, 125.0, 132.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 158.0, 159.0, 155.0, 156.0, 160.0, 160.0, 156.0, 165.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 66.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1491.5, "alertThreshold": 2.0}]} 22:55:27 INFO - Return code: 0 22:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:55:27 INFO - # TBPL SUCCESS # 22:55:27 INFO - Running post-action listener: _resource_record_post_action 22:55:27 INFO - ##### 22:55:27 INFO - ##### Finished run-tests step (success) 22:55:27 INFO - ##### 22:55:27 INFO - Running post-run listener: _resource_record_post_run 22:55:27 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 541519872; Read time: 0; Write time: 562608 22:55:27 INFO - TinderboxPrint: CPU usage
13.1% 22:55:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:55:27 INFO - TinderboxPrint: I/O write bytes / time
541,519,872 / 562,608 22:55:27 INFO - TinderboxPrint: CPU idle
8,274.9 (86.8%) 22:55:27 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 22:55:27 INFO - TinderboxPrint: Swap in / out
0 / 0 22:55:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248524800; Read time: 0; Write time: 283388 22:55:27 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 292995072; Read time: 0; Write time: 279220 22:55:27 INFO - Running post-run listener: _upload_blobber_files 22:55:27 INFO - Blob upload gear active. 22:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:55:27 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 22:55:27 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'] 22:55:27 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 22:55:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:55:32 INFO - (blobuploader) - INFO - Done attempting. 22:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:55:33 INFO - (blobuploader) - INFO - Done attempting. 22:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:55:33 INFO - (blobuploader) - INFO - Done attempting. 22:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:55:33 INFO - Return code: 0 22:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf0b09d1c01f247b9e1d9c1f204d820a9b5af032f7d0c3cbe6a0c633cd67234df1caa932df5e07c1524b4a4f0f00c8619d3f43d6eeb42bbd663b7332c35128cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4d6347554f70012111ceb60cc19ee5f2c0aa29c8e8f18696c2dd5e317219357c5605a69b65e976bb53badf4f03a1b748d0908f10b2d44b3b9e6ed9ea09a77ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036c32668e57a1b50d41ff59261b760952e4e29ad3064feb3489594b2f135b157a7be7f725eca854125ff3afb429c61f556e577e953fb93430024457aceeb828"} 22:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:55:33 INFO - Contents: 22:55:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf0b09d1c01f247b9e1d9c1f204d820a9b5af032f7d0c3cbe6a0c633cd67234df1caa932df5e07c1524b4a4f0f00c8619d3f43d6eeb42bbd663b7332c35128cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4d6347554f70012111ceb60cc19ee5f2c0aa29c8e8f18696c2dd5e317219357c5605a69b65e976bb53badf4f03a1b748d0908f10b2d44b3b9e6ed9ea09a77ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036c32668e57a1b50d41ff59261b760952e4e29ad3064feb3489594b2f135b157a7be7f725eca854125ff3afb429c61f556e577e953fb93430024457aceeb828"} 22:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:55:33 INFO - Copying logs to upload dir... 22:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.411250 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-10 22:55:32.346009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 22:55:32.349864) ========= 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-1465619629.800314-369750013 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/cf0b09d1c01f247b9e1d9c1f204d820a9b5af032f7d0c3cbe6a0c633cd67234df1caa932df5e07c1524b4a4f0f00c8619d3f43d6eeb42bbd663b7332c35128cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4d6347554f70012111ceb60cc19ee5f2c0aa29c8e8f18696c2dd5e317219357c5605a69b65e976bb53badf4f03a1b748d0908f10b2d44b3b9e6ed9ea09a77ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036c32668e57a1b50d41ff59261b760952e4e29ad3064feb3489594b2f135b157a7be7f725eca854125ff3afb429c61f556e577e953fb93430024457aceeb828"} build_url:https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/LI0V7BWaTHemh6Il3k8V_Q/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/cf0b09d1c01f247b9e1d9c1f204d820a9b5af032f7d0c3cbe6a0c633cd67234df1caa932df5e07c1524b4a4f0f00c8619d3f43d6eeb42bbd663b7332c35128cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4d6347554f70012111ceb60cc19ee5f2c0aa29c8e8f18696c2dd5e317219357c5605a69b65e976bb53badf4f03a1b748d0908f10b2d44b3b9e6ed9ea09a77ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/036c32668e57a1b50d41ff59261b760952e4e29ad3064feb3489594b2f135b157a7be7f725eca854125ff3afb429c61f556e577e953fb93430024457aceeb828"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 22:55:32.377209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:55:32.377783) ========= 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-1465619629.800314-369750013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:55:32.459284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 22:55:32.459664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 22:55:32.459956) ========= ========= Total master_lag: 0.16 =========