builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1465247439.08 results: success (0) buildid: 20160606113026 builduid: 72080a92fcb041e48af3e5333fb1b521 revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.083020) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.084167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.084814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.103289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.103977) ========= 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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 14:10:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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-06 14:10:39 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.192469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.193025) ========= 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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020135 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.246601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.247349) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a363789d659493f11efc0a4621b107b10e3fef3 --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 8a363789d659493f11efc0a4621b107b10e3fef3 --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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 14:10:39,325 truncating revision to first 12 chars 2016-06-06 14:10:39,325 Setting DEBUG logging. 2016-06-06 14:10:39,325 attempt 1/10 2016-06-06 14:10:39,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a363789d659?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:10:39,703 unpacking tar archive at: fx-team-8a363789d659/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.978853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.979601) ========= script_repo_revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.980585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.981322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:39.992249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 14:10:39.992659) ========= /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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:40 INFO - MultiFileLogger online at 20160606 14:10:40 in /builds/slave/test 14:10:40 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 14:10:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:40 INFO - {'append_to_log': False, 14:10:40 INFO - 'base_work_dir': '/builds/slave/test', 14:10:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:10:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:40 INFO - 'branch': 'Fx-Team', 14:10:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:40 INFO - 'config_files': ('talos/linux_config.py',), 14:10:40 INFO - 'default_actions': ('clobber', 14:10:40 INFO - 'read-buildbot-config', 14:10:40 INFO - 'download-and-extract', 14:10:40 INFO - 'populate-webroot', 14:10:40 INFO - 'create-virtualenv', 14:10:40 INFO - 'install', 14:10:40 INFO - 'run-tests'), 14:10:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:40 INFO - 'download_minidump_stackwalk': True, 14:10:40 INFO - 'download_symbols': 'ondemand', 14:10:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:40 INFO - 'installer_path': 'installer.exe', 14:10:40 INFO - 'log_level': 'info', 14:10:40 INFO - 'log_name': 'talos', 14:10:40 INFO - 'log_to_console': True, 14:10:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:40 INFO - 'opt_config_files': (), 14:10:40 INFO - 'pip_index': False, 14:10:40 INFO - 'sps_profile': False, 14:10:40 INFO - 'sps_profile_interval': 0, 14:10:40 INFO - 'suite': 'dromaeojs-e10s', 14:10:40 INFO - 'system_bits': '32', 14:10:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:40 INFO - 'title': 'talos-linux64-ix-027', 14:10:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:40 INFO - 'use_talos_json': True, 14:10:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:40 INFO - 'work_dir': 'build'} 14:10:40 INFO - ##### 14:10:40 INFO - ##### Running clobber step. 14:10:40 INFO - ##### 14:10:40 INFO - Running pre-action listener: _resource_record_pre_action 14:10:40 INFO - Running main action method: clobber 14:10:40 INFO - rmtree: /builds/slave/test/build 14:10:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:40 INFO - Running post-action listener: _resource_record_post_action 14:10:40 INFO - ##### 14:10:40 INFO - ##### Finished clobber step (success) 14:10:40 INFO - ##### 14:10:40 INFO - ##### 14:10:40 INFO - ##### Running read-buildbot-config step. 14:10:40 INFO - ##### 14:10:40 INFO - Running pre-action listener: _resource_record_pre_action 14:10:40 INFO - Running main action method: read_buildbot_config 14:10:40 INFO - Using buildbot properties: 14:10:40 INFO - { 14:10:40 INFO - "project": "", 14:10:40 INFO - "product": "firefox", 14:10:40 INFO - "script_repo_revision": "production", 14:10:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:10:40 INFO - "repository": "", 14:10:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:10:40 INFO - "buildid": "20160606113026", 14:10:40 INFO - "pgo_build": "True", 14:10:40 INFO - "basedir": "/builds/slave/test", 14:10:40 INFO - "buildnumber": 814, 14:10:40 INFO - "slavename": "talos-linux64-ix-027", 14:10:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:10:40 INFO - "platform": "ubuntu64_hw", 14:10:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:10:40 INFO - "branch": "fx-team", 14:10:40 INFO - "repo_path": "integration/fx-team", 14:10:40 INFO - "revision": "8a363789d659493f11efc0a4621b107b10e3fef3", 14:10:40 INFO - "stage_platform": "linux64-pgo", 14:10:40 INFO - "builduid": "72080a92fcb041e48af3e5333fb1b521", 14:10:40 INFO - "slavebuilddir": "test" 14:10:40 INFO - } 14:10:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:10:40 INFO - Running post-action listener: _resource_record_post_action 14:10:40 INFO - ##### 14:10:40 INFO - ##### Finished read-buildbot-config step (success) 14:10:40 INFO - ##### 14:10:40 INFO - ##### 14:10:40 INFO - ##### Running download-and-extract step. 14:10:40 INFO - ##### 14:10:40 INFO - Running pre-action listener: _resource_record_pre_action 14:10:40 INFO - Running main action method: download_and_extract 14:10:40 INFO - mkdir: /builds/slave/test/build/tests 14:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:40 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:10:42 INFO - Downloaded 1361 bytes. 14:10:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:42 INFO - Using the following test package requirements: 14:10:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'jsshell-linux-x86_64.zip'], 14:10:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:42 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:43 INFO - Downloaded 24443829 bytes. 14:10:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:45 INFO - Return code: 0 14:10:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:45 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:46 INFO - Downloaded 24443829 bytes. 14:10:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:48 INFO - Return code: 0 14:10: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')]} 14:10:48 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:10:49 INFO - Downloaded 10833369 bytes. 14:10:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:10:50 INFO - Return code: 0 14:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:50 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:10:51 INFO - Downloaded 59193663 bytes. 14:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:51 INFO - mkdir: /builds/slave/test/properties 14:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:51 INFO - Contents: 14:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:52 INFO - Running post-action listener: _resource_record_post_action 14:10:52 INFO - Running post-action listener: set_extra_try_arguments 14:10:52 INFO - ##### 14:10:52 INFO - ##### Finished download-and-extract step (success) 14:10:52 INFO - ##### 14:10:52 INFO - ##### 14:10:52 INFO - ##### Running populate-webroot step. 14:10:52 INFO - ##### 14:10:52 INFO - Running pre-action listener: _resource_record_pre_action 14:10:52 INFO - Running main action method: populate_webroot 14:10:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:52 INFO - '--tppagecycles', 14:10:52 INFO - '7'], 14:10:52 INFO - 'tests': ['tsvgm']}}, 14:10:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['damp', 'tps']}, 14:10:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'tests': ['damp', 'tps']}, 14:10:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['dromaeo_dom']}, 14:10:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['a11yr', 14:10:52 INFO - 'ts_paint', 14:10:52 INFO - 'tpaint', 14:10:52 INFO - 'sessionrestore', 14:10:52 INFO - 'sessionrestore_no_auto_restore', 14:10:52 INFO - 'tabpaint']}, 14:10:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['tsvgx', 14:10:52 INFO - 'tsvgr_opacity', 14:10:52 INFO - 'tart', 14:10:52 INFO - 'tscrollx', 14:10:52 INFO - 'cart']}, 14:10:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:52 INFO - 'tsvgr_opacity', 14:10:52 INFO - 'tart', 14:10:52 INFO - 'tscrollx', 14:10:52 INFO - 'cart']}, 14:10:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'talos_options': ['--disable-e10s'], 14:10:52 INFO - 'tests': ['tp5o']}, 14:10:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'tests': ['tp5o']}, 14:10:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'talos_options': ['--disable-e10s', 14:10:52 INFO - '--xperf_path', 14:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:52 INFO - 'tests': ['tp5n']}, 14:10:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:52 INFO - 'talos_options': ['--xperf_path', 14:10:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:52 INFO - 'tests': ['tp5n']}}, 14:10:52 INFO - 'talos.zip': {'path': '', 14:10:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:52 INFO - Running post-action listener: _resource_record_post_action 14:10:52 INFO - ##### 14:10:52 INFO - ##### Finished populate-webroot step (success) 14:10:52 INFO - ##### 14:10:52 INFO - ##### 14:10:52 INFO - ##### Running create-virtualenv step. 14:10:52 INFO - ##### 14:10:52 INFO - Running pre-action listener: _resource_record_pre_action 14:10:52 INFO - Running main action method: create_virtualenv 14:10:52 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:52 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 14:10:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:52 INFO - Using real prefix '/usr' 14:10:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:53 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:55 INFO - Installing pip.................done. 14:10:55 INFO - Return code: 0 14:10:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:10:55 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 14:10:55 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 14:10:55 INFO - Using env: {'DISPLAY': ':0', 14:10:55 INFO - 'HOME': '/home/cltbld', 14:10:55 INFO - 'LANG': 'en_US.UTF-8', 14:10:55 INFO - 'LANGUAGE': 'en_US:en', 14:10:55 INFO - 'LOGNAME': 'cltbld', 14:10:55 INFO - 'MAIL': '/var/mail/cltbld', 14:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:55 INFO - 'MOZ_NO_REMOTE': '1', 14:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:55 INFO - 'NO_EM_RESTART': '1', 14:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:55 INFO - 'PWD': '/builds/slave/test', 14:10:55 INFO - 'SHELL': '/bin/bash', 14:10:55 INFO - 'SHLVL': '1', 14:10:55 INFO - 'TERM': 'linux', 14:10:55 INFO - 'TMOUT': '86400', 14:10:55 INFO - 'USER': 'cltbld', 14:10:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:55 INFO - '_': '/tools/buildbot/bin/python'} 14:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:55 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 14:10:55 INFO - Cleaning up... 14:10:55 INFO - Return code: 0 14:10:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:10:55 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 14:10:55 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 14:10:55 INFO - Using env: {'DISPLAY': ':0', 14:10:55 INFO - 'HOME': '/home/cltbld', 14:10:55 INFO - 'LANG': 'en_US.UTF-8', 14:10:55 INFO - 'LANGUAGE': 'en_US:en', 14:10:55 INFO - 'LOGNAME': 'cltbld', 14:10:55 INFO - 'MAIL': '/var/mail/cltbld', 14:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:55 INFO - 'MOZ_NO_REMOTE': '1', 14:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:55 INFO - 'NO_EM_RESTART': '1', 14:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:55 INFO - 'PWD': '/builds/slave/test', 14:10:55 INFO - 'SHELL': '/bin/bash', 14:10:55 INFO - 'SHLVL': '1', 14:10:55 INFO - 'TERM': 'linux', 14:10:55 INFO - 'TMOUT': '86400', 14:10:55 INFO - 'USER': 'cltbld', 14:10:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:55 INFO - '_': '/tools/buildbot/bin/python'} 14:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:55 INFO - Downloading/unpacking psutil>=3.1.1 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:57 INFO - Installing collected packages: psutil 14:10:57 INFO - Running setup.py install for psutil 14:10:57 INFO - building 'psutil._psutil_linux' extension 14:10:57 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 14:10:57 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 14:10:57 INFO - building 'psutil._psutil_posix' extension 14:10:57 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 14:10:57 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 14:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:58 INFO - Successfully installed psutil 14:10:58 INFO - Cleaning up... 14:10:58 INFO - Return code: 0 14:10:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:58 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:10:58 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 14:10:58 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 14:10:58 INFO - Using env: {'DISPLAY': ':0', 14:10:58 INFO - 'HOME': '/home/cltbld', 14:10:58 INFO - 'LANG': 'en_US.UTF-8', 14:10:58 INFO - 'LANGUAGE': 'en_US:en', 14:10:58 INFO - 'LOGNAME': 'cltbld', 14:10:58 INFO - 'MAIL': '/var/mail/cltbld', 14:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:58 INFO - 'MOZ_NO_REMOTE': '1', 14:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:58 INFO - 'NO_EM_RESTART': '1', 14:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:58 INFO - 'PWD': '/builds/slave/test', 14:10:58 INFO - 'SHELL': '/bin/bash', 14:10:58 INFO - 'SHLVL': '1', 14:10:58 INFO - 'TERM': 'linux', 14:10:58 INFO - 'TMOUT': '86400', 14:10:58 INFO - 'USER': 'cltbld', 14:10:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:58 INFO - '_': '/tools/buildbot/bin/python'} 14:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:58 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 14:10:58 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 14:10:58 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 14:10:58 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 14:10:58 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 14:10:58 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 14:11:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:00 INFO - Installing collected packages: mozsystemmonitor 14:11:00 INFO - Running setup.py install for mozsystemmonitor 14:11:00 INFO - Successfully installed mozsystemmonitor 14:11:00 INFO - Cleaning up... 14:11:00 INFO - Return code: 0 14:11:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:00 INFO - Using env: {'DISPLAY': ':0', 14:11:00 INFO - 'HOME': '/home/cltbld', 14:11:00 INFO - 'LANG': 'en_US.UTF-8', 14:11:00 INFO - 'LANGUAGE': 'en_US:en', 14:11:00 INFO - 'LOGNAME': 'cltbld', 14:11:00 INFO - 'MAIL': '/var/mail/cltbld', 14:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:00 INFO - 'MOZ_NO_REMOTE': '1', 14:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:00 INFO - 'NO_EM_RESTART': '1', 14:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:00 INFO - 'PWD': '/builds/slave/test', 14:11:00 INFO - 'SHELL': '/bin/bash', 14:11:00 INFO - 'SHLVL': '1', 14:11:00 INFO - 'TERM': 'linux', 14:11:00 INFO - 'TMOUT': '86400', 14:11:00 INFO - 'USER': 'cltbld', 14:11:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:00 INFO - '_': '/tools/buildbot/bin/python'} 14:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:00 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:02 INFO - warning: no files found matching '*.txt' 14:11:02 INFO - no previously-included directories found matching 'build' 14:11:02 INFO - no previously-included directories found matching 'dist' 14:11:02 INFO - no previously-included directories found matching '.git*' 14:11:02 INFO - Installing collected packages: jsonschema, functools32 14:11:02 INFO - Running setup.py install for functools32 14:11:02 INFO - warning: no files found matching '*.txt' 14:11:02 INFO - no previously-included directories found matching 'build' 14:11:02 INFO - no previously-included directories found matching 'dist' 14:11:02 INFO - no previously-included directories found matching '.git*' 14:11:02 INFO - Successfully installed jsonschema functools32 14:11:02 INFO - Cleaning up... 14:11:02 INFO - Return code: 0 14:11:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11: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 blobuploader==1.2.4 14:11:02 INFO - Using env: {'DISPLAY': ':0', 14:11:02 INFO - 'HOME': '/home/cltbld', 14:11:02 INFO - 'LANG': 'en_US.UTF-8', 14:11:02 INFO - 'LANGUAGE': 'en_US:en', 14:11:02 INFO - 'LOGNAME': 'cltbld', 14:11:02 INFO - 'MAIL': '/var/mail/cltbld', 14:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:02 INFO - 'MOZ_NO_REMOTE': '1', 14:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:02 INFO - 'NO_EM_RESTART': '1', 14:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:02 INFO - 'PWD': '/builds/slave/test', 14:11:02 INFO - 'SHELL': '/bin/bash', 14:11:02 INFO - 'SHLVL': '1', 14:11:02 INFO - 'TERM': 'linux', 14:11:02 INFO - 'TMOUT': '86400', 14:11:02 INFO - 'USER': 'cltbld', 14:11:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:02 INFO - '_': '/tools/buildbot/bin/python'} 14:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:05 INFO - Downloading docopt-0.6.1.tar.gz 14:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:05 INFO - Running setup.py install for blobuploader 14:11:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:05 INFO - Running setup.py install for requests 14:11:06 INFO - Running setup.py install for docopt 14:11:06 INFO - Successfully installed blobuploader requests docopt 14:11:06 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:06 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 14:11:06 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 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:06 INFO - Running setup.py (path:/tmp/pip-gCnRkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:06 INFO - Running setup.py (path:/tmp/pip-g9AsUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:06 INFO - Running setup.py (path:/tmp/pip-zBKS7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:06 INFO - Running setup.py (path:/tmp/pip-pyTxJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:06 INFO - Running setup.py (path:/tmp/pip-FOIgF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:06 INFO - Running setup.py (path:/tmp/pip-q282mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:06 INFO - Running setup.py (path:/tmp/pip-QdFOQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:07 INFO - Running setup.py (path:/tmp/pip-xjlShB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:07 INFO - Running setup.py (path:/tmp/pip-3jYiv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:07 INFO - Running setup.py (path:/tmp/pip-wZ_9K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:07 INFO - Running setup.py (path:/tmp/pip-VWFbDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:07 INFO - Running setup.py (path:/tmp/pip-h7cbxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:07 INFO - Running setup.py (path:/tmp/pip-cdkOpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:07 INFO - Running setup.py (path:/tmp/pip-GEhrrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:07 INFO - Running setup.py (path:/tmp/pip-LdisTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:07 INFO - Running setup.py (path:/tmp/pip-wwx8zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:07 INFO - Running setup.py (path:/tmp/pip-CRr0q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:07 INFO - Running setup.py install for manifestparser 14:11:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:07 INFO - Running setup.py install for mozcrash 14:11:07 INFO - Running setup.py install for mozdebug 14:11:08 INFO - Running setup.py install for mozdevice 14:11:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for mozfile 14:11:08 INFO - Running setup.py install for mozhttpd 14:11:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for mozinfo 14:11:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for mozInstall 14:11:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for mozleak 14:11:08 INFO - Running setup.py install for mozlog 14:11:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for moznetwork 14:11:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:08 INFO - Running setup.py install for mozprocess 14:11:09 INFO - Running setup.py install for mozprofile 14:11:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:09 INFO - Running setup.py install for mozrunner 14:11:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:09 INFO - Running setup.py install for mozscreenshot 14:11:09 INFO - Running setup.py install for moztest 14:11:09 INFO - Running setup.py install for mozversion 14:11:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:09 INFO - Cleaning up... 14:11:09 INFO - Return code: 0 14:11:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:09 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:09 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 14:11:09 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 14:11:09 INFO - Using env: {'DISPLAY': ':0', 14:11:09 INFO - 'HOME': '/home/cltbld', 14:11:09 INFO - 'LANG': 'en_US.UTF-8', 14:11:09 INFO - 'LANGUAGE': 'en_US:en', 14:11:09 INFO - 'LOGNAME': 'cltbld', 14:11:09 INFO - 'MAIL': '/var/mail/cltbld', 14:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:09 INFO - 'MOZ_NO_REMOTE': '1', 14:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:09 INFO - 'NO_EM_RESTART': '1', 14:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:09 INFO - 'PWD': '/builds/slave/test', 14:11:09 INFO - 'SHELL': '/bin/bash', 14:11:09 INFO - 'SHLVL': '1', 14:11:09 INFO - 'TERM': 'linux', 14:11:09 INFO - 'TMOUT': '86400', 14:11:09 INFO - 'USER': 'cltbld', 14:11:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:09 INFO - '_': '/tools/buildbot/bin/python'} 14:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:09 INFO - Running setup.py (path:/tmp/pip-sKp6W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:09 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)) 14:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:09 INFO - Running setup.py (path:/tmp/pip-2tlTRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:09 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)) 14:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:09 INFO - Running setup.py (path:/tmp/pip-HZZpP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:10 INFO - Running setup.py (path:/tmp/pip-0cviEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:10 INFO - Running setup.py (path:/tmp/pip-0k7QKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:10 INFO - Running setup.py (path:/tmp/pip-_rIeyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:10 INFO - Running setup.py (path:/tmp/pip-0VptQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:10 INFO - Running setup.py (path:/tmp/pip-aA78EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:10 INFO - Running setup.py (path:/tmp/pip-S0u3ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:10 INFO - Running setup.py (path:/tmp/pip-q84JZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:10 INFO - Running setup.py (path:/tmp/pip-vhmNxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:10 INFO - Running setup.py (path:/tmp/pip-lA2z64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:10 INFO - Running setup.py (path:/tmp/pip-3rJVAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:10 INFO - Running setup.py (path:/tmp/pip-vCyWKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:10 INFO - Running setup.py (path:/tmp/pip-edb04X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:10 INFO - Running setup.py (path:/tmp/pip-rvZ6wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:10 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)) 14:11:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:10 INFO - Running setup.py (path:/tmp/pip-dVgjIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:11 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 14:11:11 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 14:11:11 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 14:11:11 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 14:11:11 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 14:11:11 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 14:11:12 INFO - Downloading blessings-1.6.tar.gz 14:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:13 INFO - Installing collected packages: blessings 14:11:13 INFO - Running setup.py install for blessings 14:11:13 INFO - Successfully installed blessings 14:11:13 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:13 INFO - Reading from file tmpfile_stdout 14:11:13 INFO - Current package versions: 14:11:13 INFO - argparse == 1.2.1 14:11:13 INFO - blessings == 1.6 14:11:13 INFO - blobuploader == 1.2.4 14:11:13 INFO - docopt == 0.6.1 14:11:13 INFO - functools32 == 3.2.3-2 14:11:13 INFO - jsonschema == 2.5.1 14:11:13 INFO - manifestparser == 1.1 14:11:13 INFO - mozInstall == 1.12 14:11:13 INFO - mozcrash == 0.17 14:11:13 INFO - mozdebug == 0.1 14:11:13 INFO - mozdevice == 0.48 14:11:13 INFO - mozfile == 1.2 14:11:13 INFO - mozhttpd == 0.7 14:11:13 INFO - mozinfo == 0.9 14:11:13 INFO - mozleak == 0.1 14:11:13 INFO - mozlog == 3.2 14:11:13 INFO - moznetwork == 0.27 14:11:13 INFO - mozprocess == 0.22 14:11:13 INFO - mozprofile == 0.28 14:11:13 INFO - mozrunner == 6.11 14:11:13 INFO - mozscreenshot == 0.1 14:11:13 INFO - mozsystemmonitor == 0.3 14:11:13 INFO - moztest == 0.7 14:11:13 INFO - mozversion == 1.4 14:11:13 INFO - psutil == 3.1.1 14:11:13 INFO - requests == 1.2.3 14:11:13 INFO - wsgiref == 0.1.2 14:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 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 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:13 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 14:11:13 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 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 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)) 14:11:13 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:13 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca777aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d6190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, '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': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', '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 14:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:14 INFO - Downloading/unpacking flake8 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:11:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:16 INFO - no previously-included directories found matching 'docs/_build' 14:11:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:16 INFO - Running setup.py install for pep8 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:16 INFO - no previously-included directories found matching 'docs/_build' 14:11:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:11:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:16 INFO - Cleaning up... 14:11:16 INFO - Return code: 0 14:11:16 INFO - Running post-action listener: _resource_record_post_action 14:11:16 INFO - Running post-action listener: _start_resource_monitoring 14:11:16 INFO - Starting resource monitoring. 14:11:16 INFO - ##### 14:11:16 INFO - ##### Finished create-virtualenv step (success) 14:11:16 INFO - ##### 14:11:16 INFO - ##### 14:11:16 INFO - ##### Running install step. 14:11:16 INFO - ##### 14:11:16 INFO - Running pre-action listener: _resource_record_pre_action 14:11:16 INFO - Running main action method: install 14:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:17 INFO - Reading from file tmpfile_stdout 14:11:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:17 INFO - Reading from file tmpfile_stdout 14:11:17 INFO - Output received: 14:11:17 INFO - Usage: mozinstall [options] installer 14:11:17 INFO - Options: 14:11:17 INFO - -h, --help show this help message and exit 14:11:17 INFO - -d DEST, --destination=DEST 14:11:17 INFO - Directory to install application into. [default: 14:11:17 INFO - "/builds/slave/test"] 14:11:17 INFO - --app=APP Application being installed. [default: firefox] 14:11:17 INFO - mkdir: /builds/slave/test/build/application 14:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:11:34 INFO - Reading from file tmpfile_stdout 14:11:34 INFO - Output received: 14:11:34 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:34 INFO - Running post-action listener: _resource_record_post_action 14:11:34 INFO - ##### 14:11:34 INFO - ##### Finished install step (success) 14:11:34 INFO - ##### 14:11:34 INFO - ##### 14:11:34 INFO - ##### Running run-tests step. 14:11:34 INFO - ##### 14:11:34 INFO - Running pre-action listener: _resource_record_pre_action 14:11:34 INFO - Running main action method: run_tests 14:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:34 INFO - Python 2.7.3 14:11:34 INFO - Return code: 0 14:11:34 INFO - grabbing minidump binary from tooltool 14:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:34 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 0x2968110>, '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 0x28d4230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d46c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:34 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 14:11:34 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 14:11:34 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 14:11:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:34 INFO - Return code: 0 14:11:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:35 INFO - Return code: 0 14:11:35 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/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:11:35 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/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 14:11:35 INFO - Using env: {'DISPLAY': ':0', 14:11:35 INFO - 'HOME': '/home/cltbld', 14:11:35 INFO - 'LANG': 'en_US.UTF-8', 14:11:35 INFO - 'LANGUAGE': 'en_US:en', 14:11:35 INFO - 'LOGNAME': 'cltbld', 14:11:35 INFO - 'MAIL': '/var/mail/cltbld', 14:11:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:35 INFO - 'MOZ_NO_REMOTE': '1', 14:11:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:35 INFO - 'NO_EM_RESTART': '1', 14:11:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:35 INFO - 'PWD': '/builds/slave/test', 14:11:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:35 INFO - 'SHELL': '/bin/bash', 14:11:35 INFO - 'SHLVL': '1', 14:11:35 INFO - 'TERM': 'linux', 14:11:35 INFO - 'TMOUT': '86400', 14:11:35 INFO - 'USER': 'cltbld', 14:11:35 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256', 14:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:35 INFO - '_': '/tools/buildbot/bin/python'} 14:11:35 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/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:11:35 INFO - mozversion application_buildid: 20160606113026 14:11:35 INFO - mozversion application_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:11:35 INFO - mozversion application_display_name: Nightly 14:11:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:35 INFO - mozversion application_name: Firefox 14:11:35 INFO - mozversion application_remotingname: firefox 14:11:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:35 INFO - mozversion application_vendor: Mozilla 14:11:35 INFO - mozversion application_version: 49.0a1 14:11:35 INFO - mozversion platform_buildid: 20160606113026 14:11:35 INFO - mozversion platform_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:11:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:35 INFO - mozversion platform_version: 49.0a1 14:11:35 INFO - using testdate: 1465247495 14:11:35 INFO - actual date: 1465247495 14:11:35 INFO - starting webserver on 'localhost:53336' 14:11:35 INFO - SUITE-START | Running 2 tests 14:11:35 INFO - TEST-START | dromaeo_css 14:11:35 INFO - operating with platform_type : linux_ 14:11:35 INFO - Initialising browser for dromaeo_css test... 14:11:35 INFO - TEST-INFO | started process 15150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9bE1y/profile http://localhost:53336/getInfo.html) 14:11:39 INFO - PROCESS | 15150 | __metrics Screen width/height:1600/1200 14:11:39 INFO - PROCESS | 15150 | colorDepth:24 14:11:39 INFO - PROCESS | 15150 | Browser inner width/height: 1024/697 14:11:39 INFO - PROCESS | 15150 | __metrics 14:11:40 ERROR - PROCESS | 15150 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 14:11:41 INFO - TEST-INFO | 15150: exit 0 14:11:41 INFO - Browser initialized. 14:11:41 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:41 INFO - TEST-INFO | started process 15269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9bE1y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:53 INFO - PROCESS | 15269 | RSS: Main: 167452672 14:11:53 INFO - PROCESS | 15269 | 14:12:42 INFO - PROCESS | 15269 | 1465247562613 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] 14:14:50 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53336/tests/dromaeo/cssquery-ext.html) 14:14:51 INFO - PROCESS | 15269 | RSS: Main: 170856448 14:14:51 INFO - PROCESS | 15269 | 14:17:53 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-ext.html (next: http://localhost:53336/tests/dromaeo/cssquery-jquery.html) 14:17:54 INFO - PROCESS | 15269 | RSS: Main: 170549248 14:17:54 INFO - PROCESS | 15269 | 14:20:55 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53336/tests/dromaeo/cssquery-mootools.html) 14:20:56 INFO - PROCESS | 15269 | RSS: Main: 171511808 14:20:56 INFO - PROCESS | 15269 | 14:23:58 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53336/tests/dromaeo/cssquery-prototype.html) 14:23:58 INFO - PROCESS | 15269 | RSS: Main: 169181184 14:23:58 INFO - PROCESS | 15269 | 14:27:01 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53336/tests/dromaeo/cssquery-yui.html) 14:27:02 INFO - PROCESS | 15269 | RSS: Main: 170749952 14:27:02 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | Cycle 1(1): loaded http://localhost:53336/tests/dromaeo/cssquery-yui.html (next: http://localhost:53336/tests/dromaeo/cssquery-dojo.html) 14:30:04 INFO - PROCESS | 15269 | RSS: Main: 172470272 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | __start_tp_report 14:30:04 INFO - PROCESS | 15269 | _x_x_mozilla_page_load 14:30:04 INFO - PROCESS | 15269 | _x_x_mozilla_page_load_details 14:30:04 INFO - PROCESS | 15269 | |i|pagename|runs| 14:30:04 INFO - PROCESS | 15269 | |0;dojo.html;3094.81431114133;3096.736777373923;3135.9059228223146;3138.8744450221993;3141.5758872552215;5402.135658294664;5403.162509810976;5413.377461591918;5431.945680543194;5514.641548299368;5275.235090911816;5408.513233808956;5419.810306639269;5471.890562188763;5546.4453554644515;4864.440589332228;4895.020995800836;5004.899902001957;5026.82406115786;5089.083964886319;855.2850701676764;4891.510848915115;4920.212765957447;4928.457869634337;5055.721935293557;4969.950300497003;5002.524760147817;5015.5486006259425;5025.3467049283545;5035;5024.824131155392;5026.12042892496;5039.672421292641;5052;5052.0906236877345;4914.729689867056;4975.378077740283;4980.477049909744;4995.350604421438;5027.09512287788;5368.0605893968395;5429.321334833146;5476.91784623231;5484.177373394023;5502.284702988626;5605.971970140124;5615.522680572116;5873.471387575139;5933.406659334075;5960.076188190794;5832.6792026438525;5837.299524057098;5860.267466566679;5905.645661260295;5911.142884281798;5452.727363631842;5493.038718224295;5502.669839809624;5504.944950550484;5511.559075273968;5842.036064049385;5956.897973874847;6011.909821352683;6031;6031.396860314021;5765.509931655773;5859.296884373817;5863.970680146572;5885.352611212763;5913.379095194942;5953.285605727254;5953.851153721192;5956.821295361146;5959.910601340984;5975.940240597625;5772.5670574707065;5794.855128621818;5808.5933984621515;5933.199018132583;5944.940550594439;5830.504407125357;5860;5864.179014937912;5870.853228669232;5903.173555702205;4468.642508599304;4507.233770259064;4521.412216411911;4524.366588677588;4532.818687252539;3910;3934.6655534279907;3945.940810887839;3963.6630886374405;3988.920221595552;5536.280283563111;5610.074337734228;5624.690642014729;5643.604947653707;5669.348024977098;5892.911606325909;5955.255593050869;5958.463738263577;5959.702014899238;5970.880582388328;5456.372517160498;5595.048841696921;5619.719014049281;5636.774529018875;5674.035413979634;5102.642815002914;5108.157154069611;5115.028144652504;5122.897542049138;5125.487451254845;6114.847128821815;6128.509719222451;6130.877382452326;6139.662318572432;6144.969275153596;5817.360090389969;5879.412058794257;5890.617109887844;5920.851978700567;5967.164596956342;6073.605215660968;6104.542159337979;6111.052786818051;6132.2947860996555;6133.355997620186;5641.238432811518;5848.56135789826;5859.384764599656;5864.648121112747;5874.941250587611;5863.384344643751;5883.029300165596;5909.556783241188;5968.8806223876145;5996.760129594767;5767.5674324425;5777.826665200051;5797.391273916178;5810.82567522975;5815.3893841147765;5654.575906807088;5775;5818.214541036906;5839.970800145972;5856.326522449803;5647.576431767552;5658.745356458887;5691.772329106955;5713.171590119493;5764.0201165802755;5795.681237531976;5809.419058094157;5816.272965879265;5824.446677565625;5845.532357411312;5544.833654990357;5646.209530665628;5655.095184770582;5715.8856822864145;5717.885642287214 14:30:04 INFO - PROCESS | 15269 | |1;ext.html;585.8066837943479;607.6414915200032;627.3788948940548;629.9842503937404;648.176815444386;39925.80037099814;43603.34594981074;43739.56260437395;43852.99999999996;43867.341989870176;43500.56499435005;43820.56179438205;44078;44334.55665443344;44410.333844992354;8531.402801803877;8758.474491530496;8760.649574017032;8763.474191548528;8767.780805479882;8514.872276915852;8530.57347132644;8581.485110893334;8613.310935125175;8616.095309992455;8601.440906341068;8645.610947507346;8649.913500865005;8663.39356245063;8698.47809131451;8600.741977740678;8640.179182977607;8651.091635378258;8652.913470865305;8656.653733850639;8607.35444841633;8708.78228044304;8709.912900870973;8718.825623487559;8734.912650873473;35835.462468063;35895.28209435823;35904;36088.63911360879;36224.09439764001;2896.8551572421293;3212.4699424595146;3280.3931272714626;3285.097790798956;3456.2050728332374;30072;30880.073597792103;30902.763889444395;32599.185020374443;33016.83491582527;4365.257906155961;4379.102284031797;4400.427944367212;4427.180971520279;4434.49003364614;382896;386400;388437;388457;388756.99999999715;34956.82521587376;35783.82108089443;61077.38922610806;62069.689651552355;62130.0680489793;37114.25771484555;37153.628463715555;37299.4405083924;37330.066748330966;37367.62632373696;14166.787498187536;14248.572542823731;14259.42962281497;14260.429582816778;14290.785638215435;12485.188462749893;12549.74900502003;12595.307258100709;12597.992160627127;12624.431900564497;8304.252617264354;8314.750557483285;8354.958225208835;8361.581920903931;8413.873791893126;3256.0394683568406;3259.940519331227;3276.328352687741;3288.0300311407714;3330.200751819546;962.7400601837464;962.9566669499749;1034.1898597733857;1059.4543809937888;1126.099120703434;30825.537616935762;31261.687383126333;33320.333593327996;33342.83328583342;33525.186320366374;1112.4159816096615;1187.2935603316187;1226.9325187114794;1232.1990706041145;1254.9372531373394;16929.83070169307;17141.400050998156;17182.65634687299;17194.656106877792;17215.397461088804;576759;577783;582382;584628;585492;58479.4152058474;58872;59023.704881475314;59114.40885591089;59257.40742592519;1260.4643026713793;1307.1046333261936;1307.267929959226;1345.589595173462;1361.8161548191065;31075.533866992464;31821.363572727954;32045.67954320427;32332.515012275304;32645.673543264264;50099.24851127309;50858.74570627271;50923.490765091876;50948.707308171965;51040.48959510357;488440;492607;492846;497640;498385;42864.35703464388;43361.78319108384;43454.34818477662;43680.56319436892;45169;47579;47740.7612961933;48598.75700621474;48683.269750954474;49103;41368.586314136475;41755;42069.15861682688;42245.36631950585;42265.57734422616;41336.37995430131;41407.171856563305;41469.170616588104;41558.79220603878;42298.36552451777;39677.206455870146;40105.39841902432;40489.19021619492;41629;41667.7916610415;35506.82246588854;37726;37951.24097517979;38251.691959095544;38376.232475350895;28669;29045.564316535692;29049.564256535745;29062.709372906;29157 14:30:04 INFO - PROCESS | 15269 | |2;jquery.html;402.5129593192236;403.7335358663282;404.7713042131194;405.106739639096;423.6695377605467;13724.313784310794;17545.385911493086;18998.71501927472;19108.52228694285;19160.61678766424;17258.741118883227;17977.280908763634;18069.1868865901;18075.72886406705;18079.18643661035;5600.131979543177;5625.662460252388;5707.514861236779;5730.56735816046;5812.389699081599;5086.720230387327;5384.3538775346815;5663.603547751659;5710.885782284352;5725.312962444513;5374.435684253156;5379.193121031837;5391.56867450603;5435.456454354553;5466.726663666801;5320.654157479771;5595.804146854861;5596.3284405871145;5647.407022262685;5653.858653533674;5249.921251181236;5396.595255355864;5416.295881535415;5430.67415955044;5446.1558458439;12400.503979840796;12892.87107128926;21462.463438414008;21766.34700958974;21844.563108737897;2051.148773259096;2187.3000639795114;2276.9658455123185;2311.15642790382;2830.377316990259;9535.618575256982;10095.646652367132;11045.779084418347;13787.241701706402;14383.065100768521;1467.5010496431264;1610.2995197089188;1734.2629382512382;1894.4224194820858;1957.2268953763185;55716.44283557153;68986.3101368985;83593.58203208946;84711.576442118;85168;10659.467026648637;10838.783224335626;10992.042864568748;10997;11366.829497557543;15484.458043968407;15513.844861551466;15539;15659.138747369005;15741.921290393704;7634.274743899321;7708.190639982721;7831.412644051719;7993.280604745601;8074.596270186467;7432.479726419207;7510.586917719468;7632.847343053108;7636.753170462077;7778.688852445952;4732.692374995614;4741.95258047422;4745.644076694192;4750;4878;1957.8727382720078;1957.9720646660617;1991.5917236966386;2032.1363420546209;2058.8044135807077;900.5677274908081;945.6690158444627;985.5663508056432;1023.3706270643501;1029.552144817007;17738.5565360867;18105.547361316072;18657.90671046636;18757.78874432974;18873.339433119774;989.5250279865704;995.6316163019584;996.476849653923;1014.3254735600743;1023.2121266624806;10198.796024079476;10413.53139108742;10478.633247836442;10511.369317840954;10526.631567895087;496971;504601;509570;511298;515655;96110;96113;96425;97873.51063244781;97939;972.8151651186251;984.6750572311263;1000.1548691355938;1026.4867566216892;1029.2383636109225;16217.756733648768;16341.67316653684;16380.262888170299;16447.09540975258;16489.505314840575;39867;41398.58601414068;43466.78266608647;44786.104277914914;45589;61348.38651613427;62592.37407626048;62675.37324626878;63456;64492.03261951169;7356.602245573324;7459.179490256176;7559.357454616419;8394.622241999003;8756.25571826402;9068.818623627623;12689.682757931125;12760.6809829755;12951.935240324116;13089;10923.945380273048;11278.492467838803;11368.94315528417;11652.825207621723;11833;11326.546938122383;11369.886301136883;11393.373364465035;11786.76426471483;11935.641930742091;11722.296662200295;11736.88263117358;11864.406779661154;11878.524859005543;12150.21023633461;7565.470417070752;7616.428767842544;7724.227577242231;7791.22087791239;7830.451868369388;9673.516324183622;11275.477810495806;11563.364014979257;11634.476448559666;11718.88281117178 14:30:04 INFO - PROCESS | 15269 | |3;mootools.html;1528.8624023837856;1535.8694510966568;1671.398296613219;1743.8168992255821;1767.0987796223922;8025.197480251972;8572.571371431426;8748.081451447602;9144.634214631415;9148.542572871364;8805.16350946659;9051.954740226289;9062.184403403693;9091.954540227289;9194.54027298634;2397.7602239776056;2443.5235129149823;2445.4131008557906;2446.437319416535;2448.3511869354547;2399.5081008393236;2412.2401443545314;2426.114468219096;2428.64784606232;2434.817388695846;2379.1910750344878;2396.772306630876;2409.518096380722;2410;2422.539717453687;2314.0628045641542;2322.6516022596575;2332.1953925895623;2334.253039027512;2376.9286921392386;2327.080803082773;2341.613633750429;2347.448349637834;2359.587072262347;2364.5270945810735;8983.550822458916;9119.908800912039;9126.58930348136;9129.589168487433;9147.54262286883;5359.1425371940695;5524.751386187591;5528.778848846041;5531;5543.916841247345;3385.6952874241438;3444.689977902001;3453.1021934297014;3475.2180759329203;3580.4092324766384;1205.1804772754524;1212.660455072581;1213.5327898759042;1222.1750318534953;1243.819646151312;12896.290704011275;12914;12938.805917911239;12952.740945181138;12954.157979731288;4720.504347043511;4858.149823780895;4909.2881532177635;4909.558139767367;4935.407751069894;10919.890801091888;10962.342259464458;10979.670609881716;10987.835182472269;10989.725256868642;5493.725313734298;5550.056490396642;5557.805476808292;5561.499465048165;5565.081761509306;4527.886802829889;4859.07677541266;5011.774470148852;5020.171671674206;5022.924656130161;4107.562353176424;4125.278076336629;4145.834166633301;4171.561985991427;4185.518665353462;1327.3961195354466;1345.9259740714158;1353.7360214758226;1354.7900075488315;1355.525566051874;771.9961400192963;820.3478234803346;857.1514200941148;900.0234745301422;953.828310904044;5863.824085277449;5880.852978675567;5881.558883083786;5955.821325360246;6035.517158627299;452.4321975920265;469.3757302787285;477.13876453002666;479.4462395932634;481.84099247248326;3863;3910.0420397002918;3955.3671412574427;3965.940510892339;4022.054817117975;10955.83566246507;11413.543458261742;11415;11424.771504570028;11469.942650286695;10814.29707069038;11216.32702037864;11244.156688248251;11266.66200014001;11321.962046831484;8216.876746848802;8347.415680902279;8349.749507514663;8350.540720260444;8393.118722534167;6008.098785182257;6194.256689197326;6221.751129954751;6233.657148856675;6238.220222472191;10557.366558006544;10632.989865962722;10731.195160362848;10760.139188864716;10763.730906727082;10563.841542376716;10590.576376944837;10810.67567972962;10886.23796334249;10907.454627268446;7514.586697731677;7794.22057794216;8025.759227223192;8160.510369377619;8208.261256486945;8831.116888311117;8884.466931984101;8928.687495937611;8968.372213945222;8970.37207395476;7255.2019277880445;7269.345758881726;7347.889781653386;7361.521501102411;7518.060242469692;7576.696932122653;7608.80977975555;7638.159802421618;7674.270944260286;7802.024746906637;6907.481938854707;6933.861322773617;6943.409810166192;6971.51199416036;7004.439644828503;4748.667593268438;4827.565519103297;4854.830080947291;4915.0415668944215;4932.605391568594;4675.111728771522;4752.168370535212;4790.9281360780315;4792.928106078341;4807.591354734886 14:30:04 INFO - PROCESS | 15269 | |4;prototype.html;324.0812297137615;326.3000863148546;326.3912802623108;332.8651895982128;333.73968304722297;5607.943920560793;5624.9999999999945;5661.179129026289;5676.914846277309;5690.4594063564;5550.611457197998;5566.2207290979195;5577.721113944307;5583.609147359686;5604.943950560493;4096.365063415168;4186.74879507229;4304;4316.82732690692;4332.458442694663;4261.4673165854265;4271.569024376838;4272.33778764292;4296.355546668009;4317.740935543861;4285.142971405731;4299.849505267316;4304.074623955848;4317.222899878021;4333;4046.9797651011704;4235.978820105911;4267.125239325962;4272.594103560188;4331.8483853065145;3713.424419215026;3731.440283957401;3762.2475504898857;3779.2993153080947;3784.299904517673;5381.865453363658;5436.483534064297;5446.782128714846;5465.3330734126075;5467.41444980959;4738.881527961794;4823.445303790038;4863.8540843774745;4868.49970113567;4916.213405855082;5720.3135623725;5801.53587712982;5811.738471768781;5833.358330583633;5849.151872978437;4129.855455059089;4176.415301857743;4180.602842729936;4185.6232939035635;4196.916061678749;5832.871002084251;6014.939850601526;6054.364291749347;6069;6074.848128796815;4126.277901367249;4140.730852494578;4141.544430112685;4153.231652144363;4154.1068670236045;4214.777714462772;4225.049363893161;4229.344451610005;4232.830686772495;4235.830566777295;4724.574788269072;4818.915743957581;4876.878078048077;4879.34128892595;4911.533404326583;5788.855278618068;5838.7080645967535;5864.32560255576;5889.705514724246;5926.703664816828;1429.6140042188551;1443.7762146867253;1447.9927600362141;1465.7947887295786;1470.2869108482378;931.7996630724426;937.6952490440634;937.8265020971143;941.3175447800427;972.4797233480055;5544.75243070306;5562.443755624405;5562.749676264578;5574.3555651083025;5614.803481878114;5936.821895343147;5954.523638108941;5979.6711180884595;5985.25184351956;6013.969930150409;5319.308489896366;5481.643693160012;5485.725713714378;5492.780288788404;5618.494335509824;3135.592372991542;3148.2601588627113;3175.4760464523097;3182.6976437238427;3187.0916788715567;5926.585139040312;6091.939080609226;6096.542759293071;6107.755689772448;6113.899498090297;5902.970485147547;5919.911201331984;5963.612365196335;5973.223480947449;6136.754529818846;6123.295820980644;6162.198914141133;6170.691465426711;6191.678120704736;6199.473044791153;5724.856878578069;5905.379935106752;5925.466707996301;5943.881122377615;5960.791372301948;5884.382139875252;5900.586958912835;5903.439173278532;5919.644821310735;5926.614770039933;5842.7078646066675;6008.519318454601;6035.245594300713;6085.817425477066;6096.475881029743;4099.241640296555;4101.794910254535;4109.691773116969;4112.753234805801;4135.379693046068;5907.232059832366;5967.7016149191495;5967.9701601491715;5970.9701451492465;6010.849728756816;5557.722113894209;5790.710464476675;5795.304563452412;5797.681127537857;5859.59756499833;5671.602987790815;5786.739596718074;5803.216565763568;5837.241158649348;5875.001249787461;5617.550595952396;5629.423761346829;5707.486326230659;5745.764660597992;5783.710814459176;5890.852728681817;5899.262592175978;5915.822525324247;5938.524918006636;5939.4951429129005;5657.886842263049;5808.82573522795;5845.590808643354;5853.600023990143;5879.529637629065 14:30:04 INFO - PROCESS | 15269 | |5;yui.html;690.3855568543994;702.2485940044155;716.8351279205782;807.862663347231;865.8138500222451;14286.642833929143;15374.154421506813;15704.214789260548;15743.370265189407;15755.527334179964;13042.21746695199;13132.934335328333;13136.080474366774;13241.073124881263;13718.65703357414;782.8747400415934;794.2970471133032;794.9841003179932;799.220759759233;803.7548547692966;797.0873350014231;835.2900034970287;837.0165056059136;842.2335674536173;844.771911583872;856.648774002659;857.6569372251118;865.0786911938796;866.3329236487932;867.2541614211773;859.6045818923303;861.3582880753816;861.7414775567305;862.0818827948277;863.4775960543875;629.0281515059245;630.2216762298558;630.4515071887441;630.7382436288934;632.2381530256031;15189.620259493491;15242.618934526614;15267.847321526864;15386.9230653846;15396.846031539766;14565.417383304655;14872.330745116496;14901.32944017511;15052.698946021019;15074.698506029818;11825.172237943347;11917;11986.940065299617;12013.519459221621;12622.368881555885;3777.244551089793;3825.5600605930117;3965.4448377226922;4052.837886484537;4054.0472988847596;82499.5875020627;83451;84230.57884710598;84545.57727211386;84866.15133848706;9985.251106167067;10166.237532185116;10378.42918639482;10695.144388448905;10892.074173695166;22423.775762242494;22479.88760056189;22762.43093922665;22797;22834.657480137812;8789.296856251485;8820.117988201257;8822.558872056372;8866.33502487316;8949.373543851998;4516.593506584423;4548.6133678637025;4663.760337586468;4720.291956206596;4782.402199725035;3461.9653803462147;3571.964280357215;3572.5712914450432;3575.4100573405617;3597.6941959933697;591.5474661883662;597.5130268830889;603.123102799652;610.4292486525113;612.9938700613026;632.8069938668658;634.536788144657;636.9235691717024;642.9067785171123;663.8838203314497;8512.361572882059;8931.910680893108;9021.188093071523;9071.282912941751;9086.772830679285;546.4453579616692;589.4105894105894;589.5519405252039;626.8620903401336;647.3785166240461;4075.144219713893;4270.402143699885;4343.391925130484;4599.770011499411;4650.604698600657;105799.82600521996;111090;113756;123625.92943759705;125116;99926.50036749769;103293;104806;104818.47590761997;104905.47547262214;86541.56729216313;87800.56099719461;88185.99999999872;88188;88647.55676221706;8542;8776.868346974672;8953.820923581361;9029.41308814925;9399.295052871199;37519.24961500809;43323.35014974841;44692.77653611711;51247.48752512576;52755;77179.2282077172;77691;78718;80551.19448805437;80745;11968.341741204318;12249.203801752858;12439.37803109859;12797.552085676956;12992.545260915822;13918;13927.094738841943;13951.860481395057;14193.219372934587;14752.63118422048;12813.743725125632;12990;13064.21614703121;13490.932545337211;13641.522546711214;13043.673908152372;13404.731905362034;13824.447022119002;13979.720405591628;14038.78941815853;11480.82778758336;11944.64166075019;12388.442520086437;12817.295048772407;13322.9333853334;9341.20599749029;11178.329300242012;11522.699398737823;11653.6503904883;11983.221090629082;8895;9716.174125199437;9797.608095676092;9893.35693179941;10097.141742951637 14:30:04 INFO - PROCESS | 15269 | __end_tp_report 14:30:04 INFO - PROCESS | 15269 | __start_cc_report 14:30:04 INFO - PROCESS | 15269 | _x_x_mozilla_cycle_collect,327 14:30:04 INFO - PROCESS | 15269 | __end_cc_report 14:30:04 INFO - PROCESS | 15269 | __startTimestamp1465248604923__endTimestamp 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | ------- Summary: start ------- 14:30:04 INFO - PROCESS | 15269 | Number of tests: 6 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#0] dojo.html Cycles:165 Average:5442.43 Median:5674.04 stddev:731.72 (12.9%) stddev-sans-first:710.41 14:30:04 INFO - PROCESS | 15269 | Values: 3094.8 3096.7 3135.9 3138.9 3141.6 5402.1 5403.2 5413.4 5431.9 5514.6 5275.2 5408.5 5419.8 5471.9 5546.4 4864.4 4895.0 5004.9 5026.8 5089.1 855.3 4891.5 4920.2 4928.5 5055.7 4970.0 5002.5 5015.5 5025.3 5035.0 5024.8 5026.1 5039.7 5052.0 5052.1 4914.7 4975.4 4980.5 4995.4 5027.1 5368.1 5429.3 5476.9 5484.2 5502.3 5606.0 5615.5 5873.5 5933.4 5960.1 5832.7 5837.3 5860.3 5905.6 5911.1 5452.7 5493.0 5502.7 5504.9 5511.6 5842.0 5956.9 6011.9 6031.0 6031.4 5765.5 5859.3 5864.0 5885.4 5913.4 5953.3 5953.9 5956.8 5959.9 5975.9 5772.6 5794.9 5808.6 5933.2 5944.9 5830.5 5860.0 5864.2 5870.9 5903.2 4468.6 4507.2 4521.4 4524.4 4532.8 3910.0 3934.7 3945.9 3963.7 3988.9 5536.3 5610.1 5624.7 5643.6 5669.3 5892.9 5955.3 5958.5 5959.7 5970.9 5456.4 5595.0 5619.7 5636.8 5674.0 5102.6 5108.2 5115.0 5122.9 5125.5 6114.8 6128.5 6130.9 6139.7 6145.0 5817.4 5879.4 5890.6 5920.9 5967.2 6073.6 6104.5 6111.1 6132.3 6133.4 5641.2 5848.6 5859.4 5864.6 5874.9 5863.4 5883.0 5909.6 5968.9 5996.8 5767.6 5777.8 5797.4 5810.8 5815.4 5654.6 5775.0 5818.2 5840.0 5856.3 5647.6 5658.7 5691.8 5713.2 5764.0 5795.7 5809.4 5816.3 5824.4 5845.5 5544.8 5646.2 5655.1 5715.9 5717.9 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#1] ext.html Cycles:180 Average:63139.94 Median:41711.40 stddev:131547.37 (315.4%) stddev-sans-first:131832.55 14:30:04 INFO - PROCESS | 15269 | Values: 585.8 607.6 627.4 630.0 648.2 39925.8 43603.3 43739.6 43853.0 43867.3 43500.6 43820.6 44078.0 44334.6 44410.3 8531.4 8758.5 8760.6 8763.5 8767.8 8514.9 8530.6 8581.5 8613.3 8616.1 8601.4 8645.6 8649.9 8663.4 8698.5 8600.7 8640.2 8651.1 8652.9 8656.7 8607.4 8708.8 8709.9 8718.8 8734.9 35835.5 35895.3 35904.0 36088.6 36224.1 2896.9 3212.5 3280.4 3285.1 3456.2 30072.0 30880.1 30902.8 32599.2 33016.8 4365.3 4379.1 4400.4 4427.2 4434.5 382896.0 386400.0 388437.0 388457.0 388757.0 34956.8 35783.8 61077.4 62069.7 62130.1 37114.3 37153.6 37299.4 37330.1 37367.6 14166.8 14248.6 14259.4 14260.4 14290.8 12485.2 12549.7 12595.3 12598.0 12624.4 8304.3 8314.8 8355.0 8361.6 8413.9 3256.0 3259.9 3276.3 3288.0 3330.2 962.7 963.0 1034.2 1059.5 1126.1 30825.5 31261.7 33320.3 33342.8 33525.2 1112.4 1187.3 1226.9 1232.2 1254.9 16929.8 17141.4 17182.7 17194.7 17215.4 576759.0 577783.0 582382.0 584628.0 585492.0 58479.4 58872.0 59023.7 59114.4 59257.4 1260.5 1307.1 1307.3 1345.6 1361.8 31075.5 31821.4 32045.7 32332.5 32645.7 50099.2 50858.7 50923.5 50948.7 51040.5 488440.0 492607.0 492846.0 497640.0 498385.0 42864.4 43361.8 43454.3 43680.6 45169.0 47579.0 47740.8 48598.8 48683.3 49103.0 41368.6 41755.0 42069.2 42245.4 42265.6 41336.4 41407.2 41469.2 41558.8 42298.4 39677.2 40105.4 40489.2 41629.0 41667.8 35506.8 37726.0 37951.2 38251.7 38376.2 28669.0 29045.6 29049.6 29062.7 29157.0 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#2] jquery.html Cycles:180 Average:29285.85 Median:403.12 stddev:83769.43 (20780.1%) stddev-sans-first:83976.35 14:30:04 INFO - PROCESS | 15269 | Values: 402.5 403.7 404.8 405.1 423.7 13724.3 17545.4 18998.7 19108.5 19160.6 17258.7 17977.3 18069.2 18075.7 18079.2 5600.1 5625.7 5707.5 5730.6 5812.4 5086.7 5384.4 5663.6 5710.9 5725.3 5374.4 5379.2 5391.6 5435.5 5466.7 5320.7 5595.8 5596.3 5647.4 5653.9 5249.9 5396.6 5416.3 5430.7 5446.2 12400.5 12892.9 21462.5 21766.3 21844.6 2051.1 2187.3 2277.0 2311.2 2830.4 9535.6 10095.6 11045.8 13787.2 14383.1 1467.5 1610.3 1734.3 1894.4 1957.2 55716.4 68986.3 83593.6 84711.6 85168.0 10659.5 10838.8 10992.0 10997.0 11366.8 15484.5 15513.8 15539.0 15659.1 15741.9 7634.3 7708.2 7831.4 7993.3 8074.6 7432.5 7510.6 7632.8 7636.8 7778.7 4732.7 4742.0 4745.6 4750.0 4878.0 1957.9 1958.0 1991.6 2032.1 2058.8 900.6 945.7 985.6 1023.4 1029.6 17738.6 18105.5 18657.9 18757.8 18873.3 989.5 995.6 996.5 1014.3 1023.2 10198.8 10413.5 10478.6 10511.4 10526.6 496971.0 504601.0 509570.0 511298.0 515655.0 96110.0 96113.0 96425.0 97873.5 97939.0 972.8 984.7 1000.2 1026.5 1029.2 16217.8 16341.7 16380.3 16447.1 16489.5 39867.0 41398.6 43466.8 44786.1 45589.0 61348.4 62592.4 62675.4 63456.0 64492.0 7356.6 7459.2 7559.4 8394.6 8756.3 9068.8 12689.7 12760.7 12951.9 13089.0 10923.9 11278.5 11368.9 11652.8 11833.0 11326.5 11369.9 11393.4 11786.8 11935.6 11722.3 11736.9 11864.4 11878.5 12150.2 7565.5 7616.4 7724.2 7791.2 7830.5 9673.5 11275.5 11563.4 11634.5 11718.9 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#3] mootools.html Cycles:180 Average:5928.95 Median:4750.42 stddev:3457.02 (72.8%) stddev-sans-first:3450.91 14:30:04 INFO - PROCESS | 15269 | Values: 1528.9 1535.9 1671.4 1743.8 1767.1 8025.2 8572.6 8748.1 9144.6 9148.5 8805.2 9052.0 9062.2 9092.0 9194.5 2397.8 2443.5 2445.4 2446.4 2448.4 2399.5 2412.2 2426.1 2428.6 2434.8 2379.2 2396.8 2409.5 2410.0 2422.5 2314.1 2322.7 2332.2 2334.3 2376.9 2327.1 2341.6 2347.4 2359.6 2364.5 8983.6 9119.9 9126.6 9129.6 9147.5 5359.1 5524.8 5528.8 5531.0 5543.9 3385.7 3444.7 3453.1 3475.2 3580.4 1205.2 1212.7 1213.5 1222.2 1243.8 12896.3 12914.0 12938.8 12952.7 12954.2 4720.5 4858.1 4909.3 4909.6 4935.4 10919.9 10962.3 10979.7 10987.8 10989.7 5493.7 5550.1 5557.8 5561.5 5565.1 4527.9 4859.1 5011.8 5020.2 5022.9 4107.6 4125.3 4145.8 4171.6 4185.5 1327.4 1345.9 1353.7 1354.8 1355.5 772.0 820.3 857.2 900.0 953.8 5863.8 5880.9 5881.6 5955.8 6035.5 452.4 469.4 477.1 479.4 481.8 3863.0 3910.0 3955.4 3965.9 4022.1 10955.8 11413.5 11415.0 11424.8 11469.9 10814.3 11216.3 11244.2 11266.7 11322.0 8216.9 8347.4 8349.7 8350.5 8393.1 6008.1 6194.3 6221.8 6233.7 6238.2 10557.4 10633.0 10731.2 10760.1 10763.7 10563.8 10590.6 10810.7 10886.2 10907.5 7514.6 7794.2 8025.8 8160.5 8208.3 8831.1 8884.5 8928.7 8968.4 8970.4 7255.2 7269.3 7347.9 7361.5 7518.1 7576.7 7608.8 7638.2 7674.3 7802.0 6907.5 6933.9 6943.4 6971.5 7004.4 4748.7 4827.6 4854.8 4915.0 4932.6 4675.1 4752.2 4790.9 4792.9 4807.6 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#4] prototype.html Cycles:180 Average:4872.07 Median:5616.18 stddev:1451.23 (25.8%) stddev-sans-first:1414.59 14:30:04 INFO - PROCESS | 15269 | Values: 324.1 326.3 326.4 332.9 333.7 5607.9 5625.0 5661.2 5676.9 5690.5 5550.6 5566.2 5577.7 5583.6 5604.9 4096.4 4186.7 4304.0 4316.8 4332.5 4261.5 4271.6 4272.3 4296.4 4317.7 4285.1 4299.8 4304.1 4317.2 4333.0 4047.0 4236.0 4267.1 4272.6 4331.8 3713.4 3731.4 3762.2 3779.3 3784.3 5381.9 5436.5 5446.8 5465.3 5467.4 4738.9 4823.4 4863.9 4868.5 4916.2 5720.3 5801.5 5811.7 5833.4 5849.2 4129.9 4176.4 4180.6 4185.6 4196.9 5832.9 6014.9 6054.4 6069.0 6074.8 4126.3 4140.7 4141.5 4153.2 4154.1 4214.8 4225.0 4229.3 4232.8 4235.8 4724.6 4818.9 4876.9 4879.3 4911.5 5788.9 5838.7 5864.3 5889.7 5926.7 1429.6 1443.8 1448.0 1465.8 1470.3 931.8 937.7 937.8 941.3 972.5 5544.8 5562.4 5562.7 5574.4 5614.8 5936.8 5954.5 5979.7 5985.3 6014.0 5319.3 5481.6 5485.7 5492.8 5618.5 3135.6 3148.3 3175.5 3182.7 3187.1 5926.6 6091.9 6096.5 6107.8 6113.9 5903.0 5919.9 5963.6 5973.2 6136.8 6123.3 6162.2 6170.7 6191.7 6199.5 5724.9 5905.4 5925.5 5943.9 5960.8 5884.4 5900.6 5903.4 5919.6 5926.6 5842.7 6008.5 6035.2 6085.8 6096.5 4099.2 4101.8 4109.7 4112.8 4135.4 5907.2 5967.7 5968.0 5971.0 6010.8 5557.7 5790.7 5795.3 5797.7 5859.6 5671.6 5786.7 5803.2 5837.2 5875.0 5617.6 5629.4 5707.5 5745.8 5783.7 5890.9 5899.3 5915.8 5938.5 5939.5 5657.9 5808.8 5845.6 5853.6 5879.5 14:30:04 INFO - PROCESS | 15269 | 14:30:04 INFO - PROCESS | 15269 | [#5] yui.html Cycles:180 Average:21016.71 Median:4574.19 stddev:31038.26 (678.6%) stddev-sans-first:31087.80 14:30:04 INFO - PROCESS | 15269 | Values: 690.4 702.2 716.8 807.9 865.8 14286.6 15374.2 15704.2 15743.4 15755.5 13042.2 13132.9 13136.1 13241.1 13718.7 782.9 794.3 795.0 799.2 803.8 797.1 835.3 837.0 842.2 844.8 856.6 857.7 865.1 866.3 867.3 859.6 861.4 861.7 862.1 863.5 629.0 630.2 630.5 630.7 632.2 15189.6 15242.6 15267.8 15386.9 15396.8 14565.4 14872.3 14901.3 15052.7 15074.7 11825.2 11917.0 11986.9 12013.5 12622.4 3777.2 3825.6 3965.4 4052.8 4054.0 82499.6 83451.0 84230.6 84545.6 84866.2 9985.3 10166.2 10378.4 10695.1 10892.1 22423.8 22479.9 22762.4 22797.0 22834.7 8789.3 8820.1 8822.6 8866.3 8949.4 4516.6 4548.6 4663.8 4720.3 4782.4 3462.0 3572.0 3572.6 3575.4 3597.7 591.5 597.5 603.1 610.4 613.0 632.8 634.5 636.9 642.9 663.9 8512.4 8931.9 9021.2 9071.3 9086.8 546.4 589.4 589.6 626.9 647.4 4075.1 4270.4 4343.4 4599.8 4650.6 105799.8 111090.0 113756.0 123625.9 125116.0 99926.5 103293.0 104806.0 104818.5 104905.5 86541.6 87800.6 88186.0 88188.0 88647.6 8542.0 8776.9 8953.8 9029.4 9399.3 37519.2 43323.4 44692.8 51247.5 52755.0 77179.2 77691.0 78718.0 80551.2 80745.0 11968.3 12249.2 12439.4 12797.6 12992.5 13918.0 13927.1 13951.9 14193.2 14752.6 12813.7 12990.0 13064.2 13490.9 13641.5 13043.7 13404.7 13824.4 13979.7 14038.8 11480.8 11944.6 12388.4 12817.3 13322.9 9341.2 11178.3 11522.7 11653.7 11983.2 8895.0 9716.2 9797.6 9893.4 10097.1 14:30:04 INFO - PROCESS | 15269 | -------- Summary: end -------- 14:30:04 INFO - PROCESS | 15269 | 14:30:05 INFO - TEST-INFO | 15269: exit 0 14:30:05 INFO - TEST-OK | dromaeo_css | took 1110374ms 14:30:05 INFO - TEST-START | kraken 14:30:05 INFO - operating with platform_type : linux_ 14:30:05 INFO - Initialising browser for kraken test... 14:30:05 INFO - TEST-INFO | started process 15508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLO15XD/profile http://localhost:53336/getInfo.html) 14:30:09 INFO - PROCESS | 15508 | __metrics Screen width/height:1600/1200 14:30:09 INFO - PROCESS | 15508 | colorDepth:24 14:30:09 INFO - PROCESS | 15508 | Browser inner width/height: 1024/697 14:30:09 INFO - PROCESS | 15508 | __metrics 14:30:10 ERROR - PROCESS | 15508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 14:30:11 INFO - TEST-INFO | 15508: exit 0 14:30:11 INFO - Browser initialized. 14:30:11 INFO - Running cycle 1/1 for kraken test... 14:30:11 INFO - TEST-INFO | started process 15628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLO15XD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:23 INFO - PROCESS | 15628 | RSS: Main: 167460864 14:30:23 INFO - PROCESS | 15628 | 14:30:25 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53336/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:26 INFO - PROCESS | 15628 | RSS: Main: 173113344 14:30:26 INFO - PROCESS | 15628 | 14:30:29 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53336/tests/kraken/driver.html?testName=audio-dft) 14:30:29 INFO - PROCESS | 15628 | RSS: Main: 172204032 14:30:29 INFO - PROCESS | 15628 | 14:30:32 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53336/tests/kraken/driver.html?testName=audio-fft) 14:30:33 INFO - PROCESS | 15628 | RSS: Main: 167116800 14:30:33 INFO - PROCESS | 15628 | 14:30:35 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53336/tests/kraken/driver.html?testName=audio-oscillator) 14:30:36 INFO - PROCESS | 15628 | RSS: Main: 167796736 14:30:36 INFO - PROCESS | 15628 | 14:30:38 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:38 INFO - PROCESS | 15628 | RSS: Main: 168558592 14:30:38 INFO - PROCESS | 15628 | 14:30:42 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53336/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:42 INFO - PROCESS | 15628 | RSS: Main: 169099264 14:30:42 INFO - PROCESS | 15628 | 14:30:46 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53336/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:46 INFO - PROCESS | 15628 | RSS: Main: 166154240 14:30:46 INFO - PROCESS | 15628 | 14:30:49 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53336/tests/kraken/driver.html?testName=json-parse-financial) 14:30:50 INFO - PROCESS | 15628 | RSS: Main: 167428096 14:30:50 INFO - PROCESS | 15628 | 14:30:51 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:52 INFO - PROCESS | 15628 | RSS: Main: 167952384 14:30:52 INFO - PROCESS | 15628 | 14:30:54 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:54 INFO - PROCESS | 15628 | RSS: Main: 168271872 14:30:54 INFO - PROCESS | 15628 | 14:30:56 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:57 INFO - PROCESS | 15628 | RSS: Main: 168443904 14:30:57 INFO - PROCESS | 15628 | 14:31:00 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:00 INFO - PROCESS | 15628 | RSS: Main: 168558592 14:31:00 INFO - PROCESS | 15628 | 14:31:03 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:04 INFO - PROCESS | 15628 | RSS: Main: 168583168 14:31:04 INFO - PROCESS | 15628 | 14:31:05 INFO - PROCESS | 15628 | Cycle 1(1): loaded http://localhost:53336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53336/tests/kraken/driver.html?testName=ai-astar) 14:31:06 INFO - PROCESS | 15628 | RSS: Main: 169078784 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | __start_tp_report 14:31:06 INFO - PROCESS | 15628 | _x_x_mozilla_page_load 14:31:06 INFO - PROCESS | 15628 | _x_x_mozilla_page_load_details 14:31:06 INFO - PROCESS | 15628 | |i|pagename|runs| 14:31:06 INFO - PROCESS | 15628 | |0;ai-astar;111;108;112;112;114;113;112;110;110;111 14:31:06 INFO - PROCESS | 15628 | |1;audio-beat-detection;156;125;157;178;134;158;156;128;189;126 14:31:06 INFO - PROCESS | 15628 | |2;audio-dft;163;162;160;162;162;167;169;163;161;168 14:31:06 INFO - PROCESS | 15628 | |3;audio-fft;74;75;77;156;76;76;75;75;169;74 14:31:06 INFO - PROCESS | 15628 | |4;audio-oscillator;84;85;151;86;85;85;146;85;85;158 14:31:06 INFO - PROCESS | 15628 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 14:31:06 INFO - PROCESS | 15628 | |6;imaging-darkroom;148;153;149;152;150;150;149;148;152;152 14:31:06 INFO - PROCESS | 15628 | |7;imaging-desaturate;96;96;96;95;96;95;96;95;96;97 14:31:06 INFO - PROCESS | 15628 | |8;json-parse-financial;55;56;54;52;57;53;56;53;53;56 14:31:06 INFO - PROCESS | 15628 | |9;json-stringify-tinderbox;62;64;69;63;62;63;63;63;64;63 14:31:06 INFO - PROCESS | 15628 | |10;stanford-crypto-aes;80;80;81;80;80;81;81;80;120;80 14:31:06 INFO - PROCESS | 15628 | |11;stanford-crypto-ccm;131;122;133;123;123;128;131;123;169;138 14:31:06 INFO - PROCESS | 15628 | |12;stanford-crypto-pbkdf2;163;164;161;163;158;161;160;166;156;160 14:31:06 INFO - PROCESS | 15628 | |13;stanford-crypto-sha256-iterative;62;63;66;64;64;64;61;62;62;66 14:31:06 INFO - PROCESS | 15628 | __end_tp_report 14:31:06 INFO - PROCESS | 15628 | __start_cc_report 14:31:06 INFO - PROCESS | 15628 | _x_x_mozilla_cycle_collect,898 14:31:06 INFO - PROCESS | 15628 | __end_cc_report 14:31:06 INFO - PROCESS | 15628 | __startTimestamp1465248666066__endTimestamp 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | ------- Summary: start ------- 14:31:06 INFO - PROCESS | 15628 | Number of tests: 14 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 14:31:06 INFO - PROCESS | 15628 | Values: 111.0 108.0 112.0 112.0 114.0 113.0 112.0 110.0 110.0 111.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.50 stddev:22.18 (14.2%) stddev-sans-first:23.44 14:31:06 INFO - PROCESS | 15628 | Values: 156.0 125.0 157.0 178.0 134.0 158.0 156.0 128.0 189.0 126.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.13 (1.9%) stddev-sans-first:3.31 14:31:06 INFO - PROCESS | 15628 | Values: 163.0 162.0 160.0 162.0 162.0 167.0 169.0 163.0 161.0 168.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:36.93 (49.2%) stddev-sans-first:38.54 14:31:06 INFO - PROCESS | 15628 | Values: 74.0 75.0 77.0 156.0 76.0 76.0 75.0 75.0 169.0 74.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:85.00 stddev:32.33 (38.0%) stddev-sans-first:33.39 14:31:06 INFO - PROCESS | 15628 | Values: 84.0 85.0 151.0 86.0 85.0 85.0 146.0 85.0 85.0 158.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:31:06 INFO - PROCESS | 15628 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:151.00 stddev:1.83 (1.2%) stddev-sans-first:1.74 14:31:06 INFO - PROCESS | 15628 | Values: 148.0 153.0 149.0 152.0 150.0 150.0 149.0 148.0 152.0 152.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:31:06 INFO - PROCESS | 15628 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 97.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.50 stddev:1.72 (3.1%) stddev-sans-first:1.81 14:31:06 INFO - PROCESS | 15628 | Values: 55.0 56.0 54.0 52.0 57.0 53.0 56.0 53.0 53.0 56.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:63.00 stddev:2.01 (3.2%) stddev-sans-first:2.05 14:31:06 INFO - PROCESS | 15628 | Values: 62.0 64.0 69.0 63.0 62.0 63.0 63.0 63.0 64.0 63.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:80.00 stddev:12.55 (15.7%) stddev-sans-first:13.22 14:31:06 INFO - PROCESS | 15628 | Values: 80.0 80.0 81.0 80.0 80.0 81.0 81.0 80.0 120.0 80.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.00 stddev:14.01 (10.7%) stddev-sans-first:14.86 14:31:06 INFO - PROCESS | 15628 | Values: 131.0 122.0 133.0 123.0 123.0 128.0 131.0 123.0 169.0 138.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:2.94 (1.8%) stddev-sans-first:3.04 14:31:06 INFO - PROCESS | 15628 | Values: 163.0 164.0 161.0 163.0 158.0 161.0 160.0 166.0 156.0 160.0 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - PROCESS | 15628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.71 (2.7%) stddev-sans-first:1.74 14:31:06 INFO - PROCESS | 15628 | Values: 62.0 63.0 66.0 64.0 64.0 64.0 61.0 62.0 62.0 66.0 14:31:06 INFO - PROCESS | 15628 | -------- Summary: end -------- 14:31:06 INFO - PROCESS | 15628 | 14:31:06 INFO - TEST-INFO | 15628: exit 0 14:31:07 INFO - TEST-OK | kraken | took 61403ms 14:31:07 INFO - SUITE-END | took 1171s 14:31:07 INFO - Completed test suite (00:19:31) 14:31:07 INFO - javascript benchmark 14:31:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.3604414461515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.81431114133, 3096.736777373923, 3135.9059228223146, 3138.8744450221993, 3141.5758872552215, 5402.135658294664, 5403.162509810976, 5413.377461591918, 5431.945680543194, 5514.641548299368, 5275.235090911816, 5408.513233808956, 5419.810306639269, 5471.890562188763, 5546.4453554644515, 4864.440589332228, 4895.020995800836, 5004.899902001957, 5026.82406115786, 5089.083964886319, 855.2850701676764, 4891.510848915115, 4920.212765957447, 4928.457869634337, 5055.721935293557, 4969.950300497003, 5002.524760147817, 5015.5486006259425, 5025.3467049283545, 5035.0, 5024.824131155392, 5026.12042892496, 5039.672421292641, 5052.0, 5052.0906236877345, 4914.729689867056, 4975.378077740283, 4980.477049909744, 4995.350604421438, 5027.09512287788, 5368.0605893968395, 5429.321334833146, 5476.91784623231, 5484.177373394023, 5502.284702988626, 5605.971970140124, 5615.522680572116, 5873.471387575139, 5933.406659334075, 5960.076188190794, 5832.6792026438525, 5837.299524057098, 5860.267466566679, 5905.645661260295, 5911.142884281798, 5452.727363631842, 5493.038718224295, 5502.669839809624, 5504.944950550484, 5511.559075273968, 5842.036064049385, 5956.897973874847, 6011.909821352683, 6031.0, 6031.396860314021, 5765.509931655773, 5859.296884373817, 5863.970680146572, 5885.352611212763, 5913.379095194942, 5953.285605727254, 5953.851153721192, 5956.821295361146, 5959.910601340984, 5975.940240597625, 5772.5670574707065, 5794.855128621818, 5808.5933984621515, 5933.199018132583, 5944.940550594439, 5830.504407125357, 5860.0, 5864.179014937912, 5870.853228669232, 5903.173555702205, 4468.642508599304, 4507.233770259064, 4521.412216411911, 4524.366588677588, 4532.818687252539, 3910.0, 3934.6655534279907, 3945.940810887839, 3963.6630886374405, 3988.920221595552, 5536.280283563111, 5610.074337734228, 5624.690642014729, 5643.604947653707, 5669.348024977098, 5892.911606325909, 5955.255593050869, 5958.463738263577, 5959.702014899238, 5970.880582388328, 5456.372517160498, 5595.048841696921, 5619.719014049281, 5636.774529018875, 5674.035413979634, 5102.642815002914, 5108.157154069611, 5115.028144652504, 5122.897542049138, 5125.487451254845, 6114.847128821815, 6128.509719222451, 6130.877382452326, 6139.662318572432, 6144.969275153596, 5817.360090389969, 5879.412058794257, 5890.617109887844, 5920.851978700567, 5967.164596956342, 6073.605215660968, 6104.542159337979, 6111.052786818051, 6132.2947860996555, 6133.355997620186, 5641.238432811518, 5848.56135789826, 5859.384764599656, 5864.648121112747, 5874.941250587611, 5863.384344643751, 5883.029300165596, 5909.556783241188, 5968.8806223876145, 5996.760129594767, 5767.5674324425, 5777.826665200051, 5797.391273916178, 5810.82567522975, 5815.3893841147765, 5654.575906807088, 5775.0, 5818.214541036906, 5839.970800145972, 5856.326522449803, 5647.576431767552, 5658.745356458887, 5691.772329106955, 5713.171590119493, 5764.0201165802755, 5795.681237531976, 5809.419058094157, 5816.272965879265, 5824.446677565625, 5845.532357411312, 5544.833654990357, 5646.209530665628, 5655.095184770582, 5715.8856822864145, 5717.885642287214], "value": 5392.90554464031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8066837943479, 607.6414915200032, 627.3788948940548, 629.9842503937404, 648.176815444386, 39925.80037099814, 43603.34594981074, 43739.56260437395, 43852.99999999996, 43867.341989870176, 43500.56499435005, 43820.56179438205, 44078.0, 44334.55665443344, 44410.333844992354, 8531.402801803877, 8758.474491530496, 8760.649574017032, 8763.474191548528, 8767.780805479882, 8514.872276915852, 8530.57347132644, 8581.485110893334, 8613.310935125175, 8616.095309992455, 8601.440906341068, 8645.610947507346, 8649.913500865005, 8663.39356245063, 8698.47809131451, 8600.741977740678, 8640.179182977607, 8651.091635378258, 8652.913470865305, 8656.653733850639, 8607.35444841633, 8708.78228044304, 8709.912900870973, 8718.825623487559, 8734.912650873473, 35835.462468063, 35895.28209435823, 35904.0, 36088.63911360879, 36224.09439764001, 2896.8551572421293, 3212.4699424595146, 3280.3931272714626, 3285.097790798956, 3456.2050728332374, 30072.0, 30880.073597792103, 30902.763889444395, 32599.185020374443, 33016.83491582527, 4365.257906155961, 4379.102284031797, 4400.427944367212, 4427.180971520279, 4434.49003364614, 382896.0, 386400.0, 388437.0, 388457.0, 388756.99999999715, 34956.82521587376, 35783.82108089443, 61077.38922610806, 62069.689651552355, 62130.0680489793, 37114.25771484555, 37153.628463715555, 37299.4405083924, 37330.066748330966, 37367.62632373696, 14166.787498187536, 14248.572542823731, 14259.42962281497, 14260.429582816778, 14290.785638215435, 12485.188462749893, 12549.74900502003, 12595.307258100709, 12597.992160627127, 12624.431900564497, 8304.252617264354, 8314.750557483285, 8354.958225208835, 8361.581920903931, 8413.873791893126, 3256.0394683568406, 3259.940519331227, 3276.328352687741, 3288.0300311407714, 3330.200751819546, 962.7400601837464, 962.9566669499749, 1034.1898597733857, 1059.4543809937888, 1126.099120703434, 30825.537616935762, 31261.687383126333, 33320.333593327996, 33342.83328583342, 33525.186320366374, 1112.4159816096615, 1187.2935603316187, 1226.9325187114794, 1232.1990706041145, 1254.9372531373394, 16929.83070169307, 17141.400050998156, 17182.65634687299, 17194.656106877792, 17215.397461088804, 576759.0, 577783.0, 582382.0, 584628.0, 585492.0, 58479.4152058474, 58872.0, 59023.704881475314, 59114.40885591089, 59257.40742592519, 1260.4643026713793, 1307.1046333261936, 1307.267929959226, 1345.589595173462, 1361.8161548191065, 31075.533866992464, 31821.363572727954, 32045.67954320427, 32332.515012275304, 32645.673543264264, 50099.24851127309, 50858.74570627271, 50923.490765091876, 50948.707308171965, 51040.48959510357, 488440.0, 492607.0, 492846.0, 497640.0, 498385.0, 42864.35703464388, 43361.78319108384, 43454.34818477662, 43680.56319436892, 45169.0, 47579.0, 47740.7612961933, 48598.75700621474, 48683.269750954474, 49103.0, 41368.586314136475, 41755.0, 42069.15861682688, 42245.36631950585, 42265.57734422616, 41336.37995430131, 41407.171856563305, 41469.170616588104, 41558.79220603878, 42298.36552451777, 39677.206455870146, 40105.39841902432, 40489.19021619492, 41629.0, 41667.7916610415, 35506.82246588854, 37726.0, 37951.24097517979, 38251.691959095544, 38376.232475350895, 28669.0, 29045.564316535692, 29049.564256535745, 29062.709372906, 29157.0], "value": 19119.765921380967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.5129593192236, 403.7335358663282, 404.7713042131194, 405.106739639096, 423.6695377605467, 13724.313784310794, 17545.385911493086, 18998.71501927472, 19108.52228694285, 19160.61678766424, 17258.741118883227, 17977.280908763634, 18069.1868865901, 18075.72886406705, 18079.18643661035, 5600.131979543177, 5625.662460252388, 5707.514861236779, 5730.56735816046, 5812.389699081599, 5086.720230387327, 5384.3538775346815, 5663.603547751659, 5710.885782284352, 5725.312962444513, 5374.435684253156, 5379.193121031837, 5391.56867450603, 5435.456454354553, 5466.726663666801, 5320.654157479771, 5595.804146854861, 5596.3284405871145, 5647.407022262685, 5653.858653533674, 5249.921251181236, 5396.595255355864, 5416.295881535415, 5430.67415955044, 5446.1558458439, 12400.503979840796, 12892.87107128926, 21462.463438414008, 21766.34700958974, 21844.563108737897, 2051.148773259096, 2187.3000639795114, 2276.9658455123185, 2311.15642790382, 2830.377316990259, 9535.618575256982, 10095.646652367132, 11045.779084418347, 13787.241701706402, 14383.065100768521, 1467.5010496431264, 1610.2995197089188, 1734.2629382512382, 1894.4224194820858, 1957.2268953763185, 55716.44283557153, 68986.3101368985, 83593.58203208946, 84711.576442118, 85168.0, 10659.467026648637, 10838.783224335626, 10992.042864568748, 10997.0, 11366.829497557543, 15484.458043968407, 15513.844861551466, 15539.0, 15659.138747369005, 15741.921290393704, 7634.274743899321, 7708.190639982721, 7831.412644051719, 7993.280604745601, 8074.596270186467, 7432.479726419207, 7510.586917719468, 7632.847343053108, 7636.753170462077, 7778.688852445952, 4732.692374995614, 4741.95258047422, 4745.644076694192, 4750.0, 4878.0, 1957.8727382720078, 1957.9720646660617, 1991.5917236966386, 2032.1363420546209, 2058.8044135807077, 900.5677274908081, 945.6690158444627, 985.5663508056432, 1023.3706270643501, 1029.552144817007, 17738.5565360867, 18105.547361316072, 18657.90671046636, 18757.78874432974, 18873.339433119774, 989.5250279865704, 995.6316163019584, 996.476849653923, 1014.3254735600743, 1023.2121266624806, 10198.796024079476, 10413.53139108742, 10478.633247836442, 10511.369317840954, 10526.631567895087, 496971.0, 504601.0, 509570.0, 511298.0, 515655.0, 96110.0, 96113.0, 96425.0, 97873.51063244781, 97939.0, 972.8151651186251, 984.6750572311263, 1000.1548691355938, 1026.4867566216892, 1029.2383636109225, 16217.756733648768, 16341.67316653684, 16380.262888170299, 16447.09540975258, 16489.505314840575, 39867.0, 41398.58601414068, 43466.78266608647, 44786.104277914914, 45589.0, 61348.38651613427, 62592.37407626048, 62675.37324626878, 63456.0, 64492.03261951169, 7356.602245573324, 7459.179490256176, 7559.357454616419, 8394.622241999003, 8756.25571826402, 9068.818623627623, 12689.682757931125, 12760.6809829755, 12951.935240324116, 13089.0, 10923.945380273048, 11278.492467838803, 11368.94315528417, 11652.825207621723, 11833.0, 11326.546938122383, 11369.886301136883, 11393.373364465035, 11786.76426471483, 11935.641930742091, 11722.296662200295, 11736.88263117358, 11864.406779661154, 11878.524859005543, 12150.21023633461, 7565.470417070752, 7616.428767842544, 7724.227577242231, 7791.22087791239, 7830.451868369388, 9673.516324183622, 11275.477810495806, 11563.364014979257, 11634.476448559666, 11718.88281117178], "value": 8996.852756531483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.8624023837856, 1535.8694510966568, 1671.398296613219, 1743.8168992255821, 1767.0987796223922, 8025.197480251972, 8572.571371431426, 8748.081451447602, 9144.634214631415, 9148.542572871364, 8805.16350946659, 9051.954740226289, 9062.184403403693, 9091.954540227289, 9194.54027298634, 2397.7602239776056, 2443.5235129149823, 2445.4131008557906, 2446.437319416535, 2448.3511869354547, 2399.5081008393236, 2412.2401443545314, 2426.114468219096, 2428.64784606232, 2434.817388695846, 2379.1910750344878, 2396.772306630876, 2409.518096380722, 2410.0, 2422.539717453687, 2314.0628045641542, 2322.6516022596575, 2332.1953925895623, 2334.253039027512, 2376.9286921392386, 2327.080803082773, 2341.613633750429, 2347.448349637834, 2359.587072262347, 2364.5270945810735, 8983.550822458916, 9119.908800912039, 9126.58930348136, 9129.589168487433, 9147.54262286883, 5359.1425371940695, 5524.751386187591, 5528.778848846041, 5531.0, 5543.916841247345, 3385.6952874241438, 3444.689977902001, 3453.1021934297014, 3475.2180759329203, 3580.4092324766384, 1205.1804772754524, 1212.660455072581, 1213.5327898759042, 1222.1750318534953, 1243.819646151312, 12896.290704011275, 12914.0, 12938.805917911239, 12952.740945181138, 12954.157979731288, 4720.504347043511, 4858.149823780895, 4909.2881532177635, 4909.558139767367, 4935.407751069894, 10919.890801091888, 10962.342259464458, 10979.670609881716, 10987.835182472269, 10989.725256868642, 5493.725313734298, 5550.056490396642, 5557.805476808292, 5561.499465048165, 5565.081761509306, 4527.886802829889, 4859.07677541266, 5011.774470148852, 5020.171671674206, 5022.924656130161, 4107.562353176424, 4125.278076336629, 4145.834166633301, 4171.561985991427, 4185.518665353462, 1327.3961195354466, 1345.9259740714158, 1353.7360214758226, 1354.7900075488315, 1355.525566051874, 771.9961400192963, 820.3478234803346, 857.1514200941148, 900.0234745301422, 953.828310904044, 5863.824085277449, 5880.852978675567, 5881.558883083786, 5955.821325360246, 6035.517158627299, 452.4321975920265, 469.3757302787285, 477.13876453002666, 479.4462395932634, 481.84099247248326, 3863.0, 3910.0420397002918, 3955.3671412574427, 3965.940510892339, 4022.054817117975, 10955.83566246507, 11413.543458261742, 11415.0, 11424.771504570028, 11469.942650286695, 10814.29707069038, 11216.32702037864, 11244.156688248251, 11266.66200014001, 11321.962046831484, 8216.876746848802, 8347.415680902279, 8349.749507514663, 8350.540720260444, 8393.118722534167, 6008.098785182257, 6194.256689197326, 6221.751129954751, 6233.657148856675, 6238.220222472191, 10557.366558006544, 10632.989865962722, 10731.195160362848, 10760.139188864716, 10763.730906727082, 10563.841542376716, 10590.576376944837, 10810.67567972962, 10886.23796334249, 10907.454627268446, 7514.586697731677, 7794.22057794216, 8025.759227223192, 8160.510369377619, 8208.261256486945, 8831.116888311117, 8884.466931984101, 8928.687495937611, 8968.372213945222, 8970.37207395476, 7255.2019277880445, 7269.345758881726, 7347.889781653386, 7361.521501102411, 7518.060242469692, 7576.696932122653, 7608.80977975555, 7638.159802421618, 7674.270944260286, 7802.024746906637, 6907.481938854707, 6933.861322773617, 6943.409810166192, 6971.51199416036, 7004.439644828503, 4748.667593268438, 4827.565519103297, 4854.830080947291, 4915.0415668944215, 4932.605391568594, 4675.111728771522, 4752.168370535212, 4790.9281360780315, 4792.928106078341, 4807.591354734886], "value": 4644.6947101723335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.0812297137615, 326.3000863148546, 326.3912802623108, 332.8651895982128, 333.73968304722297, 5607.943920560793, 5624.9999999999945, 5661.179129026289, 5676.914846277309, 5690.4594063564, 5550.611457197998, 5566.2207290979195, 5577.721113944307, 5583.609147359686, 5604.943950560493, 4096.365063415168, 4186.74879507229, 4304.0, 4316.82732690692, 4332.458442694663, 4261.4673165854265, 4271.569024376838, 4272.33778764292, 4296.355546668009, 4317.740935543861, 4285.142971405731, 4299.849505267316, 4304.074623955848, 4317.222899878021, 4333.0, 4046.9797651011704, 4235.978820105911, 4267.125239325962, 4272.594103560188, 4331.8483853065145, 3713.424419215026, 3731.440283957401, 3762.2475504898857, 3779.2993153080947, 3784.299904517673, 5381.865453363658, 5436.483534064297, 5446.782128714846, 5465.3330734126075, 5467.41444980959, 4738.881527961794, 4823.445303790038, 4863.8540843774745, 4868.49970113567, 4916.213405855082, 5720.3135623725, 5801.53587712982, 5811.738471768781, 5833.358330583633, 5849.151872978437, 4129.855455059089, 4176.415301857743, 4180.602842729936, 4185.6232939035635, 4196.916061678749, 5832.871002084251, 6014.939850601526, 6054.364291749347, 6069.0, 6074.848128796815, 4126.277901367249, 4140.730852494578, 4141.544430112685, 4153.231652144363, 4154.1068670236045, 4214.777714462772, 4225.049363893161, 4229.344451610005, 4232.830686772495, 4235.830566777295, 4724.574788269072, 4818.915743957581, 4876.878078048077, 4879.34128892595, 4911.533404326583, 5788.855278618068, 5838.7080645967535, 5864.32560255576, 5889.705514724246, 5926.703664816828, 1429.6140042188551, 1443.7762146867253, 1447.9927600362141, 1465.7947887295786, 1470.2869108482378, 931.7996630724426, 937.6952490440634, 937.8265020971143, 941.3175447800427, 972.4797233480055, 5544.75243070306, 5562.443755624405, 5562.749676264578, 5574.3555651083025, 5614.803481878114, 5936.821895343147, 5954.523638108941, 5979.6711180884595, 5985.25184351956, 6013.969930150409, 5319.308489896366, 5481.643693160012, 5485.725713714378, 5492.780288788404, 5618.494335509824, 3135.592372991542, 3148.2601588627113, 3175.4760464523097, 3182.6976437238427, 3187.0916788715567, 5926.585139040312, 6091.939080609226, 6096.542759293071, 6107.755689772448, 6113.899498090297, 5902.970485147547, 5919.911201331984, 5963.612365196335, 5973.223480947449, 6136.754529818846, 6123.295820980644, 6162.198914141133, 6170.691465426711, 6191.678120704736, 6199.473044791153, 5724.856878578069, 5905.379935106752, 5925.466707996301, 5943.881122377615, 5960.791372301948, 5884.382139875252, 5900.586958912835, 5903.439173278532, 5919.644821310735, 5926.614770039933, 5842.7078646066675, 6008.519318454601, 6035.245594300713, 6085.817425477066, 6096.475881029743, 4099.241640296555, 4101.794910254535, 4109.691773116969, 4112.753234805801, 4135.379693046068, 5907.232059832366, 5967.7016149191495, 5967.9701601491715, 5970.9701451492465, 6010.849728756816, 5557.722113894209, 5790.710464476675, 5795.304563452412, 5797.681127537857, 5859.59756499833, 5671.602987790815, 5786.739596718074, 5803.216565763568, 5837.241158649348, 5875.001249787461, 5617.550595952396, 5629.423761346829, 5707.486326230659, 5745.764660597992, 5783.710814459176, 5890.852728681817, 5899.262592175978, 5915.822525324247, 5938.524918006636, 5939.4951429129005, 5657.886842263049, 5808.82573522795, 5845.590808643354, 5853.600023990143, 5879.529637629065], "value": 4400.475891680285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3855568543994, 702.2485940044155, 716.8351279205782, 807.862663347231, 865.8138500222451, 14286.642833929143, 15374.154421506813, 15704.214789260548, 15743.370265189407, 15755.527334179964, 13042.21746695199, 13132.934335328333, 13136.080474366774, 13241.073124881263, 13718.65703357414, 782.8747400415934, 794.2970471133032, 794.9841003179932, 799.220759759233, 803.7548547692966, 797.0873350014231, 835.2900034970287, 837.0165056059136, 842.2335674536173, 844.771911583872, 856.648774002659, 857.6569372251118, 865.0786911938796, 866.3329236487932, 867.2541614211773, 859.6045818923303, 861.3582880753816, 861.7414775567305, 862.0818827948277, 863.4775960543875, 629.0281515059245, 630.2216762298558, 630.4515071887441, 630.7382436288934, 632.2381530256031, 15189.620259493491, 15242.618934526614, 15267.847321526864, 15386.9230653846, 15396.846031539766, 14565.417383304655, 14872.330745116496, 14901.32944017511, 15052.698946021019, 15074.698506029818, 11825.172237943347, 11917.0, 11986.940065299617, 12013.519459221621, 12622.368881555885, 3777.244551089793, 3825.5600605930117, 3965.4448377226922, 4052.837886484537, 4054.0472988847596, 82499.5875020627, 83451.0, 84230.57884710598, 84545.57727211386, 84866.15133848706, 9985.251106167067, 10166.237532185116, 10378.42918639482, 10695.144388448905, 10892.074173695166, 22423.775762242494, 22479.88760056189, 22762.43093922665, 22797.0, 22834.657480137812, 8789.296856251485, 8820.117988201257, 8822.558872056372, 8866.33502487316, 8949.373543851998, 4516.593506584423, 4548.6133678637025, 4663.760337586468, 4720.291956206596, 4782.402199725035, 3461.9653803462147, 3571.964280357215, 3572.5712914450432, 3575.4100573405617, 3597.6941959933697, 591.5474661883662, 597.5130268830889, 603.123102799652, 610.4292486525113, 612.9938700613026, 632.8069938668658, 634.536788144657, 636.9235691717024, 642.9067785171123, 663.8838203314497, 8512.361572882059, 8931.910680893108, 9021.188093071523, 9071.282912941751, 9086.772830679285, 546.4453579616692, 589.4105894105894, 589.5519405252039, 626.8620903401336, 647.3785166240461, 4075.144219713893, 4270.402143699885, 4343.391925130484, 4599.770011499411, 4650.604698600657, 105799.82600521996, 111090.0, 113756.0, 123625.92943759705, 125116.0, 99926.50036749769, 103293.0, 104806.0, 104818.47590761997, 104905.47547262214, 86541.56729216313, 87800.56099719461, 88185.99999999872, 88188.0, 88647.55676221706, 8542.0, 8776.868346974672, 8953.820923581361, 9029.41308814925, 9399.295052871199, 37519.24961500809, 43323.35014974841, 44692.77653611711, 51247.48752512576, 52755.0, 77179.2282077172, 77691.0, 78718.0, 80551.19448805437, 80745.0, 11968.341741204318, 12249.203801752858, 12439.37803109859, 12797.552085676956, 12992.545260915822, 13918.0, 13927.094738841943, 13951.860481395057, 14193.219372934587, 14752.63118422048, 12813.743725125632, 12990.0, 13064.21614703121, 13490.932545337211, 13641.522546711214, 13043.673908152372, 13404.731905362034, 13824.447022119002, 13979.720405591628, 14038.78941815853, 11480.82778758336, 11944.64166075019, 12388.442520086437, 12817.295048772407, 13322.9333853334, 9341.20599749029, 11178.329300242012, 11522.699398737823, 11653.6503904883, 11983.221090629082, 8895.0, 9716.174125199437, 9797.608095676092, 9893.35693179941, 10097.141742951637], "value": 7404.345985852226, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 112.0, 112.0, 114.0, 113.0, 112.0, 110.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 157.0, 178.0, 134.0, 158.0, 156.0, 128.0, 189.0, 126.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 162.0, 162.0, 167.0, 169.0, 163.0, 161.0, 168.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 156.0, 76.0, 76.0, 75.0, 75.0, 169.0, 74.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 151.0, 86.0, 85.0, 85.0, 146.0, 85.0, 85.0, 158.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 153.0, 149.0, 152.0, 150.0, 150.0, 149.0, 148.0, 152.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 52.0, 57.0, 53.0, 56.0, 53.0, 53.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 69.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 80.0, 80.0, 81.0, 81.0, 80.0, 120.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 133.0, 123.0, 123.0, 128.0, 131.0, 123.0, 169.0, 138.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 163.0, 158.0, 161.0, 160.0, 166.0, 156.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 66.0, 64.0, 64.0, 64.0, 61.0, 62.0, 62.0, 66.0], "value": 63.4, "unit": "score"}]}]} 14:31:07 INFO - Return code: 0 14:31:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:07 ERROR - # TBPL SUCCESS # 14:31:07 INFO - Running post-action listener: _resource_record_post_action 14:31:07 INFO - ##### 14:31:07 INFO - ##### Finished run-tests step (success) 14:31:07 INFO - ##### 14:31:07 INFO - Running post-run listener: _resource_record_post_run 14:31:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 549928960; Read time: 236; Write time: 435160 14:31:07 INFO - TinderboxPrint: CPU usage
13.4% 14:31:07 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 14:31:07 INFO - TinderboxPrint: I/O write bytes / time
549,928,960 / 435,160 14:31:07 INFO - TinderboxPrint: CPU idle
8,217.3 (86.5%) 14:31:07 INFO - TinderboxPrint: CPU user
1,223.3 (12.9%) 14:31:07 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 254971904; Read time: 0; Write time: 228120 14:31:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294789120; Read time: 236; Write time: 207020 14:31:07 INFO - Running post-run listener: _upload_blobber_files 14:31:07 INFO - Blob upload gear active. 14:31:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:07 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 14:31:07 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'] 14:31:07 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 14:31:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:11 INFO - (blobuploader) - INFO - Done attempting. 14:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:12 INFO - (blobuploader) - INFO - Done attempting. 14:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:13 INFO - (blobuploader) - INFO - Done attempting. 14:31:13 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:13 INFO - Return code: 0 14:31:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e54e83014c1631bf4e89f41629031eb551cee0fc21b34d719e2bf69866345a2caa5c52f31a05cb2a4abd13254d69b8f0bf652aa81feb96a1383cc9736d0ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7adf78377901e9f31b0bcc9d791fdb8839e94ea37b7ec074ecde0d6f3ca38fef1642387d91a84068165d6a87ca085f663a521f95266f441de4290d17238329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0a40abda0e81a97b2562f7b1bb0ff8fa175c775bca2eee2d9f3fb53cc98535aff95bf8934443fc26d423e53abb501103c7d14e247cede790661211d3b34d80f"} 14:31:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:13 INFO - Contents: 14:31:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e54e83014c1631bf4e89f41629031eb551cee0fc21b34d719e2bf69866345a2caa5c52f31a05cb2a4abd13254d69b8f0bf652aa81feb96a1383cc9736d0ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7adf78377901e9f31b0bcc9d791fdb8839e94ea37b7ec074ecde0d6f3ca38fef1642387d91a84068165d6a87ca085f663a521f95266f441de4290d17238329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0a40abda0e81a97b2562f7b1bb0ff8fa175c775bca2eee2d9f3fb53cc98535aff95bf8934443fc26d423e53abb501103c7d14e247cede790661211d3b34d80f"} 14:31:13 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:13 INFO - Copying logs to upload dir... 14:31:13 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.545520 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 14:31:13.569352) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:13.573294) ========= 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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 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/42e54e83014c1631bf4e89f41629031eb551cee0fc21b34d719e2bf69866345a2caa5c52f31a05cb2a4abd13254d69b8f0bf652aa81feb96a1383cc9736d0ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7adf78377901e9f31b0bcc9d791fdb8839e94ea37b7ec074ecde0d6f3ca38fef1642387d91a84068165d6a87ca085f663a521f95266f441de4290d17238329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0a40abda0e81a97b2562f7b1bb0ff8fa175c775bca2eee2d9f3fb53cc98535aff95bf8934443fc26d423e53abb501103c7d14e247cede790661211d3b34d80f"} build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.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/42e54e83014c1631bf4e89f41629031eb551cee0fc21b34d719e2bf69866345a2caa5c52f31a05cb2a4abd13254d69b8f0bf652aa81feb96a1383cc9736d0ab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa7adf78377901e9f31b0bcc9d791fdb8839e94ea37b7ec074ecde0d6f3ca38fef1642387d91a84068165d6a87ca085f663a521f95266f441de4290d17238329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0a40abda0e81a97b2562f7b1bb0ff8fa175c775bca2eee2d9f3fb53cc98535aff95bf8934443fc26d423e53abb501103c7d14e247cede790661211d3b34d80f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:13.601404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:13.601900) ========= 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=1f5564757af27664ca02d71f000001b0-1465243528.512648-272838256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:13.684591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:31:13.685055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:31:13.685465) ========= ========= Total master_lag: 0.20 =========