builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1466104645.41 results: success (0) buildid: 20160616093554 builduid: e7cc58182c60494b8d5f6c4bdf9ce75d revision: ea9d62d5f09b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.411395) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.412157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.412461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.430724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.431085) ========= 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=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 12:17:25-- 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% 43.0M=0s 2016-06-16 12:17:25 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116604 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.564430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.564742) ========= 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=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019867 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:25.617465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 12:17:25.617828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9d62d5f09b --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 ea9d62d5f09b --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=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 12:17:25,909 Setting DEBUG logging. 2016-06-16 12:17:25,909 attempt 1/10 2016-06-16 12:17:25,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9d62d5f09b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 12:17:27,328 unpacking tar archive at: fx-team-ea9d62d5f09b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.781244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 12:17:27.414901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:27.415439) ========= script_repo_revision: ea9d62d5f09b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:27.416084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:27.416549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:17:27.428290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-16 12:17:27.428900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:27 INFO - MultiFileLogger online at 20160616 12:17:27 in /builds/slave/test 12:17:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:17:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:27 INFO - {'append_to_log': False, 12:17:27 INFO - 'base_work_dir': '/builds/slave/test', 12:17:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:17:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:27 INFO - 'branch': 'Fx-Team', 12:17:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:27 INFO - 'config_files': ('talos/linux_config.py',), 12:17:27 INFO - 'default_actions': ('clobber', 12:17:27 INFO - 'read-buildbot-config', 12:17:27 INFO - 'download-and-extract', 12:17:27 INFO - 'populate-webroot', 12:17:27 INFO - 'create-virtualenv', 12:17:27 INFO - 'install', 12:17:27 INFO - 'run-tests'), 12:17:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:27 INFO - 'download_minidump_stackwalk': True, 12:17:27 INFO - 'download_symbols': 'ondemand', 12:17:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:27 INFO - 'installer_path': 'installer.exe', 12:17:27 INFO - 'log_level': 'info', 12:17:27 INFO - 'log_name': 'talos', 12:17:27 INFO - 'log_to_console': True, 12:17:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:27 INFO - 'opt_config_files': (), 12:17:27 INFO - 'pip_index': False, 12:17:27 INFO - 'sps_profile': False, 12:17:27 INFO - 'sps_profile_interval': 0, 12:17:27 INFO - 'suite': 'dromaeojs-e10s', 12:17:27 INFO - 'system_bits': '32', 12:17:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:27 INFO - 'title': 'talos-linux64-ix-035', 12:17:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:27 INFO - 'use_talos_json': True, 12:17:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:27 INFO - 'work_dir': 'build'} 12:17:27 INFO - ##### 12:17:27 INFO - ##### Running clobber step. 12:17:27 INFO - ##### 12:17:27 INFO - Running pre-action listener: _resource_record_pre_action 12:17:27 INFO - Running main action method: clobber 12:17:27 INFO - rmtree: /builds/slave/test/build 12:17:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:28 INFO - Running post-action listener: _resource_record_post_action 12:17:28 INFO - ##### 12:17:28 INFO - ##### Finished clobber step (success) 12:17:28 INFO - ##### 12:17:28 INFO - ##### 12:17:28 INFO - ##### Running read-buildbot-config step. 12:17:28 INFO - ##### 12:17:28 INFO - Running pre-action listener: _resource_record_pre_action 12:17:28 INFO - Running main action method: read_buildbot_config 12:17:28 INFO - Using buildbot properties: 12:17:28 INFO - { 12:17:28 INFO - "project": "", 12:17:28 INFO - "product": "firefox", 12:17:28 INFO - "script_repo_revision": "production", 12:17:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:17:28 INFO - "repository": "", 12:17:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:17:28 INFO - "buildid": "20160616093554", 12:17:28 INFO - "pgo_build": "True", 12:17:28 INFO - "basedir": "/builds/slave/test", 12:17:28 INFO - "buildnumber": 481, 12:17:28 INFO - "slavename": "talos-linux64-ix-035", 12:17:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:17:28 INFO - "platform": "ubuntu64_hw", 12:17:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:17:28 INFO - "branch": "fx-team", 12:17:28 INFO - "repo_path": "integration/fx-team", 12:17:28 INFO - "revision": "ea9d62d5f09b", 12:17:28 INFO - "stage_platform": "linux64-pgo", 12:17:28 INFO - "builduid": "e7cc58182c60494b8d5f6c4bdf9ce75d", 12:17:28 INFO - "slavebuilddir": "test" 12:17:28 INFO - } 12:17:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:17:28 INFO - Running post-action listener: _resource_record_post_action 12:17:28 INFO - ##### 12:17:28 INFO - ##### Finished read-buildbot-config step (success) 12:17:28 INFO - ##### 12:17:28 INFO - ##### 12:17:28 INFO - ##### Running download-and-extract step. 12:17:28 INFO - ##### 12:17:28 INFO - Running pre-action listener: _resource_record_pre_action 12:17:28 INFO - Running main action method: download_and_extract 12:17:28 INFO - mkdir: /builds/slave/test/build/tests 12:17: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')]} 12:17:28 INFO - https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:30 INFO - Downloaded 1361 bytes. 12:17:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:17:30 INFO - Using the following test package requirements: 12:17:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:17:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'jsshell-linux-x86_64.zip'], 12:17:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:17:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:17:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:30 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')]} 12:17:30 INFO - https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:32 INFO - Downloaded 24221220 bytes. 12:17:32 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'] 12:17:32 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 12:17:33 INFO - Return code: 0 12:17:33 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 12:17:33 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')]} 12:17:33 INFO - https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:17:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:17:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:34 INFO - Downloaded 24221220 bytes. 12:17:34 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'] 12:17:34 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 12:17:36 INFO - Return code: 0 12:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:36 INFO - https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:37 INFO - Downloaded 14405384 bytes. 12:17:37 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'] 12:17:37 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 12:17:37 INFO - Return code: 0 12:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:37 INFO - https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bam9AA-tTcWzhbugyNCTBg/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 12:17:39 INFO - Downloaded 60108447 bytes. 12:17:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:17:39 INFO - mkdir: /builds/slave/test/properties 12:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:39 INFO - Contents: 12:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:17:40 INFO - Running post-action listener: _resource_record_post_action 12:17:40 INFO - Running post-action listener: set_extra_try_arguments 12:17:40 INFO - ##### 12:17:40 INFO - ##### Finished download-and-extract step (success) 12:17:40 INFO - ##### 12:17:40 INFO - ##### 12:17:40 INFO - ##### Running populate-webroot step. 12:17:40 INFO - ##### 12:17:40 INFO - Running pre-action listener: _resource_record_pre_action 12:17:40 INFO - Running main action method: populate_webroot 12:17:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:40 INFO - '--tppagecycles', 12:17:40 INFO - '7'], 12:17:40 INFO - 'tests': ['tsvgm']}}, 12:17:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:17:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:17:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['damp', 'tps']}, 12:17:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['damp', 'tps']}, 12:17:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['dromaeo_dom']}, 12:17:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['basic_compositor_video']}, 12:17:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:17:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['a11yr', 12:17:40 INFO - 'ts_paint', 12:17:40 INFO - 'tpaint', 12:17:40 INFO - 'sessionrestore', 12:17:40 INFO - 'sessionrestore_no_auto_restore', 12:17:40 INFO - 'tabpaint']}, 12:17:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tsvgx', 12:17:40 INFO - 'tsvgr_opacity', 12:17:40 INFO - 'tart', 12:17:40 INFO - 'tscrollx', 12:17:40 INFO - 'cart']}, 12:17:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:17:40 INFO - 'tsvgr_opacity', 12:17:40 INFO - 'tart', 12:17:40 INFO - 'tscrollx', 12:17:40 INFO - 'cart']}, 12:17:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s'], 12:17:40 INFO - 'tests': ['tp5o']}, 12:17:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'tests': ['tp5o']}, 12:17:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--disable-e10s', 12:17:40 INFO - '--xperf_path', 12:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:40 INFO - 'tests': ['tp5n']}, 12:17:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:40 INFO - 'talos_options': ['--xperf_path', 12:17:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:40 INFO - 'tests': ['tp5n']}}, 12:17:40 INFO - 'talos.zip': {'path': '', 12:17:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:40 INFO - Running post-action listener: _resource_record_post_action 12:17:40 INFO - ##### 12:17:40 INFO - ##### Finished populate-webroot step (success) 12:17:40 INFO - ##### 12:17:40 INFO - ##### 12:17:40 INFO - ##### Running create-virtualenv step. 12:17:40 INFO - ##### 12:17:40 INFO - Running pre-action listener: _resource_record_pre_action 12:17:40 INFO - Running main action method: create_virtualenv 12:17:40 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:40 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 12:17:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:40 INFO - Using real prefix '/usr' 12:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:43 INFO - Installing pip.................done. 12:17:43 INFO - Return code: 0 12:17:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:43 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 12:17:43 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 12:17:43 INFO - Using env: {'DISPLAY': ':0', 12:17:43 INFO - 'HOME': '/home/cltbld', 12:17:43 INFO - 'LANG': 'en_US.UTF-8', 12:17:43 INFO - 'LANGUAGE': 'en_US:en', 12:17:43 INFO - 'LOGNAME': 'cltbld', 12:17:43 INFO - 'MAIL': '/var/mail/cltbld', 12:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:43 INFO - 'MOZ_NO_REMOTE': '1', 12:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:43 INFO - 'NO_EM_RESTART': '1', 12:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:43 INFO - 'PWD': '/builds/slave/test', 12:17:43 INFO - 'SHELL': '/bin/bash', 12:17:43 INFO - 'SHLVL': '1', 12:17:43 INFO - 'TERM': 'linux', 12:17:43 INFO - 'TMOUT': '86400', 12:17:43 INFO - 'USER': 'cltbld', 12:17:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:43 INFO - '_': '/tools/buildbot/bin/python'} 12:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:43 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 12:17:43 INFO - Cleaning up... 12:17:43 INFO - Return code: 0 12:17:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:43 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:43 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 12:17:43 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 12:17:43 INFO - Using env: {'DISPLAY': ':0', 12:17:43 INFO - 'HOME': '/home/cltbld', 12:17:43 INFO - 'LANG': 'en_US.UTF-8', 12:17:43 INFO - 'LANGUAGE': 'en_US:en', 12:17:43 INFO - 'LOGNAME': 'cltbld', 12:17:43 INFO - 'MAIL': '/var/mail/cltbld', 12:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:43 INFO - 'MOZ_NO_REMOTE': '1', 12:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:43 INFO - 'NO_EM_RESTART': '1', 12:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:43 INFO - 'PWD': '/builds/slave/test', 12:17:43 INFO - 'SHELL': '/bin/bash', 12:17:43 INFO - 'SHLVL': '1', 12:17:43 INFO - 'TERM': 'linux', 12:17:43 INFO - 'TMOUT': '86400', 12:17:43 INFO - 'USER': 'cltbld', 12:17:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:43 INFO - '_': '/tools/buildbot/bin/python'} 12:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:43 INFO - Downloading/unpacking psutil>=3.1.1 12:17:43 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 12:17:43 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 12:17:43 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 12:17:43 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 12:17:43 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 12:17:43 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 12:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:45 INFO - Installing collected packages: psutil 12:17:45 INFO - Running setup.py install for psutil 12:17:45 INFO - building 'psutil._psutil_linux' extension 12:17:45 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 12:17:45 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 12:17:45 INFO - building 'psutil._psutil_posix' extension 12:17:45 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 12:17:46 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 12:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:46 INFO - Successfully installed psutil 12:17:46 INFO - Cleaning up... 12:17:46 INFO - Return code: 0 12:17:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:46 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:46 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 12:17:46 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 12:17:46 INFO - Using env: {'DISPLAY': ':0', 12:17:46 INFO - 'HOME': '/home/cltbld', 12:17:46 INFO - 'LANG': 'en_US.UTF-8', 12:17:46 INFO - 'LANGUAGE': 'en_US:en', 12:17:46 INFO - 'LOGNAME': 'cltbld', 12:17:46 INFO - 'MAIL': '/var/mail/cltbld', 12:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:46 INFO - 'MOZ_NO_REMOTE': '1', 12:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:46 INFO - 'NO_EM_RESTART': '1', 12:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:46 INFO - 'PWD': '/builds/slave/test', 12:17:46 INFO - 'SHELL': '/bin/bash', 12:17:46 INFO - 'SHLVL': '1', 12:17:46 INFO - 'TERM': 'linux', 12:17:46 INFO - 'TMOUT': '86400', 12:17:46 INFO - 'USER': 'cltbld', 12:17:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:46 INFO - '_': '/tools/buildbot/bin/python'} 12:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:46 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 12:17:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:17:48 INFO - Installing collected packages: mozsystemmonitor 12:17:48 INFO - Running setup.py install for mozsystemmonitor 12:17:48 INFO - Successfully installed mozsystemmonitor 12:17:48 INFO - Cleaning up... 12:17:48 INFO - Return code: 0 12:17:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:48 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:48 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 12:17:48 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 12:17:48 INFO - Using env: {'DISPLAY': ':0', 12:17:48 INFO - 'HOME': '/home/cltbld', 12:17:48 INFO - 'LANG': 'en_US.UTF-8', 12:17:48 INFO - 'LANGUAGE': 'en_US:en', 12:17:48 INFO - 'LOGNAME': 'cltbld', 12:17:48 INFO - 'MAIL': '/var/mail/cltbld', 12:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:48 INFO - 'MOZ_NO_REMOTE': '1', 12:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:48 INFO - 'NO_EM_RESTART': '1', 12:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:48 INFO - 'PWD': '/builds/slave/test', 12:17:48 INFO - 'SHELL': '/bin/bash', 12:17:48 INFO - 'SHLVL': '1', 12:17:48 INFO - 'TERM': 'linux', 12:17:48 INFO - 'TMOUT': '86400', 12:17:48 INFO - 'USER': 'cltbld', 12:17:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:48 INFO - '_': '/tools/buildbot/bin/python'} 12:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:48 INFO - Downloading/unpacking jsonschema==2.5.1 12:17:48 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 12:17:48 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 12:17:48 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 12:17:48 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 12:17:48 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 12:17:48 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 12:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:17:50 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 12:17:50 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 12:17:50 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 12:17:50 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 12:17:50 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 12:17:50 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 12:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:50 INFO - warning: no files found matching '*.txt' 12:17:50 INFO - no previously-included directories found matching 'build' 12:17:50 INFO - no previously-included directories found matching 'dist' 12:17:50 INFO - no previously-included directories found matching '.git*' 12:17:50 INFO - Installing collected packages: jsonschema, functools32 12:17:50 INFO - Running setup.py install for functools32 12:17:50 INFO - warning: no files found matching '*.txt' 12:17:50 INFO - no previously-included directories found matching 'build' 12:17:50 INFO - no previously-included directories found matching 'dist' 12:17:50 INFO - no previously-included directories found matching '.git*' 12:17:51 INFO - Successfully installed jsonschema functools32 12:17:51 INFO - Cleaning up... 12:17:51 INFO - Return code: 0 12:17:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:51 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 12:17:51 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 12:17:51 INFO - Using env: {'DISPLAY': ':0', 12:17:51 INFO - 'HOME': '/home/cltbld', 12:17:51 INFO - 'LANG': 'en_US.UTF-8', 12:17:51 INFO - 'LANGUAGE': 'en_US:en', 12:17:51 INFO - 'LOGNAME': 'cltbld', 12:17:51 INFO - 'MAIL': '/var/mail/cltbld', 12:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:51 INFO - 'MOZ_NO_REMOTE': '1', 12:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:51 INFO - 'NO_EM_RESTART': '1', 12:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:51 INFO - 'PWD': '/builds/slave/test', 12:17:51 INFO - 'SHELL': '/bin/bash', 12:17:51 INFO - 'SHLVL': '1', 12:17:51 INFO - 'TERM': 'linux', 12:17:51 INFO - 'TMOUT': '86400', 12:17:51 INFO - 'USER': 'cltbld', 12:17:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:51 INFO - '_': '/tools/buildbot/bin/python'} 12:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:51 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:51 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 12:17:51 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 12:17:51 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 12:17:51 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 12:17:51 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 12:17:51 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 12:17:53 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 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 12:17:53 INFO - Downloading docopt-0.6.1.tar.gz 12:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:53 INFO - Running setup.py install for blobuploader 12:17:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:54 INFO - Running setup.py install for requests 12:17:54 INFO - Running setup.py install for docopt 12:17:54 INFO - Successfully installed blobuploader requests docopt 12:17:54 INFO - Cleaning up... 12:17:54 INFO - Return code: 0 12:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:54 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')]} 12:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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')]} 12:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:54 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 12:17:54 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 12:17:54 INFO - Using env: {'DISPLAY': ':0', 12:17:54 INFO - 'HOME': '/home/cltbld', 12:17:54 INFO - 'LANG': 'en_US.UTF-8', 12:17:54 INFO - 'LANGUAGE': 'en_US:en', 12:17:54 INFO - 'LOGNAME': 'cltbld', 12:17:54 INFO - 'MAIL': '/var/mail/cltbld', 12:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:54 INFO - 'MOZ_NO_REMOTE': '1', 12:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:54 INFO - 'NO_EM_RESTART': '1', 12:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:54 INFO - 'PWD': '/builds/slave/test', 12:17:54 INFO - 'SHELL': '/bin/bash', 12:17:54 INFO - 'SHLVL': '1', 12:17:54 INFO - 'TERM': 'linux', 12:17:54 INFO - 'TMOUT': '86400', 12:17:54 INFO - 'USER': 'cltbld', 12:17:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:54 INFO - '_': '/tools/buildbot/bin/python'} 12:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 INFO - Running setup.py (path:/tmp/pip-kni8bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 INFO - Running setup.py (path:/tmp/pip-wBQucz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 INFO - Running setup.py (path:/tmp/pip-sk2yyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:54 INFO - Running setup.py (path:/tmp/pip-IfC76N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:55 INFO - Running setup.py (path:/tmp/pip-Ryj4_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Running setup.py (path:/tmp/pip-GauvaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Running setup.py (path:/tmp/pip-IOxm9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Running setup.py (path:/tmp/pip-5zLwKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Running setup.py (path:/tmp/pip-qhtiXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Running setup.py (path:/tmp/pip-RM34tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Running setup.py (path:/tmp/pip-RuF6u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Running setup.py (path:/tmp/pip-fxKGc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 INFO - Running setup.py (path:/tmp/pip-nGdRwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 INFO - Running setup.py (path:/tmp/pip-VRTml7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 INFO - Running setup.py (path:/tmp/pip-BryWic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:55 INFO - Running setup.py (path:/tmp/pip-rTUa4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:55 INFO - Running setup.py (path:/tmp/pip-oavZ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:55 INFO - Running setup.py install for manifestparser 12:17:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozcrash 12:17:56 INFO - Running setup.py install for mozdebug 12:17:56 INFO - Running setup.py install for mozdevice 12:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozfile 12:17:56 INFO - Running setup.py install for mozhttpd 12:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozinfo 12:17:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozInstall 12:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:56 INFO - Running setup.py install for mozleak 12:17:56 INFO - Running setup.py install for mozlog 12:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for moznetwork 12:17:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozprocess 12:17:57 INFO - Running setup.py install for mozprofile 12:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozrunner 12:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Running setup.py install for mozscreenshot 12:17:57 INFO - Running setup.py install for moztest 12:17:57 INFO - Running setup.py install for mozversion 12:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:17:57 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 12:17:57 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 12:17:57 INFO - Using env: {'DISPLAY': ':0', 12:17:57 INFO - 'HOME': '/home/cltbld', 12:17:57 INFO - 'LANG': 'en_US.UTF-8', 12:17:57 INFO - 'LANGUAGE': 'en_US:en', 12:17:57 INFO - 'LOGNAME': 'cltbld', 12:17:57 INFO - 'MAIL': '/var/mail/cltbld', 12:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:57 INFO - 'MOZ_NO_REMOTE': '1', 12:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:57 INFO - 'NO_EM_RESTART': '1', 12:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:57 INFO - 'PWD': '/builds/slave/test', 12:17:57 INFO - 'SHELL': '/bin/bash', 12:17:57 INFO - 'SHLVL': '1', 12:17:57 INFO - 'TERM': 'linux', 12:17:57 INFO - 'TMOUT': '86400', 12:17:57 INFO - 'USER': 'cltbld', 12:17:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:57 INFO - '_': '/tools/buildbot/bin/python'} 12:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:57 INFO - Running setup.py (path:/tmp/pip-wbK9WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:58 INFO - Running setup.py (path:/tmp/pip-a0uTPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 INFO - Running setup.py (path:/tmp/pip-FQ0YLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 INFO - Running setup.py (path:/tmp/pip-lt_eF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:58 INFO - Running setup.py (path:/tmp/pip-vnuVXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 INFO - Running setup.py (path:/tmp/pip-j8iQQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Running setup.py (path:/tmp/pip-hC7NPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Running setup.py (path:/tmp/pip-fzicwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Running setup.py (path:/tmp/pip-gMygCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:58 INFO - Running setup.py (path:/tmp/pip-c1e0lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 INFO - Running setup.py (path:/tmp/pip-FWlXFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 INFO - Running setup.py (path:/tmp/pip-ktr3x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 INFO - Running setup.py (path:/tmp/pip-uadzq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 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)) 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:58 INFO - Running setup.py (path:/tmp/pip-pPPNII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:59 INFO - Running setup.py (path:/tmp/pip-NEfIk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:59 INFO - Running setup.py (path:/tmp/pip-muJuzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:59 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)) 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Running setup.py (path:/tmp/pip-CT_4Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:59 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)) 12:17:59 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)) 12:17:59 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)) 12:17:59 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)) 12:17:59 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)) 12:17:59 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)) 12:17:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:59 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 12:17:59 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 12:17:59 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 12:17:59 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 12:17:59 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 12:17:59 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 12:18:01 INFO - Downloading blessings-1.6.tar.gz 12:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:01 INFO - Installing collected packages: blessings 12:18:01 INFO - Running setup.py install for blessings 12:18:01 INFO - Successfully installed blessings 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:01 INFO - Reading from file tmpfile_stdout 12:18:01 INFO - Current package versions: 12:18:01 INFO - argparse == 1.2.1 12:18:01 INFO - blessings == 1.6 12:18:01 INFO - blobuploader == 1.2.4 12:18:01 INFO - docopt == 0.6.1 12:18:01 INFO - functools32 == 3.2.3-2 12:18:01 INFO - jsonschema == 2.5.1 12:18:01 INFO - manifestparser == 1.1 12:18:01 INFO - mozInstall == 1.12 12:18:01 INFO - mozcrash == 0.17 12:18:01 INFO - mozdebug == 0.1 12:18:01 INFO - mozdevice == 0.48 12:18:01 INFO - mozfile == 1.2 12:18:01 INFO - mozhttpd == 0.7 12:18:01 INFO - mozinfo == 0.9 12:18:01 INFO - mozleak == 0.1 12:18:01 INFO - mozlog == 3.2 12:18:01 INFO - moznetwork == 0.27 12:18:01 INFO - mozprocess == 0.22 12:18:01 INFO - mozprofile == 0.28 12:18:01 INFO - mozrunner == 6.11 12:18:01 INFO - mozscreenshot == 0.1 12:18:01 INFO - mozsystemmonitor == 0.3 12:18:01 INFO - moztest == 0.7 12:18:01 INFO - mozversion == 1.4 12:18:01 INFO - psutil == 3.1.1 12:18:01 INFO - requests == 1.2.3 12:18:01 INFO - wsgiref == 0.1.2 12:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:01 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')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:18:01 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 12:18:01 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 12:18:01 INFO - Using env: {'DISPLAY': ':0', 12:18:01 INFO - 'HOME': '/home/cltbld', 12:18:01 INFO - 'LANG': 'en_US.UTF-8', 12:18:01 INFO - 'LANGUAGE': 'en_US:en', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MAIL': '/var/mail/cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SHLVL': '1', 12:18:01 INFO - 'TERM': 'linux', 12:18:01 INFO - 'TMOUT': '86400', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - '_': '/tools/buildbot/bin/python'} 12:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 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)) 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:01 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')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:18:01 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 12:18:01 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 12:18:01 INFO - Using env: {'DISPLAY': ':0', 12:18:01 INFO - 'HOME': '/home/cltbld', 12:18:01 INFO - 'LANG': 'en_US.UTF-8', 12:18:01 INFO - 'LANGUAGE': 'en_US:en', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MAIL': '/var/mail/cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SHLVL': '1', 12:18:01 INFO - 'TERM': 'linux', 12:18:01 INFO - 'TMOUT': '86400', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - '_': '/tools/buildbot/bin/python'} 12:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:18:02 INFO - Cleaning up... 12:18:02 INFO - Return code: 0 12:18:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f176c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11880f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, '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': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', '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 12:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:18:02 INFO - Using env: {'DISPLAY': ':0', 12:18:02 INFO - 'HOME': '/home/cltbld', 12:18:02 INFO - 'LANG': 'en_US.UTF-8', 12:18:02 INFO - 'LANGUAGE': 'en_US:en', 12:18:02 INFO - 'LOGNAME': 'cltbld', 12:18:02 INFO - 'MAIL': '/var/mail/cltbld', 12:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:02 INFO - 'MOZ_NO_REMOTE': '1', 12:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:02 INFO - 'NO_EM_RESTART': '1', 12:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:02 INFO - 'PWD': '/builds/slave/test', 12:18:02 INFO - 'SHELL': '/bin/bash', 12:18:02 INFO - 'SHLVL': '1', 12:18:02 INFO - 'TERM': 'linux', 12:18:02 INFO - 'TMOUT': '86400', 12:18:02 INFO - 'USER': 'cltbld', 12:18:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:02 INFO - '_': '/tools/buildbot/bin/python'} 12:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:02 INFO - Downloading/unpacking flake8 12:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:18:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:18:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:04 INFO - no previously-included directories found matching 'docs/_build' 12:18:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:18:04 INFO - Running setup.py install for pep8 12:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:18:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:18:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:18:05 INFO - no previously-included directories found matching 'docs/_build' 12:18:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:18:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:18:05 INFO - Cleaning up... 12:18:05 INFO - Return code: 0 12:18:05 INFO - Running post-action listener: _resource_record_post_action 12:18:05 INFO - Running post-action listener: _start_resource_monitoring 12:18:05 INFO - Starting resource monitoring. 12:18:05 INFO - ##### 12:18:05 INFO - ##### Finished create-virtualenv step (success) 12:18:05 INFO - ##### 12:18:05 INFO - ##### 12:18:05 INFO - ##### Running install step. 12:18:05 INFO - ##### 12:18:05 INFO - Running pre-action listener: _resource_record_pre_action 12:18:05 INFO - Running main action method: install 12:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:05 INFO - Reading from file tmpfile_stdout 12:18:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:05 INFO - Reading from file tmpfile_stdout 12:18:05 INFO - Output received: 12:18:05 INFO - Usage: mozinstall [options] installer 12:18:05 INFO - Options: 12:18:05 INFO - -h, --help show this help message and exit 12:18:05 INFO - -d DEST, --destination=DEST 12:18:05 INFO - Directory to install application into. [default: 12:18:05 INFO - "/builds/slave/test"] 12:18:05 INFO - --app=APP Application being installed. [default: firefox] 12:18:05 INFO - mkdir: /builds/slave/test/build/application 12:18:05 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'] 12:18:05 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 12:18:22 INFO - Reading from file tmpfile_stdout 12:18:22 INFO - Output received: 12:18:22 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:22 INFO - Running post-action listener: _resource_record_post_action 12:18:22 INFO - ##### 12:18:22 INFO - ##### Finished install step (success) 12:18:22 INFO - ##### 12:18:22 INFO - ##### 12:18:22 INFO - ##### Running run-tests step. 12:18:22 INFO - ##### 12:18:22 INFO - Running pre-action listener: _resource_record_pre_action 12:18:22 INFO - Running main action method: run_tests 12:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:22 INFO - Python 2.7.3 12:18:22 INFO - Return code: 0 12:18:22 INFO - grabbing minidump binary from tooltool 12:18:22 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')]} 12:18:22 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 0x121a050>, '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 0x1186170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1186620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:22 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 12:18:22 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 12:18:22 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 12:18:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:22 INFO - Return code: 0 12:18:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:18:23 INFO - Return code: 0 12:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:18:23 INFO - Using env: {'DISPLAY': ':0', 12:18:23 INFO - 'HOME': '/home/cltbld', 12:18:23 INFO - 'LANG': 'en_US.UTF-8', 12:18:23 INFO - 'LANGUAGE': 'en_US:en', 12:18:23 INFO - 'LOGNAME': 'cltbld', 12:18:23 INFO - 'MAIL': '/var/mail/cltbld', 12:18:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:23 INFO - 'MOZ_NO_REMOTE': '1', 12:18:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:23 INFO - 'NO_EM_RESTART': '1', 12:18:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:23 INFO - 'PWD': '/builds/slave/test', 12:18:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:23 INFO - 'SHELL': '/bin/bash', 12:18:23 INFO - 'SHLVL': '1', 12:18:23 INFO - 'TERM': 'linux', 12:18:23 INFO - 'TMOUT': '86400', 12:18:23 INFO - 'USER': 'cltbld', 12:18:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423', 12:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:23 INFO - '_': '/tools/buildbot/bin/python'} 12:18:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:18:23 INFO - mozversion application_buildid: 20160616093554 12:18:23 INFO - mozversion application_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:18:23 INFO - mozversion application_display_name: Nightly 12:18:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:23 INFO - mozversion application_name: Firefox 12:18:23 INFO - mozversion application_remotingname: firefox 12:18:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:18:23 INFO - mozversion application_vendor: Mozilla 12:18:23 INFO - mozversion application_version: 50.0a1 12:18:23 INFO - mozversion platform_buildid: 20160616093554 12:18:23 INFO - mozversion platform_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:18:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:18:23 INFO - mozversion platform_version: 50.0a1 12:18:23 INFO - using testdate: 1466104703 12:18:23 INFO - actual date: 1466104703 12:18:23 INFO - starting webserver on 'localhost:56955' 12:18:23 INFO - SUITE-START | Running 2 tests 12:18:23 INFO - TEST-START | dromaeo_css 12:18:23 INFO - operating with platform_type : linux_ 12:18:23 INFO - Initialising browser for dromaeo_css test... 12:18:23 INFO - TEST-INFO | started process 30871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp58A73p/profile http://localhost:56955/getInfo.html) 12:18:28 INFO - PROCESS | 30871 | __metrics Screen width/height:1600/1200 12:18:28 INFO - PROCESS | 30871 | colorDepth:24 12:18:28 INFO - PROCESS | 30871 | Browser inner width/height: 1024/697 12:18:28 INFO - PROCESS | 30871 | __metrics 12:18:28 ERROR - PROCESS | 30871 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:18:29 INFO - TEST-INFO | 30871: exit 0 12:18:29 INFO - Browser initialized. 12:18:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:29 INFO - TEST-INFO | started process 30988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp58A73p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:41 INFO - PROCESS | 30988 | RSS: Main: 184987648 12:18:41 INFO - PROCESS | 30988 | 12:19:31 INFO - PROCESS | 30988 | 1466104771341 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] 12:21:39 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56955/tests/dromaeo/cssquery-ext.html) 12:21:40 INFO - PROCESS | 30988 | RSS: Main: 189440000 12:21:40 INFO - PROCESS | 30988 | 12:24:42 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-ext.html (next: http://localhost:56955/tests/dromaeo/cssquery-jquery.html) 12:24:43 INFO - PROCESS | 30988 | RSS: Main: 187867136 12:24:43 INFO - PROCESS | 30988 | 12:27:45 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56955/tests/dromaeo/cssquery-mootools.html) 12:27:45 INFO - PROCESS | 30988 | RSS: Main: 189059072 12:27:45 INFO - PROCESS | 30988 | 12:30:47 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56955/tests/dromaeo/cssquery-prototype.html) 12:30:48 INFO - PROCESS | 30988 | RSS: Main: 187088896 12:30:48 INFO - PROCESS | 30988 | 12:33:50 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56955/tests/dromaeo/cssquery-yui.html) 12:33:51 INFO - PROCESS | 30988 | RSS: Main: 189194240 12:33:51 INFO - PROCESS | 30988 | 12:36:53 INFO - PROCESS | 30988 | Cycle 1(1): loaded http://localhost:56955/tests/dromaeo/cssquery-yui.html (next: http://localhost:56955/tests/dromaeo/cssquery-dojo.html) 12:36:54 INFO - PROCESS | 30988 | RSS: Main: 189849600 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | __start_tp_report 12:36:54 INFO - PROCESS | 30988 | _x_x_mozilla_page_load 12:36:54 INFO - PROCESS | 30988 | _x_x_mozilla_page_load_details 12:36:54 INFO - PROCESS | 30988 | |i|pagename|runs| 12:36:54 INFO - PROCESS | 30988 | |0;dojo.html;3123.156747678127;3153.2589841387285;3177.173934776959;3178.5550022996777;3190.2343437574973;5362.624616276862;5421;5467.835964921053;5510.779568817253;5530.419305972875;5336.4129945705945;5355.036093503168;5390.164524498699;5414.998225328317;5455.454454554542;4926.827561035365;4934.901301973959;5062.924056139161;5086.593072554187;5160.664556803815;4951.628627852908;5148.176291793314;5176.378834539842;5176.689398636075;5178.559822415099;4898;4949.4060712714345;4980.701157930535;5018.84943451697;5023.547880690737;4986.10250154972;5003.574696150795;5005.57452616528;5025.84922452327;5076.213186956028;4955.653104282702;4970.776315065831;4982.57648099912;4987.276844857475;5036.143855544567;5247.737613119367;5338;5359.866003349908;5390.595705322116;5437.075697131497;5774.2782152230975;5799;5802.738876750556;5823.388544202882;5826.155207494932;5797.652140871562;5856.76572937082;5857;5859.150423188614;5861.062230043215;5453.727313634303;5517.089680202762;5529.253550770634;5546.77812887488;5554.444555544454;6015.54883383748;6018.15745795589;6035.336113027563;6035.8792824143275;6036.366181550874;5599.0761524348845;5754.280714910637;5783.8554036149435;5799.4780469757925;5807.332156801937;5827.533797296206;5913.172155898092;5923.851903702442;5930.377310382434;5976;5589.916151257735;5788.681622510718;5866.472017518444;5870.26621672291;5879.265091863517;5702.486776190163;5815.854603634858;5843.415658434207;5887.676177810262;5906.202662640574;4452.109578084396;4511.70673906195;4512.932306015412;4550.726956382628;4555.658325625592;4001.0597509585223;4004.8998775030273;4027.0939038716056;4036.394540818842;4056.858009969696;5445.237666726662;5559.833205003856;5614.803481878114;5654.717264136777;5681.857953551112;5928.199693041471;5928.288605367384;5933.614315069507;5947.821565353046;5960.195373624505;5636.070048442043;5639.830805075854;5656.8020119295625;5665.943340566541;5672.858178545487;4838.540338667821;4898.975505122523;4929.704217746875;4942.4316203637045;4965.379327584052;6120.693965301717;6123.387661233841;6131;6137.048757442514;6165.475934545524;5896.970515147483;5960.880782384242;5964.463198311999;5966.820995370146;5975.790847320323;5872.0898260769645;6062.514998800174;6079.3008803988105;6109.2752254827155;6140.048292514667;5812.273465816773;5836.970815145897;5837.970810145922;5841.50347220474;5877.471027607536;5621.297337832771;5931.110333450017;5940.316863560746;5941.1088336749835;5948.494377977747;5582.497575218087;5594.468525490072;5596.216529685766;5613.550915926634;5666.943330566642;5634.352049514195;5687.260656114679;5700.25896633435;5702.201691763239;5722.17028530869;5547.11246200606;5628.183913332626;5633.6619802811965;5643.209950607001;5647.6893770843;5690.630109042899;5733.39799321082;5776.826695199151;5847.502962248256;5857.58996870215;5689.77240910359;5696.458836410535;5704.80033198836;5728.684922329312;5732.484076433141 12:36:54 INFO - PROCESS | 30988 | |1;ext.html;549.6619578958941;607.7207478258266;619.0961196652889;628.0391001767294;637.4931929116352;41385;43344.56655433449;43486.565134348646;47262;47312.0537589248;45164.548354516446;45746;45802.77098614502;45876.770616146954;45966.701664916785;8929.46423214606;9117.908820911773;9140.771480712969;9159.35884488086;9160.45037297761;8991.820163596723;9025.18773310402;9067.093290670946;9088.272938164931;9090.818183636324;9053.683121090764;9148.130927561871;9178.173964343208;9183.265338772882;9184.494852783095;9009.864852027193;9076.546172691373;9102.180803727662;9145.268378529701;9147.451152930778;9064.093590640883;9081.046490118508;9135.36052476327;9139.131782480654;9148.908510914873;42842;43180;43342.783286083686;43420.3486947696;43476.3478547822;3630.80030598317;3690.0774806298427;3711.740178187528;3721.3673675475234;3767.7174211934216;32292.192695182574;32493.51259731106;32504.512432313535;33207.33585328304;33316.1670958228;4244.93029935374;4393.824247030115;4425.734455932655;4450.243458612012;4457.353683715875;336148;340616;342031;343588;343855;57439.71280143572;57537.71231143901;57879;57945;58443.70778146167;34646.65353346484;62787.6860615694;63059;63122;63272.683636581525;15888.126153061461;16559.337626495046;16619.83380166183;16639.16804159787;16657.33370665184;12478.251304921734;12488.937555312164;12579.874201258053;12582.559610413591;12585.496580136693;19428.383607487893;19694.70457943132;19763.604727905647;19786.20855165806;19820.306289279804;7210.2789721027475;7220.43674495557;7328;7455.179930207672;7506.43701722373;1011.8785745710562;1067.69570672358;1129.824877144044;1142.6172232302272;1191.8569771627288;32698;32999.67000329966;33433.832830836174;33450;33818.49272260918;1096.5339730614457;1121.8822023687396;1133.0878642692712;1173.9823902641467;1216.288471244332;16653.91673041627;17281.913590432217;17352.39266625662;17511.912440437718;17606.2077206526;512497;521799;526450;527440;528058;58448;58843.70578147082;59087.40912590905;59161.70419147877;59201.40798591959;1261.161327717058;1339.3370281710615;1341.2757111159865;1342.2550484481012;1347.5216298213993;30274;32338;32451.837740811145;32510.67489325171;32688.182795430304;50592;51211.487885120674;51368.229476557135;51383.48616513787;51602.48397515977;325245;329941;331650;332140;332479;28612.713872861004;28737.56893646555;28975.42049159047;29026.274343140747;29110.854445727637;47775.52224477711;48803.77990550265;48816.755916220194;49259.75370123127;49896.50103498918;40715.1856962865;41243.38134928038;41412.792936035126;41712.3743143847;42279;41385.1722965533;41409.58590414057;41526.1694766109;42171.3674294892;42477.15045699007;41848.790756047245;42632.5736742641;42938.57061429346;43128.56871431371;43542.34686479642;35868.64131358653;38039.61960380361;38228.80885595554;38530.422043668805;38655.226895462496;29039.41921161607;29304.853475732485;29324;29669.554956675234;29747.702522974494 12:36:54 INFO - PROCESS | 30988 | |2;jquery.html;368.5025215958456;368.51540224604634;384.1951112419482;397.7176204894525;402.4707509624843;17230.161264569695;19669.213231470723;19708;19897.3035943742;19928.40214793557;18537.721934170964;18904.338348157817;19333.903330483365;19344.419667409966;19534.31629892954;5551.139573366125;5710.400407957167;5765.538756899438;5803.419658034184;5836.182934389189;5567.55459563236;5625.80309689161;5735.08238681811;5741.62679425836;5745.109508026242;5660.5471562274915;5668.149777533362;5721.856953576153;5726.3987281335485;5734.827955161331;5620.381758006616;5658.34928983164;5681.3466451358;5714.628549144334;5739.713014349287;5057.721825299607;5063;5131.615128865313;5153.149730294497;5159.613029022838;22406;22858.657120143213;22918;23421.180258690863;23439.4140146496;2400.1599440195964;2525.5580273452074;2550.885210165547;2719.456108778252;2990.6411230652243;14589.270536473134;14687.192204428753;14690.632734181625;14711.705765884622;14988.775168372484;1804.1971322761376;1886.2077927270443;1921.9039048047541;1954.5211423201265;1966.606678664273;60937.39062609361;70690.64654676746;79549;82590.17409825885;83995;10533.789324213472;10888.891111088946;10902.836457453144;11047.337159770439;11371.147163962736;15239.771403428957;15410.768838467431;15428.460003899809;15437.922810385877;15460.845391545941;7904.486208396436;8043.477173983672;8164.346852251806;8168.550729709923;8213.917860821435;7762.340201082859;7796.844063118706;7982.840343193104;8009.279164875189;8083.919160808434;4666.883327916829;4855.781489832966;4864.513548645178;4865.56209941107;4902.485239049848;1964.3517639179036;1967.1344608372272;1980.6026534294024;1984.5237143085556;2016.4051604776625;876.3558784293539;958.9664361747306;959.5586030425943;1023.7594165371132;1110.9222354435112;18162.72755908636;19793.802061979484;19810.40568782939;19977.300794472416;20014.69977950332;961.9759506012406;976.1605019683067;981.4552923127733;1003.7691330993912;1054.4569546683465;10515.737106572244;10831.404272764916;10852.643419572554;10859.619913302997;10973.890261097287;429112;435198;440890;441304;441423;94485.52757236308;94837.52581237188;95897;96909.51545242229;97189;978.7308490165261;991.6132708243935;1027;1041.6510468992972;1044.9634262800766;17348.739768903222;17416.912915435343;17507.82492175062;17635;17939.551511212325;30021.5496767553;31375;40429.641682429945;41787.582124179586;43734.12531749411;59300.70349648397;60269.698651506464;61113.388866112546;61169;61276.080858788046;8665.480071195749;8853.468791872509;8864;8910.925730622925;9147.131022552847;12554.497820087094;13198.802017969547;13699.520516781864;13957.371918263905;14008.159510429407;12263.448144833326;12298.631041068782;12406;12429.813552796535;12615.36923153857;10374.585016599553;11739.941300293443;11778.52885884555;12476.688082798002;12547.749045018865;12401.875981240071;12489.875101249234;12622.87377126217;12635.115541912346;12729.490820367082;8845.469271843709;8926.152015558511;9019;9084.818303633758;9134.680286190218;9277.257819374568;11649.650510484698;11735.413229338328;11901;12115.091368147248 12:36:54 INFO - PROCESS | 30988 | |3;mootools.html;1442.9711405771884;1455.4614792526763;1557.9454719084827;1673.0881669490127;1682.680290744759;7688.384929205664;8215.46599471034;8294.170582941702;8808.559572021406;8812.69155579554;8352.331813454924;8506.36202284828;8528.530930798803;8608.913910860889;8646.13538646135;2194.8792816395094;2223.7776222377715;2234.1510226114056;2238.4515793630585;2242;2198.923037693681;2218.5119273759747;2220.211824802196;2237.362351729749;2238.820894328458;2201.933941981735;2205.823534117275;2210.082815631511;2217.7227846519186;2222.100049479963;2140.4006878074088;2147.9892600537055;2153.364757396572;2155.892205389724;2162.513434477246;2161.524464617797;2173.3154056472163;2174.1738139507042;2189.025883481851;2190.7480639726477;8648.827023459558;8723.956380218058;8731.126887311282;8767.780805479913;8789.165029322205;4867.7079375237245;5054.797808087672;5077.619178561586;5079.136546787018;5081.110805609003;3199.696028877253;3297.72457004666;3325.933481330384;3417.1969587147;3421.0934102462866;1166.9788934682153;1175.6296766518606;1179.4928180882216;1204.9337286449243;1209.3167360441323;11837.053035757119;11863.762724745544;11863.940680296544;11879.227850189796;11891.583794567148;4162.334026555736;4252.022034931922;4275.144971005811;4337.631301339358;4374.737515749065;9970.152537034288;10009.499525023719;10034.69895903124;10120.089191972758;10142.239332050125;4970.105381031449;5031.52200540948;5041.873953151201;5043.798248070109;5058.519440653132;4032.4757781488806;4501.729896206238;4626.051659409813;4656.231721765938;4666.65000124992;3828.5022947017264;3856;3897.142628621699;3955.723099383073;3963.6432721055244;1220.45079714129;1226.4910062324213;1228.8095345221504;1235.3020543392954;1260.4580030586753;920.2408013388981;987.3187500624546;1010.282699283517;1018.0888105145852;1021.918246540275;5913.58604897653;5985.102234664748;6103.389661033861;6219.906701399483;6379.170707807955;930.2883294279746;958.5638534466801;991.7024892532212;1014.1633152649094;1069.2835800013854;4108;4250.55369186231;4306.590873866978;4312.913741725148;4337.7397356158735;10502.579896804195;10663.040326370508;10708.411037393018;10738.838917416246;10783.029527342576;10584.364938103738;10589.682309530726;10590.311629744043;10610;10631.362118272928;7658.119316278588;7777.222277772177;7868.921310786819;7881.369490440751;7963.084245311863;6008.310000896847;6168.1056246844855;6177.320494745664;6266.624002559861;6270.404311590391;9694.6122155113;9868.605255789687;9990.700278991642;10016.39901605906;10062.295639305179;9794.461304628314;10048.648297309559;10132.290739648153;10149.797004060025;10251.794964100825;7123.964380178066;7494.325510703845;7631.847363052819;7669.7315593953945;7763;8451.197136272045;8461.576921154041;8463;8505.277051450696;8513.40406171562;7516.398688105048;7568.318851303189;7692.615369231628;7789.532628042336;7807.180246074307;7411.444141689502;7493.063367079115;7545.358644515058;7568.356689681439;7579.469437139568;7083.82290442743;7126.643667816692;7153.928460715534;7172.282771722995;7182.245864184186;5051.2423136529815;5065.240213967934;5173.63784535094;5239.502247286502;5271.630985830955;5355.892882142413;5391.892162156813;5417.945820541901;5437.945620543744;5482.205080263419 12:36:54 INFO - PROCESS | 30988 | |4;prototype.html;316.55998162554056;318.93940151371226;322.74825636003925;326.4645980591829;328.70745036917134;5563.610547261694;5619.915701264485;5675.659460432366;5694.402087780781;5698.259226300575;5553.972230138854;5574.442555744424;5577.44225577442;5585.692786896719;5603.887922241563;4127.83488660454;4220.451341325624;4341.674374421915;4342.305231162999;4377.190219809346;4304.203722311367;4324.82700691972;4328.761918094504;4332.631726303252;4349.1301739652035;4305.655547556204;4333.761643109643;4351.108022855307;4356.150550642626;4362.650987920959;4262.5950534699305;4267.869014711119;4340.631046361063;4356.455443069616;4365.650747940157;3823.847046118152;3826.827792749333;3841.615838416164;3843.6348546888003;3862.4592557042038;5344.839654810323;5477.561795056386;5498.697571633598;5501.817109321515;5525.668459892419;4875.926861097087;4943.615787579483;4967.875803104916;4969.627277954168;4978.9751051244875;5801;5813.82558523245;5817.7382017809305;5834.154047663107;5850.444207800295;4226.387173859804;4227.7463352198965;4234.06850492891;4236.830526778926;4253.21315556623;5865.76536938522;6116.174316467264;6132.632042077445;6158;6178.289496707891;4156.397322388237;4157;4164.500259968823;4192.790360481964;4200.684948628865;4155.688323375759;4195.958040419618;4197.265478541243;4199.286121359376;4202.62176404119;4728.8300641904425;4808.735519546389;4846.854594362175;4877.780499877514;4925.2761533463;5845.327787304429;5879.706014699248;5910.527157827363;5965.552583556164;6000.33996260411;1448.8116544849313;1456.8106146201137;1459.4454107439105;1463.5024091808623;1470.2060887120836;920.1028996728137;923.2014307623991;923.2521657457481;925.5696101312922;937.9682349415589;5021.598272138293;5060.696358218519;5067.442581316052;5067.467915868854;5083.2375143727995;5274.492462512463;5276.551493123051;5334;5344.839654810362;5365.839024829262;4860.635452341088;5070.923936140961;5136.021107757491;5164.2770012198325;5181.1969144782615;2849.492446646979;2863.7708983281286;2881.481333359973;2882.3370624756003;2896.52207385779;5393.595480338912;5435.293411856513;5491.890162196813;5536.785285885598;5552.833414997556;5178.741062946838;5366.812161574326;5430.8913821723345;5464.508194262536;5488.4785945335125;5508.7521061552325;5548.944510554924;5568.190338140121;5587.078132108238;5597.356304025007;5076.390833099904;5254.343207099113;5324.334458192726;5374.57003439716;5390.299261096033;5246.790128394821;5255.292030090312;5273.973630131978;5304.931076880097;5331.440198779227;5441.959265275522;5452;5468.972655136698;5509.752061157337;5519.39286678473;3683.5948045714413;3843.9807800960816;3848.3842585186235;3850.403187505941;3871.8064096794483;5397.27136836522;5433.619646624698;5433.673979561239;5811.651300921958;5922.792702255572;5824.417558244142;5863.618864773776;5887.911681324698;5896.14505896634;5901.734421951109;5791.305043394819;5869.794557190648;5947.791827286197;5986.281646202484;6002.0096684048385;5571.275734154534;5723.427657234243;5750.568707347049;5760.884782304414;5791.218185545066;5868.677222752619;5946.205283516741;5963.403659634176;5970.820875373745;6003.339632640319;5641.689707066151;5727.284089488814;5747.4252574742195;5797.681127537857;5828.2423284974375 12:36:54 INFO - PROCESS | 30988 | |5;yui.html;741.7181471041004;764.4610549562556;793.2900054451262;795.0102122857043;818.7257268814947;14406;15212.391504339841;15258.008229465091;15397.769033464507;15429.074255544661;14418.35117419716;14630.41478340865;14664.266786660677;14727.852721472782;14794.852051479482;665.9367360100782;794.2375319693101;807.3702512040588;823.0493779684444;824.3199360527559;803.4375936844203;806.4838503357855;817.0685418622775;817.8364327134567;818.6234332207192;853.6585365853678;854.5171977832536;858.0218550852034;858.0947100808644;859.5487369131225;851.3997631669658;854.1373213054859;854.3549620036863;854.5300084953251;856.1053698884649;618.6473709985311;618.8824123416537;621.2203684376125;622.5113286070413;626.0890404461497;14694.485693000694;14817;14894.553163405115;14911.776323355158;14931.104133751902;14667.266636668232;15067.321970511353;15080.849191508054;15283.923580382138;15347.846521534753;11962.760744785142;12193.329366884818;12220.633380998495;12278.570250041295;12498.875011249953;3872.8644497442456;4020.396940458925;4033.294173519652;4068.2677118118727;4089.7750623715683;81389;81594.59202704008;81918;82113.17886821175;82392.76410853902;11175.44122793857;11408.486618102206;11478.426078696031;11610.175813791593;11656.592019279455;23138.3058508245;23277.185298514472;23387;23405;23512.412189695395;8657.870131948026;8678.739637810875;8789.648414063493;8862.246709029676;8989;4629.722216667011;4740.502247264057;4772.570468657768;4823.3729615150505;4928.186849169919;3408.3694516514524;3524.5770507538746;3546.929061418757;3550.3609350317192;3555;607.0863350657232;612.7977767336769;614.732591322776;619.1548536248079;626.6803929995735;640.916680831489;706.5584009993754;719.2016861283971;750.7222327738772;782.9725959591387;9806.460644664468;10120.443375614412;10121.544530496145;10351.275410721177;10519.26365154432;641.2817644238482;723.8298999735058;732.8827387617955;747.7644541969262;750.7147284032033;4889.437714662859;4933.950660493421;4995.950040499549;5010.799568017312;5032.295478632995;125754;125770;125920;128395;129723;74885;101085;102485;102564.48717756363;105551.02816260704;90776.09223907809;91243;93915.53042234745;95526.5223673891;96579.51710241544;9513.42919424809;9541.904580954379;9573.32986690925;9673.758156046155;9732.659356922473;45140.32289515725;45413.54586454093;55082;55832;56077.719611401684;69198.30801691918;73587;73694.63152684203;74998.62500687462;75785.24214758002;12974.221546707227;12990.675233119247;13168;13741.656458588615;13892.791608125684;14350.354234059283;14535.418583256975;14629.268536573341;14657.120572765669;14799;14076.366563504462;14296.070755400866;14306.642333941734;14895;14998.625034374229;13952.79070813959;13973.231472269123;14138.151710897379;14443.85556144425;14874.77687834705;13609.455621775414;14566.708665826412;14663.413463461342;14998.100113993196;15004.399824006918;11297.943510282395;11582.536698532302;11583.478743456397;11674.885627710597;11683.941580292045;11090.03847544141;11558.711032224262;12276.815847762113;12287.87712122903;12319.69200769988 12:36:54 INFO - PROCESS | 30988 | __end_tp_report 12:36:54 INFO - PROCESS | 30988 | __start_cc_report 12:36:54 INFO - PROCESS | 30988 | _x_x_mozilla_cycle_collect,341 12:36:54 INFO - PROCESS | 30988 | __end_cc_report 12:36:54 INFO - PROCESS | 30988 | __startTimestamp1466105814174__endTimestamp 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | ------- Summary: start ------- 12:36:54 INFO - PROCESS | 30988 | Number of tests: 6 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#0] dojo.html Cycles:165 Average:5451.95 Median:5647.69 stddev:620.70 (11.0%) stddev-sans-first:595.11 12:36:54 INFO - PROCESS | 30988 | Values: 3123.2 3153.3 3177.2 3178.6 3190.2 5362.6 5421.0 5467.8 5510.8 5530.4 5336.4 5355.0 5390.2 5415.0 5455.5 4926.8 4934.9 5062.9 5086.6 5160.7 4951.6 5148.2 5176.4 5176.7 5178.6 4898.0 4949.4 4980.7 5018.8 5023.5 4986.1 5003.6 5005.6 5025.8 5076.2 4955.7 4970.8 4982.6 4987.3 5036.1 5247.7 5338.0 5359.9 5390.6 5437.1 5774.3 5799.0 5802.7 5823.4 5826.2 5797.7 5856.8 5857.0 5859.2 5861.1 5453.7 5517.1 5529.3 5546.8 5554.4 6015.5 6018.2 6035.3 6035.9 6036.4 5599.1 5754.3 5783.9 5799.5 5807.3 5827.5 5913.2 5923.9 5930.4 5976.0 5589.9 5788.7 5866.5 5870.3 5879.3 5702.5 5815.9 5843.4 5887.7 5906.2 4452.1 4511.7 4512.9 4550.7 4555.7 4001.1 4004.9 4027.1 4036.4 4056.9 5445.2 5559.8 5614.8 5654.7 5681.9 5928.2 5928.3 5933.6 5947.8 5960.2 5636.1 5639.8 5656.8 5665.9 5672.9 4838.5 4899.0 4929.7 4942.4 4965.4 6120.7 6123.4 6131.0 6137.0 6165.5 5897.0 5960.9 5964.5 5966.8 5975.8 5872.1 6062.5 6079.3 6109.3 6140.0 5812.3 5837.0 5838.0 5841.5 5877.5 5621.3 5931.1 5940.3 5941.1 5948.5 5582.5 5594.5 5596.2 5613.6 5666.9 5634.4 5687.3 5700.3 5702.2 5722.2 5547.1 5628.2 5633.7 5643.2 5647.7 5690.6 5733.4 5776.8 5847.5 5857.6 5689.8 5696.5 5704.8 5728.7 5732.5 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#1] ext.html Cycles:180 Average:57059.01 Median:42225.18 stddev:107881.14 (255.5%) stddev-sans-first:108100.34 12:36:54 INFO - PROCESS | 30988 | Values: 549.7 607.7 619.1 628.0 637.5 41385.0 43344.6 43486.6 47262.0 47312.1 45164.5 45746.0 45802.8 45876.8 45966.7 8929.5 9117.9 9140.8 9159.4 9160.5 8991.8 9025.2 9067.1 9088.3 9090.8 9053.7 9148.1 9178.2 9183.3 9184.5 9009.9 9076.5 9102.2 9145.3 9147.5 9064.1 9081.0 9135.4 9139.1 9148.9 42842.0 43180.0 43342.8 43420.3 43476.3 3630.8 3690.1 3711.7 3721.4 3767.7 32292.2 32493.5 32504.5 33207.3 33316.2 4244.9 4393.8 4425.7 4450.2 4457.4 336148.0 340616.0 342031.0 343588.0 343855.0 57439.7 57537.7 57879.0 57945.0 58443.7 34646.7 62787.7 63059.0 63122.0 63272.7 15888.1 16559.3 16619.8 16639.2 16657.3 12478.3 12488.9 12579.9 12582.6 12585.5 19428.4 19694.7 19763.6 19786.2 19820.3 7210.3 7220.4 7328.0 7455.2 7506.4 1011.9 1067.7 1129.8 1142.6 1191.9 32698.0 32999.7 33433.8 33450.0 33818.5 1096.5 1121.9 1133.1 1174.0 1216.3 16653.9 17281.9 17352.4 17511.9 17606.2 512497.0 521799.0 526450.0 527440.0 528058.0 58448.0 58843.7 59087.4 59161.7 59201.4 1261.2 1339.3 1341.3 1342.3 1347.5 30274.0 32338.0 32451.8 32510.7 32688.2 50592.0 51211.5 51368.2 51383.5 51602.5 325245.0 329941.0 331650.0 332140.0 332479.0 28612.7 28737.6 28975.4 29026.3 29110.9 47775.5 48803.8 48816.8 49259.8 49896.5 40715.2 41243.4 41412.8 41712.4 42279.0 41385.2 41409.6 41526.2 42171.4 42477.2 41848.8 42632.6 42938.6 43128.6 43542.3 35868.6 38039.6 38228.8 38530.4 38655.2 29039.4 29304.9 29324.0 29669.6 29747.7 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#2] jquery.html Cycles:180 Average:27657.82 Median:16506.10 stddev:72457.24 (439.0%) stddev-sans-first:72631.53 12:36:54 INFO - PROCESS | 30988 | Values: 368.5 368.5 384.2 397.7 402.5 17230.2 19669.2 19708.0 19897.3 19928.4 18537.7 18904.3 19333.9 19344.4 19534.3 5551.1 5710.4 5765.5 5803.4 5836.2 5567.6 5625.8 5735.1 5741.6 5745.1 5660.5 5668.1 5721.9 5726.4 5734.8 5620.4 5658.3 5681.3 5714.6 5739.7 5057.7 5063.0 5131.6 5153.1 5159.6 22406.0 22858.7 22918.0 23421.2 23439.4 2400.2 2525.6 2550.9 2719.5 2990.6 14589.3 14687.2 14690.6 14711.7 14988.8 1804.2 1886.2 1921.9 1954.5 1966.6 60937.4 70690.6 79549.0 82590.2 83995.0 10533.8 10888.9 10902.8 11047.3 11371.1 15239.8 15410.8 15428.5 15437.9 15460.8 7904.5 8043.5 8164.3 8168.6 8213.9 7762.3 7796.8 7982.8 8009.3 8083.9 4666.9 4855.8 4864.5 4865.6 4902.5 1964.4 1967.1 1980.6 1984.5 2016.4 876.4 959.0 959.6 1023.8 1110.9 18162.7 19793.8 19810.4 19977.3 20014.7 962.0 976.2 981.5 1003.8 1054.5 10515.7 10831.4 10852.6 10859.6 10973.9 429112.0 435198.0 440890.0 441304.0 441423.0 94485.5 94837.5 95897.0 96909.5 97189.0 978.7 991.6 1027.0 1041.7 1045.0 17348.7 17416.9 17507.8 17635.0 17939.6 30021.5 31375.0 40429.6 41787.6 43734.1 59300.7 60269.7 61113.4 61169.0 61276.1 8665.5 8853.5 8864.0 8910.9 9147.1 12554.5 13198.8 13699.5 13957.4 14008.2 12263.4 12298.6 12406.0 12429.8 12615.4 10374.6 11739.9 11778.5 12476.7 12547.7 12401.9 12489.9 12622.9 12635.1 12729.5 8845.5 8926.2 9019.0 9084.8 9134.7 9277.3 11649.7 11735.4 11901.0 12115.1 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#3] mootools.html Cycles:180 Average:5699.48 Median:4438.23 stddev:3221.92 (72.6%) stddev-sans-first:3215.08 12:36:54 INFO - PROCESS | 30988 | Values: 1443.0 1455.5 1557.9 1673.1 1682.7 7688.4 8215.5 8294.2 8808.6 8812.7 8352.3 8506.4 8528.5 8608.9 8646.1 2194.9 2223.8 2234.2 2238.5 2242.0 2198.9 2218.5 2220.2 2237.4 2238.8 2201.9 2205.8 2210.1 2217.7 2222.1 2140.4 2148.0 2153.4 2155.9 2162.5 2161.5 2173.3 2174.2 2189.0 2190.7 8648.8 8724.0 8731.1 8767.8 8789.2 4867.7 5054.8 5077.6 5079.1 5081.1 3199.7 3297.7 3325.9 3417.2 3421.1 1167.0 1175.6 1179.5 1204.9 1209.3 11837.1 11863.8 11863.9 11879.2 11891.6 4162.3 4252.0 4275.1 4337.6 4374.7 9970.2 10009.5 10034.7 10120.1 10142.2 4970.1 5031.5 5041.9 5043.8 5058.5 4032.5 4501.7 4626.1 4656.2 4666.7 3828.5 3856.0 3897.1 3955.7 3963.6 1220.5 1226.5 1228.8 1235.3 1260.5 920.2 987.3 1010.3 1018.1 1021.9 5913.6 5985.1 6103.4 6219.9 6379.2 930.3 958.6 991.7 1014.2 1069.3 4108.0 4250.6 4306.6 4312.9 4337.7 10502.6 10663.0 10708.4 10738.8 10783.0 10584.4 10589.7 10590.3 10610.0 10631.4 7658.1 7777.2 7868.9 7881.4 7963.1 6008.3 6168.1 6177.3 6266.6 6270.4 9694.6 9868.6 9990.7 10016.4 10062.3 9794.5 10048.6 10132.3 10149.8 10251.8 7124.0 7494.3 7631.8 7669.7 7763.0 8451.2 8461.6 8463.0 8505.3 8513.4 7516.4 7568.3 7692.6 7789.5 7807.2 7411.4 7493.1 7545.4 7568.4 7579.5 7083.8 7126.6 7153.9 7172.3 7182.2 5051.2 5065.2 5173.6 5239.5 5271.6 5355.9 5391.9 5417.9 5437.9 5482.2 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#4] prototype.html Cycles:180 Average:4727.22 Median:5332.72 stddev:1382.32 (25.9%) stddev-sans-first:1345.97 12:36:54 INFO - PROCESS | 30988 | Values: 316.6 318.9 322.7 326.5 328.7 5563.6 5619.9 5675.7 5694.4 5698.3 5554.0 5574.4 5577.4 5585.7 5603.9 4127.8 4220.5 4341.7 4342.3 4377.2 4304.2 4324.8 4328.8 4332.6 4349.1 4305.7 4333.8 4351.1 4356.2 4362.7 4262.6 4267.9 4340.6 4356.5 4365.7 3823.8 3826.8 3841.6 3843.6 3862.5 5344.8 5477.6 5498.7 5501.8 5525.7 4875.9 4943.6 4967.9 4969.6 4979.0 5801.0 5813.8 5817.7 5834.2 5850.4 4226.4 4227.7 4234.1 4236.8 4253.2 5865.8 6116.2 6132.6 6158.0 6178.3 4156.4 4157.0 4164.5 4192.8 4200.7 4155.7 4196.0 4197.3 4199.3 4202.6 4728.8 4808.7 4846.9 4877.8 4925.3 5845.3 5879.7 5910.5 5965.6 6000.3 1448.8 1456.8 1459.4 1463.5 1470.2 920.1 923.2 923.3 925.6 938.0 5021.6 5060.7 5067.4 5067.5 5083.2 5274.5 5276.6 5334.0 5344.8 5365.8 4860.6 5070.9 5136.0 5164.3 5181.2 2849.5 2863.8 2881.5 2882.3 2896.5 5393.6 5435.3 5491.9 5536.8 5552.8 5178.7 5366.8 5430.9 5464.5 5488.5 5508.8 5548.9 5568.2 5587.1 5597.4 5076.4 5254.3 5324.3 5374.6 5390.3 5246.8 5255.3 5274.0 5304.9 5331.4 5442.0 5452.0 5469.0 5509.8 5519.4 3683.6 3844.0 3848.4 3850.4 3871.8 5397.3 5433.6 5433.7 5811.7 5922.8 5824.4 5863.6 5887.9 5896.1 5901.7 5791.3 5869.8 5947.8 5986.3 6002.0 5571.3 5723.4 5750.6 5760.9 5791.2 5868.7 5946.2 5963.4 5970.8 6003.3 5641.7 5727.3 5747.4 5797.7 5828.2 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - PROCESS | 30988 | [#5] yui.html Cycles:180 Average:21640.61 Median:4050.78 stddev:31630.92 (780.9%) stddev-sans-first:31680.73 12:36:54 INFO - PROCESS | 30988 | Values: 741.7 764.5 793.3 795.0 818.7 14406.0 15212.4 15258.0 15397.8 15429.1 14418.4 14630.4 14664.3 14727.9 14794.9 665.9 794.2 807.4 823.0 824.3 803.4 806.5 817.1 817.8 818.6 853.7 854.5 858.0 858.1 859.5 851.4 854.1 854.4 854.5 856.1 618.6 618.9 621.2 622.5 626.1 14694.5 14817.0 14894.6 14911.8 14931.1 14667.3 15067.3 15080.8 15283.9 15347.8 11962.8 12193.3 12220.6 12278.6 12498.9 3872.9 4020.4 4033.3 4068.3 4089.8 81389.0 81594.6 81918.0 82113.2 82392.8 11175.4 11408.5 11478.4 11610.2 11656.6 23138.3 23277.2 23387.0 23405.0 23512.4 8657.9 8678.7 8789.6 8862.2 8989.0 4629.7 4740.5 4772.6 4823.4 4928.2 3408.4 3524.6 3546.9 3550.4 3555.0 607.1 612.8 614.7 619.2 626.7 640.9 706.6 719.2 750.7 783.0 9806.5 10120.4 10121.5 10351.3 10519.3 641.3 723.8 732.9 747.8 750.7 4889.4 4934.0 4996.0 5010.8 5032.3 125754.0 125770.0 125920.0 128395.0 129723.0 74885.0 101085.0 102485.0 102564.5 105551.0 90776.1 91243.0 93915.5 95526.5 96579.5 9513.4 9541.9 9573.3 9673.8 9732.7 45140.3 45413.5 55082.0 55832.0 56077.7 69198.3 73587.0 73694.6 74998.6 75785.2 12974.2 12990.7 13168.0 13741.7 13892.8 14350.4 14535.4 14629.3 14657.1 14799.0 14076.4 14296.1 14306.6 14895.0 14998.6 13952.8 13973.2 14138.2 14443.9 14874.8 13609.5 14566.7 14663.4 14998.1 15004.4 11297.9 11582.5 11583.5 11674.9 11683.9 11090.0 11558.7 12276.8 12287.9 12319.7 12:36:54 INFO - PROCESS | 30988 | -------- Summary: end -------- 12:36:54 INFO - PROCESS | 30988 | 12:36:54 INFO - TEST-INFO | 30988: exit 0 12:36:54 INFO - TEST-OK | dromaeo_css | took 1111248ms 12:36:54 INFO - TEST-START | kraken 12:36:54 INFO - operating with platform_type : linux_ 12:36:54 INFO - Initialising browser for kraken test... 12:36:54 INFO - TEST-INFO | started process 31224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeTkFM/profile http://localhost:56955/getInfo.html) 12:36:59 INFO - PROCESS | 31224 | __metrics Screen width/height:1600/1200 12:36:59 INFO - PROCESS | 31224 | colorDepth:24 12:36:59 INFO - PROCESS | 31224 | Browser inner width/height: 1024/697 12:36:59 INFO - PROCESS | 31224 | __metrics 12:37:00 ERROR - PROCESS | 31224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:37:01 INFO - TEST-INFO | 31224: exit 0 12:37:01 INFO - Browser initialized. 12:37:01 INFO - Running cycle 1/1 for kraken test... 12:37:01 INFO - TEST-INFO | started process 31340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeTkFM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:13 INFO - PROCESS | 31340 | RSS: Main: 184651776 12:37:13 INFO - PROCESS | 31340 | 12:37:15 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56955/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:16 INFO - PROCESS | 31340 | RSS: Main: 190447616 12:37:16 INFO - PROCESS | 31340 | 12:37:19 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56955/tests/kraken/driver.html?testName=audio-dft) 12:37:19 INFO - PROCESS | 31340 | RSS: Main: 189509632 12:37:19 INFO - PROCESS | 31340 | 12:37:22 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56955/tests/kraken/driver.html?testName=audio-fft) 12:37:23 INFO - PROCESS | 31340 | RSS: Main: 184668160 12:37:23 INFO - PROCESS | 31340 | 12:37:25 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56955/tests/kraken/driver.html?testName=audio-oscillator) 12:37:26 INFO - PROCESS | 31340 | RSS: Main: 185249792 12:37:26 INFO - PROCESS | 31340 | 12:37:28 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:29 INFO - PROCESS | 31340 | RSS: Main: 185708544 12:37:29 INFO - PROCESS | 31340 | 12:37:32 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56955/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:32 INFO - PROCESS | 31340 | RSS: Main: 186130432 12:37:32 INFO - PROCESS | 31340 | 12:37:36 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56955/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:36 INFO - PROCESS | 31340 | RSS: Main: 186830848 12:37:36 INFO - PROCESS | 31340 | 12:37:39 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56955/tests/kraken/driver.html?testName=json-parse-financial) 12:37:40 INFO - PROCESS | 31340 | RSS: Main: 186593280 12:37:40 INFO - PROCESS | 31340 | 12:37:41 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:42 INFO - PROCESS | 31340 | RSS: Main: 186675200 12:37:42 INFO - PROCESS | 31340 | 12:37:44 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:44 INFO - PROCESS | 31340 | RSS: Main: 187183104 12:37:44 INFO - PROCESS | 31340 | 12:37:47 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:47 INFO - PROCESS | 31340 | RSS: Main: 186753024 12:37:47 INFO - PROCESS | 31340 | 12:37:50 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:50 INFO - PROCESS | 31340 | RSS: Main: 187166720 12:37:50 INFO - PROCESS | 31340 | 12:37:53 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:54 INFO - PROCESS | 31340 | RSS: Main: 186855424 12:37:54 INFO - PROCESS | 31340 | 12:37:55 INFO - PROCESS | 31340 | Cycle 1(1): loaded http://localhost:56955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56955/tests/kraken/driver.html?testName=ai-astar) 12:37:56 INFO - PROCESS | 31340 | RSS: Main: 187748352 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | __start_tp_report 12:37:56 INFO - PROCESS | 31340 | _x_x_mozilla_page_load 12:37:56 INFO - PROCESS | 31340 | _x_x_mozilla_page_load_details 12:37:56 INFO - PROCESS | 31340 | |i|pagename|runs| 12:37:56 INFO - PROCESS | 31340 | |0;ai-astar;112;107;112;111;111;112;109;114;110;111 12:37:56 INFO - PROCESS | 31340 | |1;audio-beat-detection;155;131;164;176;128;154;156;129;191;134 12:37:56 INFO - PROCESS | 31340 | |2;audio-dft;163;163;163;165;166;169;164;163;164;163 12:37:56 INFO - PROCESS | 31340 | |3;audio-fft;75;75;75;160;77;77;75;74;166;75 12:37:56 INFO - PROCESS | 31340 | |4;audio-oscillator;85;84;155;85;86;86;144;86;84;146 12:37:56 INFO - PROCESS | 31340 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;122;118 12:37:56 INFO - PROCESS | 31340 | |6;imaging-darkroom;147;147;147;147;149;147;148;147;147;147 12:37:56 INFO - PROCESS | 31340 | |7;imaging-desaturate;95;94;95;95;95;95;95;96;95;96 12:37:56 INFO - PROCESS | 31340 | |8;json-parse-financial;59;56;56;56;55;58;58;57;54;54 12:37:56 INFO - PROCESS | 31340 | |9;json-stringify-tinderbox;61;61;61;60;60;60;61;60;61;62 12:37:56 INFO - PROCESS | 31340 | |10;stanford-crypto-aes;78;78;80;81;80;81;81;87;107;82 12:37:56 INFO - PROCESS | 31340 | |11;stanford-crypto-ccm;127;121;135;120;129;123;131;128;126;145 12:37:56 INFO - PROCESS | 31340 | |12;stanford-crypto-pbkdf2;160;165;167;161;161;158;164;163;162;161 12:37:56 INFO - PROCESS | 31340 | |13;stanford-crypto-sha256-iterative;67;69;65;64;64;66;62;63;63;68 12:37:56 INFO - PROCESS | 31340 | __end_tp_report 12:37:56 INFO - PROCESS | 31340 | __start_cc_report 12:37:56 INFO - PROCESS | 31340 | _x_x_mozilla_cycle_collect,888 12:37:56 INFO - PROCESS | 31340 | __end_cc_report 12:37:56 INFO - PROCESS | 31340 | __startTimestamp1466105876243__endTimestamp 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | ------- Summary: start ------- 12:37:56 INFO - PROCESS | 31340 | Number of tests: 14 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.91 (1.7%) stddev-sans-first:1.99 12:37:56 INFO - PROCESS | 31340 | Values: 112.0 107.0 112.0 111.0 111.0 112.0 109.0 114.0 110.0 111.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:155.50 stddev:21.45 (13.8%) stddev-sans-first:22.72 12:37:56 INFO - PROCESS | 31340 | Values: 155.0 131.0 164.0 176.0 128.0 154.0 156.0 129.0 191.0 134.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:1.95 (1.2%) stddev-sans-first:2.01 12:37:56 INFO - PROCESS | 31340 | Values: 163.0 163.0 163.0 165.0 166.0 169.0 164.0 163.0 164.0 163.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:36.98 (49.3%) stddev-sans-first:38.66 12:37:56 INFO - PROCESS | 31340 | Values: 75.0 75.0 75.0 160.0 77.0 77.0 75.0 74.0 166.0 75.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:85.00 stddev:30.66 (36.1%) stddev-sans-first:31.73 12:37:56 INFO - PROCESS | 31340 | Values: 85.0 84.0 155.0 85.0 86.0 86.0 144.0 86.0 84.0 146.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.45 (1.2%) stddev-sans-first:1.54 12:37:56 INFO - PROCESS | 31340 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 122.0 118.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:37:56 INFO - PROCESS | 31340 | Values: 147.0 147.0 147.0 147.0 149.0 147.0 148.0 147.0 147.0 147.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:37:56 INFO - PROCESS | 31340 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.70 (3.0%) stddev-sans-first:1.50 12:37:56 INFO - PROCESS | 31340 | Values: 59.0 56.0 56.0 56.0 55.0 58.0 58.0 57.0 54.0 54.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 12:37:56 INFO - PROCESS | 31340 | Values: 61.0 61.0 61.0 60.0 60.0 60.0 61.0 60.0 61.0 62.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:81.00 stddev:8.63 (10.7%) stddev-sans-first:8.92 12:37:56 INFO - PROCESS | 31340 | Values: 78.0 78.0 80.0 81.0 80.0 81.0 81.0 87.0 107.0 82.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:128.50 stddev:7.37 (5.7%) stddev-sans-first:7.79 12:37:56 INFO - PROCESS | 31340 | Values: 127.0 121.0 135.0 120.0 129.0 123.0 131.0 128.0 126.0 145.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:2.62 (1.6%) stddev-sans-first:2.65 12:37:56 INFO - PROCESS | 31340 | Values: 160.0 165.0 167.0 161.0 161.0 158.0 164.0 163.0 162.0 161.0 12:37:56 INFO - PROCESS | 31340 | 12:37:56 INFO - PROCESS | 31340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:2.33 (3.6%) stddev-sans-first:2.37 12:37:56 INFO - PROCESS | 31340 | Values: 67.0 69.0 65.0 64.0 64.0 66.0 62.0 63.0 63.0 68.0 12:37:56 INFO - PROCESS | 31340 | -------- Summary: end -------- 12:37:56 INFO - PROCESS | 31340 | 12:37:57 INFO - TEST-INFO | 31340: exit 0 12:37:57 INFO - TEST-OK | kraken | took 62292ms 12:37:57 INFO - SUITE-END | took 1173s 12:37:57 INFO - Completed test suite (00:19:33) 12:37:57 INFO - javascript benchmark 12:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.720395588355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.156747678127, 3153.2589841387285, 3177.173934776959, 3178.5550022996777, 3190.2343437574973, 5362.624616276862, 5421.0, 5467.835964921053, 5510.779568817253, 5530.419305972875, 5336.4129945705945, 5355.036093503168, 5390.164524498699, 5414.998225328317, 5455.454454554542, 4926.827561035365, 4934.901301973959, 5062.924056139161, 5086.593072554187, 5160.664556803815, 4951.628627852908, 5148.176291793314, 5176.378834539842, 5176.689398636075, 5178.559822415099, 4898.0, 4949.4060712714345, 4980.701157930535, 5018.84943451697, 5023.547880690737, 4986.10250154972, 5003.574696150795, 5005.57452616528, 5025.84922452327, 5076.213186956028, 4955.653104282702, 4970.776315065831, 4982.57648099912, 4987.276844857475, 5036.143855544567, 5247.737613119367, 5338.0, 5359.866003349908, 5390.595705322116, 5437.075697131497, 5774.2782152230975, 5799.0, 5802.738876750556, 5823.388544202882, 5826.155207494932, 5797.652140871562, 5856.76572937082, 5857.0, 5859.150423188614, 5861.062230043215, 5453.727313634303, 5517.089680202762, 5529.253550770634, 5546.77812887488, 5554.444555544454, 6015.54883383748, 6018.15745795589, 6035.336113027563, 6035.8792824143275, 6036.366181550874, 5599.0761524348845, 5754.280714910637, 5783.8554036149435, 5799.4780469757925, 5807.332156801937, 5827.533797296206, 5913.172155898092, 5923.851903702442, 5930.377310382434, 5976.0, 5589.916151257735, 5788.681622510718, 5866.472017518444, 5870.26621672291, 5879.265091863517, 5702.486776190163, 5815.854603634858, 5843.415658434207, 5887.676177810262, 5906.202662640574, 4452.109578084396, 4511.70673906195, 4512.932306015412, 4550.726956382628, 4555.658325625592, 4001.0597509585223, 4004.8998775030273, 4027.0939038716056, 4036.394540818842, 4056.858009969696, 5445.237666726662, 5559.833205003856, 5614.803481878114, 5654.717264136777, 5681.857953551112, 5928.199693041471, 5928.288605367384, 5933.614315069507, 5947.821565353046, 5960.195373624505, 5636.070048442043, 5639.830805075854, 5656.8020119295625, 5665.943340566541, 5672.858178545487, 4838.540338667821, 4898.975505122523, 4929.704217746875, 4942.4316203637045, 4965.379327584052, 6120.693965301717, 6123.387661233841, 6131.0, 6137.048757442514, 6165.475934545524, 5896.970515147483, 5960.880782384242, 5964.463198311999, 5966.820995370146, 5975.790847320323, 5872.0898260769645, 6062.514998800174, 6079.3008803988105, 6109.2752254827155, 6140.048292514667, 5812.273465816773, 5836.970815145897, 5837.970810145922, 5841.50347220474, 5877.471027607536, 5621.297337832771, 5931.110333450017, 5940.316863560746, 5941.1088336749835, 5948.494377977747, 5582.497575218087, 5594.468525490072, 5596.216529685766, 5613.550915926634, 5666.943330566642, 5634.352049514195, 5687.260656114679, 5700.25896633435, 5702.201691763239, 5722.17028530869, 5547.11246200606, 5628.183913332626, 5633.6619802811965, 5643.209950607001, 5647.6893770843, 5690.630109042899, 5733.39799321082, 5776.826695199151, 5847.502962248256, 5857.58996870215, 5689.77240910359, 5696.458836410535, 5704.80033198836, 5728.684922329312, 5732.484076433141], "value": 5410.003708367693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.6619578958941, 607.7207478258266, 619.0961196652889, 628.0391001767294, 637.4931929116352, 41385.0, 43344.56655433449, 43486.565134348646, 47262.0, 47312.0537589248, 45164.548354516446, 45746.0, 45802.77098614502, 45876.770616146954, 45966.701664916785, 8929.46423214606, 9117.908820911773, 9140.771480712969, 9159.35884488086, 9160.45037297761, 8991.820163596723, 9025.18773310402, 9067.093290670946, 9088.272938164931, 9090.818183636324, 9053.683121090764, 9148.130927561871, 9178.173964343208, 9183.265338772882, 9184.494852783095, 9009.864852027193, 9076.546172691373, 9102.180803727662, 9145.268378529701, 9147.451152930778, 9064.093590640883, 9081.046490118508, 9135.36052476327, 9139.131782480654, 9148.908510914873, 42842.0, 43180.0, 43342.783286083686, 43420.3486947696, 43476.3478547822, 3630.80030598317, 3690.0774806298427, 3711.740178187528, 3721.3673675475234, 3767.7174211934216, 32292.192695182574, 32493.51259731106, 32504.512432313535, 33207.33585328304, 33316.1670958228, 4244.93029935374, 4393.824247030115, 4425.734455932655, 4450.243458612012, 4457.353683715875, 336148.0, 340616.0, 342031.0, 343588.0, 343855.0, 57439.71280143572, 57537.71231143901, 57879.0, 57945.0, 58443.70778146167, 34646.65353346484, 62787.6860615694, 63059.0, 63122.0, 63272.683636581525, 15888.126153061461, 16559.337626495046, 16619.83380166183, 16639.16804159787, 16657.33370665184, 12478.251304921734, 12488.937555312164, 12579.874201258053, 12582.559610413591, 12585.496580136693, 19428.383607487893, 19694.70457943132, 19763.604727905647, 19786.20855165806, 19820.306289279804, 7210.2789721027475, 7220.43674495557, 7328.0, 7455.179930207672, 7506.43701722373, 1011.8785745710562, 1067.69570672358, 1129.824877144044, 1142.6172232302272, 1191.8569771627288, 32698.0, 32999.67000329966, 33433.832830836174, 33450.0, 33818.49272260918, 1096.5339730614457, 1121.8822023687396, 1133.0878642692712, 1173.9823902641467, 1216.288471244332, 16653.91673041627, 17281.913590432217, 17352.39266625662, 17511.912440437718, 17606.2077206526, 512497.0, 521799.0, 526450.0, 527440.0, 528058.0, 58448.0, 58843.70578147082, 59087.40912590905, 59161.70419147877, 59201.40798591959, 1261.161327717058, 1339.3370281710615, 1341.2757111159865, 1342.2550484481012, 1347.5216298213993, 30274.0, 32338.0, 32451.837740811145, 32510.67489325171, 32688.182795430304, 50592.0, 51211.487885120674, 51368.229476557135, 51383.48616513787, 51602.48397515977, 325245.0, 329941.0, 331650.0, 332140.0, 332479.0, 28612.713872861004, 28737.56893646555, 28975.42049159047, 29026.274343140747, 29110.854445727637, 47775.52224477711, 48803.77990550265, 48816.755916220194, 49259.75370123127, 49896.50103498918, 40715.1856962865, 41243.38134928038, 41412.792936035126, 41712.3743143847, 42279.0, 41385.1722965533, 41409.58590414057, 41526.1694766109, 42171.3674294892, 42477.15045699007, 41848.790756047245, 42632.5736742641, 42938.57061429346, 43128.56871431371, 43542.34686479642, 35868.64131358653, 38039.61960380361, 38228.80885595554, 38530.422043668805, 38655.226895462496, 29039.41921161607, 29304.853475732485, 29324.0, 29669.554956675234, 29747.702522974494], "value": 20289.555676568867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5025215958456, 368.51540224604634, 384.1951112419482, 397.7176204894525, 402.4707509624843, 17230.161264569695, 19669.213231470723, 19708.0, 19897.3035943742, 19928.40214793557, 18537.721934170964, 18904.338348157817, 19333.903330483365, 19344.419667409966, 19534.31629892954, 5551.139573366125, 5710.400407957167, 5765.538756899438, 5803.419658034184, 5836.182934389189, 5567.55459563236, 5625.80309689161, 5735.08238681811, 5741.62679425836, 5745.109508026242, 5660.5471562274915, 5668.149777533362, 5721.856953576153, 5726.3987281335485, 5734.827955161331, 5620.381758006616, 5658.34928983164, 5681.3466451358, 5714.628549144334, 5739.713014349287, 5057.721825299607, 5063.0, 5131.615128865313, 5153.149730294497, 5159.613029022838, 22406.0, 22858.657120143213, 22918.0, 23421.180258690863, 23439.4140146496, 2400.1599440195964, 2525.5580273452074, 2550.885210165547, 2719.456108778252, 2990.6411230652243, 14589.270536473134, 14687.192204428753, 14690.632734181625, 14711.705765884622, 14988.775168372484, 1804.1971322761376, 1886.2077927270443, 1921.9039048047541, 1954.5211423201265, 1966.606678664273, 60937.39062609361, 70690.64654676746, 79549.0, 82590.17409825885, 83995.0, 10533.789324213472, 10888.891111088946, 10902.836457453144, 11047.337159770439, 11371.147163962736, 15239.771403428957, 15410.768838467431, 15428.460003899809, 15437.922810385877, 15460.845391545941, 7904.486208396436, 8043.477173983672, 8164.346852251806, 8168.550729709923, 8213.917860821435, 7762.340201082859, 7796.844063118706, 7982.840343193104, 8009.279164875189, 8083.919160808434, 4666.883327916829, 4855.781489832966, 4864.513548645178, 4865.56209941107, 4902.485239049848, 1964.3517639179036, 1967.1344608372272, 1980.6026534294024, 1984.5237143085556, 2016.4051604776625, 876.3558784293539, 958.9664361747306, 959.5586030425943, 1023.7594165371132, 1110.9222354435112, 18162.72755908636, 19793.802061979484, 19810.40568782939, 19977.300794472416, 20014.69977950332, 961.9759506012406, 976.1605019683067, 981.4552923127733, 1003.7691330993912, 1054.4569546683465, 10515.737106572244, 10831.404272764916, 10852.643419572554, 10859.619913302997, 10973.890261097287, 429112.0, 435198.0, 440890.0, 441304.0, 441423.0, 94485.52757236308, 94837.52581237188, 95897.0, 96909.51545242229, 97189.0, 978.7308490165261, 991.6132708243935, 1027.0, 1041.6510468992972, 1044.9634262800766, 17348.739768903222, 17416.912915435343, 17507.82492175062, 17635.0, 17939.551511212325, 30021.5496767553, 31375.0, 40429.641682429945, 41787.582124179586, 43734.12531749411, 59300.70349648397, 60269.698651506464, 61113.388866112546, 61169.0, 61276.080858788046, 8665.480071195749, 8853.468791872509, 8864.0, 8910.925730622925, 9147.131022552847, 12554.497820087094, 13198.802017969547, 13699.520516781864, 13957.371918263905, 14008.159510429407, 12263.448144833326, 12298.631041068782, 12406.0, 12429.813552796535, 12615.36923153857, 10374.585016599553, 11739.941300293443, 11778.52885884555, 12476.688082798002, 12547.749045018865, 12401.875981240071, 12489.875101249234, 12622.87377126217, 12635.115541912346, 12729.490820367082, 8845.469271843709, 8926.152015558511, 9019.0, 9084.818303633758, 9134.680286190218, 9277.257819374568, 11649.650510484698, 11735.413229338328, 11901.0, 12115.091368147248], "value": 9327.45608067617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.9711405771884, 1455.4614792526763, 1557.9454719084827, 1673.0881669490127, 1682.680290744759, 7688.384929205664, 8215.46599471034, 8294.170582941702, 8808.559572021406, 8812.69155579554, 8352.331813454924, 8506.36202284828, 8528.530930798803, 8608.913910860889, 8646.13538646135, 2194.8792816395094, 2223.7776222377715, 2234.1510226114056, 2238.4515793630585, 2242.0, 2198.923037693681, 2218.5119273759747, 2220.211824802196, 2237.362351729749, 2238.820894328458, 2201.933941981735, 2205.823534117275, 2210.082815631511, 2217.7227846519186, 2222.100049479963, 2140.4006878074088, 2147.9892600537055, 2153.364757396572, 2155.892205389724, 2162.513434477246, 2161.524464617797, 2173.3154056472163, 2174.1738139507042, 2189.025883481851, 2190.7480639726477, 8648.827023459558, 8723.956380218058, 8731.126887311282, 8767.780805479913, 8789.165029322205, 4867.7079375237245, 5054.797808087672, 5077.619178561586, 5079.136546787018, 5081.110805609003, 3199.696028877253, 3297.72457004666, 3325.933481330384, 3417.1969587147, 3421.0934102462866, 1166.9788934682153, 1175.6296766518606, 1179.4928180882216, 1204.9337286449243, 1209.3167360441323, 11837.053035757119, 11863.762724745544, 11863.940680296544, 11879.227850189796, 11891.583794567148, 4162.334026555736, 4252.022034931922, 4275.144971005811, 4337.631301339358, 4374.737515749065, 9970.152537034288, 10009.499525023719, 10034.69895903124, 10120.089191972758, 10142.239332050125, 4970.105381031449, 5031.52200540948, 5041.873953151201, 5043.798248070109, 5058.519440653132, 4032.4757781488806, 4501.729896206238, 4626.051659409813, 4656.231721765938, 4666.65000124992, 3828.5022947017264, 3856.0, 3897.142628621699, 3955.723099383073, 3963.6432721055244, 1220.45079714129, 1226.4910062324213, 1228.8095345221504, 1235.3020543392954, 1260.4580030586753, 920.2408013388981, 987.3187500624546, 1010.282699283517, 1018.0888105145852, 1021.918246540275, 5913.58604897653, 5985.102234664748, 6103.389661033861, 6219.906701399483, 6379.170707807955, 930.2883294279746, 958.5638534466801, 991.7024892532212, 1014.1633152649094, 1069.2835800013854, 4108.0, 4250.55369186231, 4306.590873866978, 4312.913741725148, 4337.7397356158735, 10502.579896804195, 10663.040326370508, 10708.411037393018, 10738.838917416246, 10783.029527342576, 10584.364938103738, 10589.682309530726, 10590.311629744043, 10610.0, 10631.362118272928, 7658.119316278588, 7777.222277772177, 7868.921310786819, 7881.369490440751, 7963.084245311863, 6008.310000896847, 6168.1056246844855, 6177.320494745664, 6266.624002559861, 6270.404311590391, 9694.6122155113, 9868.605255789687, 9990.700278991642, 10016.39901605906, 10062.295639305179, 9794.461304628314, 10048.648297309559, 10132.290739648153, 10149.797004060025, 10251.794964100825, 7123.964380178066, 7494.325510703845, 7631.847363052819, 7669.7315593953945, 7763.0, 8451.197136272045, 8461.576921154041, 8463.0, 8505.277051450696, 8513.40406171562, 7516.398688105048, 7568.318851303189, 7692.615369231628, 7789.532628042336, 7807.180246074307, 7411.444141689502, 7493.063367079115, 7545.358644515058, 7568.356689681439, 7579.469437139568, 7083.82290442743, 7126.643667816692, 7153.928460715534, 7172.282771722995, 7182.245864184186, 5051.2423136529815, 5065.240213967934, 5173.63784535094, 5239.502247286502, 5271.630985830955, 5355.892882142413, 5391.892162156813, 5417.945820541901, 5437.945620543744, 5482.205080263419], "value": 4570.600918705875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.55998162554056, 318.93940151371226, 322.74825636003925, 326.4645980591829, 328.70745036917134, 5563.610547261694, 5619.915701264485, 5675.659460432366, 5694.402087780781, 5698.259226300575, 5553.972230138854, 5574.442555744424, 5577.44225577442, 5585.692786896719, 5603.887922241563, 4127.83488660454, 4220.451341325624, 4341.674374421915, 4342.305231162999, 4377.190219809346, 4304.203722311367, 4324.82700691972, 4328.761918094504, 4332.631726303252, 4349.1301739652035, 4305.655547556204, 4333.761643109643, 4351.108022855307, 4356.150550642626, 4362.650987920959, 4262.5950534699305, 4267.869014711119, 4340.631046361063, 4356.455443069616, 4365.650747940157, 3823.847046118152, 3826.827792749333, 3841.615838416164, 3843.6348546888003, 3862.4592557042038, 5344.839654810323, 5477.561795056386, 5498.697571633598, 5501.817109321515, 5525.668459892419, 4875.926861097087, 4943.615787579483, 4967.875803104916, 4969.627277954168, 4978.9751051244875, 5801.0, 5813.82558523245, 5817.7382017809305, 5834.154047663107, 5850.444207800295, 4226.387173859804, 4227.7463352198965, 4234.06850492891, 4236.830526778926, 4253.21315556623, 5865.76536938522, 6116.174316467264, 6132.632042077445, 6158.0, 6178.289496707891, 4156.397322388237, 4157.0, 4164.500259968823, 4192.790360481964, 4200.684948628865, 4155.688323375759, 4195.958040419618, 4197.265478541243, 4199.286121359376, 4202.62176404119, 4728.8300641904425, 4808.735519546389, 4846.854594362175, 4877.780499877514, 4925.2761533463, 5845.327787304429, 5879.706014699248, 5910.527157827363, 5965.552583556164, 6000.33996260411, 1448.8116544849313, 1456.8106146201137, 1459.4454107439105, 1463.5024091808623, 1470.2060887120836, 920.1028996728137, 923.2014307623991, 923.2521657457481, 925.5696101312922, 937.9682349415589, 5021.598272138293, 5060.696358218519, 5067.442581316052, 5067.467915868854, 5083.2375143727995, 5274.492462512463, 5276.551493123051, 5334.0, 5344.839654810362, 5365.839024829262, 4860.635452341088, 5070.923936140961, 5136.021107757491, 5164.2770012198325, 5181.1969144782615, 2849.492446646979, 2863.7708983281286, 2881.481333359973, 2882.3370624756003, 2896.52207385779, 5393.595480338912, 5435.293411856513, 5491.890162196813, 5536.785285885598, 5552.833414997556, 5178.741062946838, 5366.812161574326, 5430.8913821723345, 5464.508194262536, 5488.4785945335125, 5508.7521061552325, 5548.944510554924, 5568.190338140121, 5587.078132108238, 5597.356304025007, 5076.390833099904, 5254.343207099113, 5324.334458192726, 5374.57003439716, 5390.299261096033, 5246.790128394821, 5255.292030090312, 5273.973630131978, 5304.931076880097, 5331.440198779227, 5441.959265275522, 5452.0, 5468.972655136698, 5509.752061157337, 5519.39286678473, 3683.5948045714413, 3843.9807800960816, 3848.3842585186235, 3850.403187505941, 3871.8064096794483, 5397.27136836522, 5433.619646624698, 5433.673979561239, 5811.651300921958, 5922.792702255572, 5824.417558244142, 5863.618864773776, 5887.911681324698, 5896.14505896634, 5901.734421951109, 5791.305043394819, 5869.794557190648, 5947.791827286197, 5986.281646202484, 6002.0096684048385, 5571.275734154534, 5723.427657234243, 5750.568707347049, 5760.884782304414, 5791.218185545066, 5868.677222752619, 5946.205283516741, 5963.403659634176, 5970.820875373745, 6003.339632640319, 5641.689707066151, 5727.284089488814, 5747.4252574742195, 5797.681127537857, 5828.2423284974375], "value": 4279.7992493157635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.7181471041004, 764.4610549562556, 793.2900054451262, 795.0102122857043, 818.7257268814947, 14406.0, 15212.391504339841, 15258.008229465091, 15397.769033464507, 15429.074255544661, 14418.35117419716, 14630.41478340865, 14664.266786660677, 14727.852721472782, 14794.852051479482, 665.9367360100782, 794.2375319693101, 807.3702512040588, 823.0493779684444, 824.3199360527559, 803.4375936844203, 806.4838503357855, 817.0685418622775, 817.8364327134567, 818.6234332207192, 853.6585365853678, 854.5171977832536, 858.0218550852034, 858.0947100808644, 859.5487369131225, 851.3997631669658, 854.1373213054859, 854.3549620036863, 854.5300084953251, 856.1053698884649, 618.6473709985311, 618.8824123416537, 621.2203684376125, 622.5113286070413, 626.0890404461497, 14694.485693000694, 14817.0, 14894.553163405115, 14911.776323355158, 14931.104133751902, 14667.266636668232, 15067.321970511353, 15080.849191508054, 15283.923580382138, 15347.846521534753, 11962.760744785142, 12193.329366884818, 12220.633380998495, 12278.570250041295, 12498.875011249953, 3872.8644497442456, 4020.396940458925, 4033.294173519652, 4068.2677118118727, 4089.7750623715683, 81389.0, 81594.59202704008, 81918.0, 82113.17886821175, 82392.76410853902, 11175.44122793857, 11408.486618102206, 11478.426078696031, 11610.175813791593, 11656.592019279455, 23138.3058508245, 23277.185298514472, 23387.0, 23405.0, 23512.412189695395, 8657.870131948026, 8678.739637810875, 8789.648414063493, 8862.246709029676, 8989.0, 4629.722216667011, 4740.502247264057, 4772.570468657768, 4823.3729615150505, 4928.186849169919, 3408.3694516514524, 3524.5770507538746, 3546.929061418757, 3550.3609350317192, 3555.0, 607.0863350657232, 612.7977767336769, 614.732591322776, 619.1548536248079, 626.6803929995735, 640.916680831489, 706.5584009993754, 719.2016861283971, 750.7222327738772, 782.9725959591387, 9806.460644664468, 10120.443375614412, 10121.544530496145, 10351.275410721177, 10519.26365154432, 641.2817644238482, 723.8298999735058, 732.8827387617955, 747.7644541969262, 750.7147284032033, 4889.437714662859, 4933.950660493421, 4995.950040499549, 5010.799568017312, 5032.295478632995, 125754.0, 125770.0, 125920.0, 128395.0, 129723.0, 74885.0, 101085.0, 102485.0, 102564.48717756363, 105551.02816260704, 90776.09223907809, 91243.0, 93915.53042234745, 95526.5223673891, 96579.51710241544, 9513.42919424809, 9541.904580954379, 9573.32986690925, 9673.758156046155, 9732.659356922473, 45140.32289515725, 45413.54586454093, 55082.0, 55832.0, 56077.719611401684, 69198.30801691918, 73587.0, 73694.63152684203, 74998.62500687462, 75785.24214758002, 12974.221546707227, 12990.675233119247, 13168.0, 13741.656458588615, 13892.791608125684, 14350.354234059283, 14535.418583256975, 14629.268536573341, 14657.120572765669, 14799.0, 14076.366563504462, 14296.070755400866, 14306.642333941734, 14895.0, 14998.625034374229, 13952.79070813959, 13973.231472269123, 14138.151710897379, 14443.85556144425, 14874.77687834705, 13609.455621775414, 14566.708665826412, 14663.413463461342, 14998.100113993196, 15004.399824006918, 11297.943510282395, 11582.536698532302, 11583.478743456397, 11674.885627710597, 11683.941580292045, 11090.03847544141, 11558.711032224262, 12276.815847762113, 12287.87712122903, 12319.69200769988], "value": 7741.927887027056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 111.0, 111.0, 112.0, 109.0, 114.0, 110.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 164.0, 176.0, 128.0, 154.0, 156.0, 129.0, 191.0, 134.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 166.0, 169.0, 164.0, 163.0, 164.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 160.0, 77.0, 77.0, 75.0, 74.0, 166.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 155.0, 85.0, 86.0, 86.0, 144.0, 86.0, 84.0, 146.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 122.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 56.0, 56.0, 55.0, 58.0, 58.0, 57.0, 54.0, 54.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 81.0, 80.0, 81.0, 81.0, 87.0, 107.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 135.0, 120.0, 129.0, 123.0, 131.0, 128.0, 126.0, 145.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 167.0, 161.0, 161.0, 158.0, 164.0, 163.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 64.0, 64.0, 66.0, 62.0, 63.0, 63.0, 68.0], "value": 65.1, "unit": "score"}]}]} 12:37:57 INFO - Return code: 0 12:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:37:57 ERROR - # TBPL SUCCESS # 12:37:57 INFO - Running post-action listener: _resource_record_post_action 12:37:57 INFO - ##### 12:37:57 INFO - ##### Finished run-tests step (success) 12:37:57 INFO - ##### 12:37:57 INFO - Running post-run listener: _resource_record_post_run 12:37:57 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 4096; Write bytes: 551768064; Read time: 12; Write time: 436152 12:37:57 INFO - TinderboxPrint: CPU usage
13.6% 12:37:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:37:57 INFO - TinderboxPrint: I/O write bytes / time
551,768,064 / 436,152 12:37:57 INFO - TinderboxPrint: CPU idle
8,218.3 (86.4%) 12:37:57 INFO - TinderboxPrint: CPU user
1,232.9 (13.0%) 12:37:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:37:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261709824; Read time: 0; Write time: 229552 12:37:57 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288542720; Read time: 12; Write time: 206576 12:37:58 INFO - Running post-run listener: _upload_blobber_files 12:37:58 INFO - Blob upload gear active. 12:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:58 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 12:37:58 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'] 12:37:58 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 12:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:59 INFO - (blobuploader) - INFO - Done attempting. 12:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:03 INFO - (blobuploader) - INFO - Done attempting. 12:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:04 INFO - (blobuploader) - INFO - Done attempting. 12:38:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:04 INFO - Return code: 0 12:38:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f296f8e94c687146614db54fa5ce7c81e98e06d6da58d67fdab0380f8cd849033ca99de0a9568a743ff1d34a69a33a0b71799bb2c22a60ec0395f228c45c0be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a50684703224bcff0a3a69eae2c1bd3f21853dc9938a2363a980452876f137dd6c8cad6a0681da03d547f51565776974f1b7a670287579b3964aa60db62dc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95929049781442780460c1bc46a6bc23015206dedab690db7e1b37ea91a3b3e7203ba06e2aae5d655abbc0f16d1d15771ceda12a8a2c2290591a59f8bf8778c3"} 12:38:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:04 INFO - Contents: 12:38:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f296f8e94c687146614db54fa5ce7c81e98e06d6da58d67fdab0380f8cd849033ca99de0a9568a743ff1d34a69a33a0b71799bb2c22a60ec0395f228c45c0be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a50684703224bcff0a3a69eae2c1bd3f21853dc9938a2363a980452876f137dd6c8cad6a0681da03d547f51565776974f1b7a670287579b3964aa60db62dc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95929049781442780460c1bc46a6bc23015206dedab690db7e1b37ea91a3b3e7203ba06e2aae5d655abbc0f16d1d15771ceda12a8a2c2290591a59f8bf8778c3"} 12:38:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:04 INFO - Copying logs to upload dir... 12:38:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.072542 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-16 12:38:04.517105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:38:04.521086) ========= 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=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f296f8e94c687146614db54fa5ce7c81e98e06d6da58d67fdab0380f8cd849033ca99de0a9568a743ff1d34a69a33a0b71799bb2c22a60ec0395f228c45c0be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a50684703224bcff0a3a69eae2c1bd3f21853dc9938a2363a980452876f137dd6c8cad6a0681da03d547f51565776974f1b7a670287579b3964aa60db62dc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95929049781442780460c1bc46a6bc23015206dedab690db7e1b37ea91a3b3e7203ba06e2aae5d655abbc0f16d1d15771ceda12a8a2c2290591a59f8bf8778c3"} build_url:https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/bam9AA-tTcWzhbugyNCTBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f296f8e94c687146614db54fa5ce7c81e98e06d6da58d67fdab0380f8cd849033ca99de0a9568a743ff1d34a69a33a0b71799bb2c22a60ec0395f228c45c0be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0a50684703224bcff0a3a69eae2c1bd3f21853dc9938a2363a980452876f137dd6c8cad6a0681da03d547f51565776974f1b7a670287579b3964aa60db62dc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95929049781442780460c1bc46a6bc23015206dedab690db7e1b37ea91a3b3e7203ba06e2aae5d655abbc0f16d1d15771ceda12a8a2c2290591a59f8bf8778c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:38:04.547756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:38:04.548166) ========= 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=ed14279e38b05397cf4aa391000001a4-1466101482.48955-184419423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004362 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:38:04.630811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:38:04.631206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:38:04.631561) ========= ========= Total master_lag: 0.17 =========