builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1447909295.41 results: success (0) buildid: 20151118204944 builduid: 636f636ba8aa436f99f01605fc654fcb revision: 3c747d782958267e847037c20fa37e14abc4de6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.413299) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.413757) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.414447) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009187 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.479379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.479699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.566951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.567257) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.640961) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.641244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.641583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.641903) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 21:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-18 21:01:35 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.830073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.830399) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.881287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:35.881596) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c747d782958267e847037c20fa37e14abc4de6c --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 3c747d782958267e847037c20fa37e14abc4de6c --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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 21:01:36,097 truncating revision to first 12 chars 2015-11-18 21:01:36,097 Setting DEBUG logging. 2015-11-18 21:01:36,097 attempt 1/10 2015-11-18 21:01:36,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c747d782958?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 21:01:36,408 unpacking tar archive at: fx-team-3c747d782958/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:36.516427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:36.516704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:36.527371) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:36.527631) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 21:01:36.528066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-18 21:01:36.528375) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:01:36 INFO - MultiFileLogger online at 20151118 21:01:36 in /builds/slave/test 21:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:01:36 INFO - {'append_to_log': False, 21:01:36 INFO - 'base_work_dir': '/builds/slave/test', 21:01:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:01:36 INFO - 'branch': 'Fx-Team-Non-PGO', 21:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:01:36 INFO - 'config_files': ('talos/linux_config.py',), 21:01:36 INFO - 'default_actions': ('clobber', 21:01:36 INFO - 'read-buildbot-config', 21:01:36 INFO - 'download-and-extract', 21:01:36 INFO - 'populate-webroot', 21:01:36 INFO - 'create-virtualenv', 21:01:36 INFO - 'install', 21:01:36 INFO - 'run-tests'), 21:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:01:36 INFO - 'download_minidump_stackwalk': True, 21:01:36 INFO - 'download_symbols': 'ondemand', 21:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:01:36 INFO - 'installer_path': 'installer.exe', 21:01:36 INFO - 'log_level': 'info', 21:01:36 INFO - 'log_name': 'talos', 21:01:36 INFO - 'log_to_console': True, 21:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:01:36 INFO - 'opt_config_files': (), 21:01:36 INFO - 'pip_index': False, 21:01:36 INFO - 'sps_profile': False, 21:01:36 INFO - 'sps_profile_interval': 0, 21:01:36 INFO - 'suite': 'dromaeojs', 21:01:36 INFO - 'system_bits': '64', 21:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:01:36 INFO - 'title': 'talos-linux64-ix-011', 21:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:01:36 INFO - 'use_talos_json': True, 21:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:01:36 INFO - 'work_dir': 'build'} 21:01:36 INFO - ##### 21:01:36 INFO - ##### Running clobber step. 21:01:36 INFO - ##### 21:01:36 INFO - Running pre-action listener: _resource_record_pre_action 21:01:36 INFO - Running main action method: clobber 21:01:36 INFO - rmtree: /builds/slave/test/build 21:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:01:37 INFO - Running post-action listener: _resource_record_post_action 21:01:37 INFO - ##### 21:01:37 INFO - ##### Running read-buildbot-config step. 21:01:37 INFO - ##### 21:01:37 INFO - Running pre-action listener: _resource_record_pre_action 21:01:37 INFO - Running main action method: read_buildbot_config 21:01:37 INFO - Using buildbot properties: 21:01:37 INFO - { 21:01:37 INFO - "properties": { 21:01:37 INFO - "buildnumber": 2083, 21:01:37 INFO - "product": "firefox", 21:01:37 INFO - "script_repo_revision": "production", 21:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:01:37 INFO - "repository": "", 21:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:01:37 INFO - "buildid": "20151118204944", 21:01:37 INFO - "slavename": "talos-linux64-ix-011", 21:01:37 INFO - "pgo_build": "False", 21:01:37 INFO - "basedir": "/builds/slave/test", 21:01:37 INFO - "project": "", 21:01:37 INFO - "platform": "ubuntu64_hw", 21:01:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:01:37 INFO - "slavebuilddir": "test", 21:01:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:01:37 INFO - "branch": "fx-team", 21:01:37 INFO - "repo_path": "integration/fx-team", 21:01:37 INFO - "stage_platform": "linux64", 21:01:37 INFO - "builduid": "636f636ba8aa436f99f01605fc654fcb", 21:01:37 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 21:01:37 INFO - }, 21:01:37 INFO - "sourcestamp": { 21:01:37 INFO - "repository": "", 21:01:37 INFO - "hasPatch": false, 21:01:37 INFO - "project": "", 21:01:37 INFO - "branch": "fx-team-linux64-talos", 21:01:37 INFO - "changes": [ 21:01:37 INFO - { 21:01:37 INFO - "category": null, 21:01:37 INFO - "files": [ 21:01:37 INFO - { 21:01:37 INFO - "url": null, 21:01:37 INFO - "name": "https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:01:37 INFO - } 21:01:37 INFO - ], 21:01:37 INFO - "repository": "", 21:01:37 INFO - "rev": "3c747d782958267e847037c20fa37e14abc4de6c", 21:01:37 INFO - "who": "jryans@gmail.com", 21:01:37 INFO - "when": 1447909226, 21:01:37 INFO - "number": 6681004, 21:01:37 INFO - "comments": "Bug 1225906 - Correct GCLI staticRequire after repackaging. r=ochameau\n", 21:01:37 INFO - "project": "", 21:01:37 INFO - "at": "Wed 18 Nov 2015 21:00:26", 21:01:37 INFO - "branch": "fx-team-linux64-talos", 21:01:37 INFO - "revlink": "", 21:01:37 INFO - "properties": [ 21:01:37 INFO - [ 21:01:37 INFO - "buildid", 21:01:37 INFO - "20151118204944", 21:01:37 INFO - "Change" 21:01:37 INFO - ], 21:01:37 INFO - [ 21:01:37 INFO - "builduid", 21:01:37 INFO - "636f636ba8aa436f99f01605fc654fcb", 21:01:37 INFO - "Change" 21:01:37 INFO - ], 21:01:37 INFO - [ 21:01:37 INFO - "pgo_build", 21:01:37 INFO - "False", 21:01:37 INFO - "Change" 21:01:37 INFO - ] 21:01:37 INFO - ], 21:01:37 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 21:01:37 INFO - } 21:01:37 INFO - ], 21:01:37 INFO - "revision": "3c747d782958267e847037c20fa37e14abc4de6c" 21:01:37 INFO - } 21:01:37 INFO - } 21:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:01:37 INFO - Running post-action listener: _resource_record_post_action 21:01:37 INFO - ##### 21:01:37 INFO - ##### Running download-and-extract step. 21:01:37 INFO - ##### 21:01:37 INFO - Running pre-action listener: _resource_record_pre_action 21:01:37 INFO - Running main action method: download_and_extract 21:01:37 INFO - mkdir: /builds/slave/test/build/tests 21:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:01:37 INFO - https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/test_packages.json 21:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/test_packages.json 21:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:01:44 INFO - Downloaded 1302 bytes. 21:01:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:01:44 INFO - Using the following test package requirements: 21:01:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:01:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'jsshell-linux-x86_64.zip'], 21:01:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:01:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:01:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:01:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:01:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:01:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:01:44 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')]} 21:01:44 INFO - https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:01:48 INFO - Downloaded 21291871 bytes. 21:01:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:01:49 INFO - Return code: 0 21:01:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:01:49 INFO - https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:01:51 INFO - Downloaded 21291871 bytes. 21:01:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 21:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:01:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:01:52 INFO - Return code: 0 21:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:01:52 INFO - https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:01:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:01:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:01:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:01:53 INFO - Downloaded 11130997 bytes. 21:01:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 21:01:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:01:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:01:54 INFO - Return code: 0 21:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:01:54 INFO - https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:01:55 INFO - Downloaded 55665757 bytes. 21:01:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:01:55 INFO - mkdir: /builds/slave/test/properties 21:01:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:01:55 INFO - Writing to file /builds/slave/test/properties/build_url 21:01:55 INFO - Contents: 21:01:55 INFO - build_url:https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:01:55 INFO - Running post-action listener: _resource_record_post_action 21:01:55 INFO - Running post-action listener: set_extra_try_arguments 21:01:55 INFO - ##### 21:01:55 INFO - ##### Running populate-webroot step. 21:01:55 INFO - ##### 21:01:55 INFO - Running pre-action listener: _resource_record_pre_action 21:01:55 INFO - Running main action method: populate_webroot 21:01:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:01:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:01:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:01:55 INFO - '../fennec_ids.txt'], 21:01:55 INFO - 'tests': ['tcheck2']}, 21:01:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:01:55 INFO - '--tppagecycles', 21:01:55 INFO - '7'], 21:01:55 INFO - 'tests': ['tsvgm']}}, 21:01:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:01:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:01:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:01:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:01:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:01:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:01:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'tests': ['damp', 'tps']}, 21:01:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['damp', 'tps']}, 21:01:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:01:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:01:55 INFO - 'other': {'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'other_l64': {'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'other_nol64': {'tests': ['a11yr', 21:01:55 INFO - 'ts_paint', 21:01:55 INFO - 'tpaint', 21:01:55 INFO - 'sessionrestore', 21:01:55 INFO - 'sessionrestore_no_auto_restore']}, 21:01:55 INFO - 'svgr': {'tests': ['tsvgx', 21:01:55 INFO - 'tsvgr_opacity', 21:01:55 INFO - 'tart', 21:01:55 INFO - 'tscrollx', 21:01:55 INFO - 'cart']}, 21:01:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['tsvgx', 21:01:55 INFO - 'tsvgr_opacity', 21:01:55 INFO - 'tart', 21:01:55 INFO - 'tscrollx', 21:01:55 INFO - 'cart']}, 21:01:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'tests': ['tp5o']}, 21:01:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'talos_options': ['--e10s'], 21:01:55 INFO - 'tests': ['tp5o']}, 21:01:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'talos_options': ['--xperf_path', 21:01:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:01:55 INFO - 'tests': ['tp5n']}, 21:01:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:01:55 INFO - 'talos_options': ['--e10s', 21:01:55 INFO - '--xperf_path', 21:01:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:01:55 INFO - 'tests': ['tp5n']}}, 21:01:55 INFO - 'talos.zip': {'path': '', 21:01:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:01:55 INFO - Running post-action listener: _resource_record_post_action 21:01:55 INFO - ##### 21:01:55 INFO - ##### Running create-virtualenv step. 21:01:55 INFO - ##### 21:01:55 INFO - Running pre-action listener: _resource_record_pre_action 21:01:55 INFO - Running main action method: create_virtualenv 21:01:55 INFO - Creating virtualenv /builds/slave/test/build/venv 21:01:55 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 21:01:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:01:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:01:55 INFO - Using real prefix '/usr' 21:01:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:01:56 INFO - Installing distribute.............................................................................................................................................................................................done. 21:01:58 INFO - Installing pip.................done. 21:01:58 INFO - Return code: 0 21:01:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 21:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 21:01:58 INFO - Using env: {'DISPLAY': ':0', 21:01:58 INFO - 'HOME': '/home/cltbld', 21:01:58 INFO - 'LANG': 'en_US.UTF-8', 21:01:58 INFO - 'LANGUAGE': 'en_US:en', 21:01:58 INFO - 'LOGNAME': 'cltbld', 21:01:58 INFO - 'MAIL': '/var/mail/cltbld', 21:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:58 INFO - 'MOZ_NO_REMOTE': '1', 21:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:01:58 INFO - 'NO_EM_RESTART': '1', 21:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:58 INFO - 'PWD': '/builds/slave/test', 21:01:58 INFO - 'SHELL': '/bin/bash', 21:01:58 INFO - 'SHLVL': '1', 21:01:58 INFO - 'TERM': 'linux', 21:01:58 INFO - 'TMOUT': '86400', 21:01:58 INFO - 'USER': 'cltbld', 21:01:58 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:58 INFO - '_': '/tools/buildbot/bin/python'} 21:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:58 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 21:01:58 INFO - Cleaning up... 21:01:58 INFO - Return code: 0 21:01:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 21:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 21:01:58 INFO - Using env: {'DISPLAY': ':0', 21:01:58 INFO - 'HOME': '/home/cltbld', 21:01:58 INFO - 'LANG': 'en_US.UTF-8', 21:01:58 INFO - 'LANGUAGE': 'en_US:en', 21:01:58 INFO - 'LOGNAME': 'cltbld', 21:01:58 INFO - 'MAIL': '/var/mail/cltbld', 21:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:58 INFO - 'MOZ_NO_REMOTE': '1', 21:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:01:58 INFO - 'NO_EM_RESTART': '1', 21:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:58 INFO - 'PWD': '/builds/slave/test', 21:01:58 INFO - 'SHELL': '/bin/bash', 21:01:58 INFO - 'SHLVL': '1', 21:01:58 INFO - 'TERM': 'linux', 21:01:58 INFO - 'TMOUT': '86400', 21:01:58 INFO - 'USER': 'cltbld', 21:01:58 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:58 INFO - '_': '/tools/buildbot/bin/python'} 21:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:58 INFO - Downloading/unpacking psutil>=0.7.1 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:02:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:00 INFO - Installing collected packages: psutil 21:02:00 INFO - Running setup.py install for psutil 21:02:00 INFO - building 'psutil._psutil_linux' extension 21:02:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:02:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:02:00 INFO - building 'psutil._psutil_posix' extension 21:02:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:02:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:00 INFO - Successfully installed psutil 21:02:00 INFO - Cleaning up... 21:02:00 INFO - Return code: 0 21:02:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 21:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 21:02:00 INFO - Using env: {'DISPLAY': ':0', 21:02:00 INFO - 'HOME': '/home/cltbld', 21:02:00 INFO - 'LANG': 'en_US.UTF-8', 21:02:00 INFO - 'LANGUAGE': 'en_US:en', 21:02:00 INFO - 'LOGNAME': 'cltbld', 21:02:00 INFO - 'MAIL': '/var/mail/cltbld', 21:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:00 INFO - 'MOZ_NO_REMOTE': '1', 21:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:00 INFO - 'NO_EM_RESTART': '1', 21:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:00 INFO - 'PWD': '/builds/slave/test', 21:02:00 INFO - 'SHELL': '/bin/bash', 21:02:00 INFO - 'SHLVL': '1', 21:02:00 INFO - 'TERM': 'linux', 21:02:00 INFO - 'TMOUT': '86400', 21:02:00 INFO - 'USER': 'cltbld', 21:02:00 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:00 INFO - '_': '/tools/buildbot/bin/python'} 21:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:02:02 INFO - Installing collected packages: mozsystemmonitor 21:02:02 INFO - Running setup.py install for mozsystemmonitor 21:02:02 INFO - Successfully installed mozsystemmonitor 21:02:02 INFO - Cleaning up... 21:02:02 INFO - Return code: 0 21:02:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 21:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 21:02:02 INFO - Using env: {'DISPLAY': ':0', 21:02:02 INFO - 'HOME': '/home/cltbld', 21:02:02 INFO - 'LANG': 'en_US.UTF-8', 21:02:02 INFO - 'LANGUAGE': 'en_US:en', 21:02:02 INFO - 'LOGNAME': 'cltbld', 21:02:02 INFO - 'MAIL': '/var/mail/cltbld', 21:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:02 INFO - 'MOZ_NO_REMOTE': '1', 21:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:02 INFO - 'NO_EM_RESTART': '1', 21:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:02 INFO - 'PWD': '/builds/slave/test', 21:02:02 INFO - 'SHELL': '/bin/bash', 21:02:02 INFO - 'SHLVL': '1', 21:02:02 INFO - 'TERM': 'linux', 21:02:02 INFO - 'TMOUT': '86400', 21:02:02 INFO - 'USER': 'cltbld', 21:02:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:02 INFO - '_': '/tools/buildbot/bin/python'} 21:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:03 INFO - Downloading/unpacking blobuploader==1.2.4 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:02:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:05 INFO - Downloading docopt-0.6.1.tar.gz 21:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:05 INFO - Running setup.py install for blobuploader 21:02:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:02:05 INFO - Running setup.py install for requests 21:02:05 INFO - Running setup.py install for docopt 21:02:06 INFO - Successfully installed blobuploader requests docopt 21:02:06 INFO - Cleaning up... 21:02:06 INFO - Return code: 0 21:02:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 21:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 21:02:06 INFO - Using env: {'DISPLAY': ':0', 21:02:06 INFO - 'HOME': '/home/cltbld', 21:02:06 INFO - 'LANG': 'en_US.UTF-8', 21:02:06 INFO - 'LANGUAGE': 'en_US:en', 21:02:06 INFO - 'LOGNAME': 'cltbld', 21:02:06 INFO - 'MAIL': '/var/mail/cltbld', 21:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:06 INFO - 'MOZ_NO_REMOTE': '1', 21:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:06 INFO - 'NO_EM_RESTART': '1', 21:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:06 INFO - 'PWD': '/builds/slave/test', 21:02:06 INFO - 'SHELL': '/bin/bash', 21:02:06 INFO - 'SHLVL': '1', 21:02:06 INFO - 'TERM': 'linux', 21:02:06 INFO - 'TMOUT': '86400', 21:02:06 INFO - 'USER': 'cltbld', 21:02:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:06 INFO - '_': '/tools/buildbot/bin/python'} 21:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:06 INFO - Running setup.py (path:/tmp/pip-zlaGZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:06 INFO - Running setup.py (path:/tmp/pip-MLRKZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:06 INFO - Running setup.py (path:/tmp/pip-fM1oRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:06 INFO - Running setup.py (path:/tmp/pip-ecMR1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:06 INFO - Running setup.py (path:/tmp/pip-AKyUN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:06 INFO - Running setup.py (path:/tmp/pip-UmlSp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:06 INFO - Running setup.py (path:/tmp/pip-efvFbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:06 INFO - Running setup.py (path:/tmp/pip-Qkqjdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:06 INFO - Running setup.py (path:/tmp/pip-Zk0kaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:06 INFO - Running setup.py (path:/tmp/pip-u6WQds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:07 INFO - Running setup.py (path:/tmp/pip-ZVoKLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:07 INFO - Running setup.py (path:/tmp/pip-iTPeEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:07 INFO - Running setup.py (path:/tmp/pip-VbXN24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:07 INFO - Running setup.py (path:/tmp/pip-GMZxfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:07 INFO - Running setup.py (path:/tmp/pip-46UbWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:07 INFO - Running setup.py (path:/tmp/pip-RQ012y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:07 INFO - Running setup.py (path:/tmp/pip-Ytyymz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:07 INFO - Running setup.py install for manifestparser 21:02:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:02:07 INFO - Running setup.py install for mozcrash 21:02:07 INFO - Running setup.py install for mozdebug 21:02:07 INFO - Running setup.py install for mozdevice 21:02:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:02:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:02:07 INFO - Running setup.py install for mozfile 21:02:08 INFO - Running setup.py install for mozhttpd 21:02:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozinfo 21:02:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozInstall 21:02:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozleak 21:02:08 INFO - Running setup.py install for mozlog 21:02:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for moznetwork 21:02:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozprocess 21:02:08 INFO - Running setup.py install for mozprofile 21:02:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozrunner 21:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:02:08 INFO - Running setup.py install for mozscreenshot 21:02:09 INFO - Running setup.py install for moztest 21:02:09 INFO - Running setup.py install for mozversion 21:02:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:02:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:09 INFO - Cleaning up... 21:02:09 INFO - Return code: 0 21:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 21:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 21:02:09 INFO - Using env: {'DISPLAY': ':0', 21:02:09 INFO - 'HOME': '/home/cltbld', 21:02:09 INFO - 'LANG': 'en_US.UTF-8', 21:02:09 INFO - 'LANGUAGE': 'en_US:en', 21:02:09 INFO - 'LOGNAME': 'cltbld', 21:02:09 INFO - 'MAIL': '/var/mail/cltbld', 21:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:09 INFO - 'MOZ_NO_REMOTE': '1', 21:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:09 INFO - 'NO_EM_RESTART': '1', 21:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:09 INFO - 'PWD': '/builds/slave/test', 21:02:09 INFO - 'SHELL': '/bin/bash', 21:02:09 INFO - 'SHLVL': '1', 21:02:09 INFO - 'TERM': 'linux', 21:02:09 INFO - 'TMOUT': '86400', 21:02:09 INFO - 'USER': 'cltbld', 21:02:09 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:09 INFO - '_': '/tools/buildbot/bin/python'} 21:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:09 INFO - Running setup.py (path:/tmp/pip-F5tFx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02: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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:09 INFO - Running setup.py (path:/tmp/pip-f6dTVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:09 INFO - Running setup.py (path:/tmp/pip-ybb_hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:09 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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:09 INFO - Running setup.py (path:/tmp/pip-XUFv5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:09 INFO - Running setup.py (path:/tmp/pip-jl7KqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:09 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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:09 INFO - Running setup.py (path:/tmp/pip-T0BCRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:09 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)) 21:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:09 INFO - Running setup.py (path:/tmp/pip-fxrlSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:10 INFO - Running setup.py (path:/tmp/pip-yt4Ki6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:10 INFO - Running setup.py (path:/tmp/pip-PaoBgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:10 INFO - Running setup.py (path:/tmp/pip-BVEqV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:10 INFO - Running setup.py (path:/tmp/pip-eJwMDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:10 INFO - Running setup.py (path:/tmp/pip-Win4HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:10 INFO - Running setup.py (path:/tmp/pip-6Hfc2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:10 INFO - Running setup.py (path:/tmp/pip-L6XXEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:10 INFO - Running setup.py (path:/tmp/pip-qa5jPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:10 INFO - Running setup.py (path:/tmp/pip-wvdYRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02: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)) 21:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:10 INFO - Running setup.py (path:/tmp/pip-RZmjqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:10 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)) 21:02:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:02:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:02:10 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)) 21:02:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:10 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:12 INFO - Downloading blessings-1.5.1.tar.gz 21:02:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:02:12 INFO - Installing collected packages: blessings 21:02:12 INFO - Running setup.py install for blessings 21:02:12 INFO - Successfully installed blessings 21:02:12 INFO - Cleaning up... 21:02:12 INFO - Return code: 0 21:02:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:12 INFO - Reading from file tmpfile_stdout 21:02:12 INFO - Current package versions: 21:02:12 INFO - argparse == 1.2.1 21:02:12 INFO - blessings == 1.5.1 21:02:12 INFO - blobuploader == 1.2.4 21:02:12 INFO - docopt == 0.6.1 21:02:12 INFO - manifestparser == 1.1 21:02:12 INFO - mozInstall == 1.12 21:02:12 INFO - mozcrash == 0.16 21:02:12 INFO - mozdebug == 0.1 21:02:12 INFO - mozdevice == 0.47 21:02:12 INFO - mozfile == 1.2 21:02:12 INFO - mozhttpd == 0.7 21:02:12 INFO - mozinfo == 0.9 21:02:12 INFO - mozleak == 0.1 21:02:12 INFO - mozlog == 3.0 21:02:12 INFO - moznetwork == 0.27 21:02:12 INFO - mozprocess == 0.22 21:02:12 INFO - mozprofile == 0.27 21:02:12 INFO - mozrunner == 6.11 21:02:12 INFO - mozscreenshot == 0.1 21:02:12 INFO - mozsystemmonitor == 0.0 21:02:12 INFO - moztest == 0.7 21:02:12 INFO - mozversion == 1.4 21:02:12 INFO - psutil == 3.1.1 21:02:12 INFO - requests == 1.2.3 21:02:12 INFO - wsgiref == 0.1.2 21:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc8b4902c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', '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 21:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 21:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 21:02:12 INFO - Using env: {'DISPLAY': ':0', 21:02:12 INFO - 'HOME': '/home/cltbld', 21:02:12 INFO - 'LANG': 'en_US.UTF-8', 21:02:12 INFO - 'LANGUAGE': 'en_US:en', 21:02:12 INFO - 'LOGNAME': 'cltbld', 21:02:12 INFO - 'MAIL': '/var/mail/cltbld', 21:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:12 INFO - 'MOZ_NO_REMOTE': '1', 21:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:12 INFO - 'NO_EM_RESTART': '1', 21:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:12 INFO - 'PWD': '/builds/slave/test', 21:02:12 INFO - 'SHELL': '/bin/bash', 21:02:12 INFO - 'SHLVL': '1', 21:02:12 INFO - 'TERM': 'linux', 21:02:12 INFO - 'TMOUT': '86400', 21:02:12 INFO - 'USER': 'cltbld', 21:02:12 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:12 INFO - '_': '/tools/buildbot/bin/python'} 21:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02: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 1)) 21:02: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 2)) 21:02: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 3)) 21:02: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 4)) 21:02: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 5)) 21:02: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 6)) 21:02: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 7)) 21:02: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 8)) 21:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:02: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 3)) 21:02: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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:02:13 INFO - Cleaning up... 21:02:13 INFO - Return code: 0 21:02:13 INFO - Running post-action listener: _resource_record_post_action 21:02:13 INFO - Running post-action listener: _start_resource_monitoring 21:02:13 INFO - Starting resource monitoring. 21:02:13 INFO - ##### 21:02:13 INFO - ##### Running install step. 21:02:13 INFO - ##### 21:02:13 INFO - Running pre-action listener: _resource_record_pre_action 21:02:13 INFO - Running main action method: install 21:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:13 INFO - Reading from file tmpfile_stdout 21:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:02:13 INFO - Reading from file tmpfile_stdout 21:02:13 INFO - Output received: 21:02:13 INFO - Usage: mozinstall [options] installer 21:02:13 INFO - Options: 21:02:13 INFO - -h, --help show this help message and exit 21:02:13 INFO - -d DEST, --destination=DEST 21:02:13 INFO - Directory to install application into. [default: 21:02:13 INFO - "/builds/slave/test"] 21:02:13 INFO - --app=APP Application being installed. [default: firefox] 21:02:13 INFO - mkdir: /builds/slave/test/build/application 21:02:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:02:27 INFO - Reading from file tmpfile_stdout 21:02:27 INFO - Output received: 21:02:27 INFO - /builds/slave/test/build/application/firefox/firefox 21:02:27 INFO - Running post-action listener: _resource_record_post_action 21:02:27 INFO - ##### 21:02:27 INFO - ##### Running run-tests step. 21:02:27 INFO - ##### 21:02:27 INFO - Running pre-action listener: _resource_record_pre_action 21:02:27 INFO - Running main action method: run_tests 21:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:02:27 INFO - Python 2.7.3 21:02:27 INFO - Return code: 0 21:02:27 INFO - grabbing minidump binary from tooltool 21:02:27 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')]} 21:02:27 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1121b70>, '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 0x1172dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:02:27 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 21:02:27 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 21:02:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:27 INFO - Return code: 0 21:02:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:02:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:02:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:02:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:02:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test/build 21:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 21:02:27 INFO - Using env: {'DISPLAY': ':0', 21:02:27 INFO - 'HOME': '/home/cltbld', 21:02:27 INFO - 'LANG': 'en_US.UTF-8', 21:02:27 INFO - 'LANGUAGE': 'en_US:en', 21:02:27 INFO - 'LOGNAME': 'cltbld', 21:02:27 INFO - 'MAIL': '/var/mail/cltbld', 21:02:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:02:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:27 INFO - 'MOZ_NO_REMOTE': '1', 21:02:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:27 INFO - 'NO_EM_RESTART': '1', 21:02:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:27 INFO - 'PWD': '/builds/slave/test', 21:02:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:02:27 INFO - 'SHELL': '/bin/bash', 21:02:27 INFO - 'SHLVL': '1', 21:02:27 INFO - 'TERM': 'linux', 21:02:27 INFO - 'TMOUT': '86400', 21:02:27 INFO - 'USER': 'cltbld', 21:02:27 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317', 21:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:27 INFO - '_': '/tools/buildbot/bin/python'} 21:02:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 21:02:27 INFO - mozversion INFO | application_buildid: 20151118204944 21:02:27 INFO - mozversion INFO | application_changeset: 3c747d782958267e847037c20fa37e14abc4de6c 21:02:27 INFO - mozversion INFO | application_display_name: Nightly 21:02:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:02:27 INFO - mozversion INFO | application_name: Firefox 21:02:27 INFO - mozversion INFO | application_remotingname: firefox 21:02:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:02:27 INFO - mozversion INFO | application_vendor: Mozilla 21:02:27 INFO - mozversion INFO | application_version: 45.0a1 21:02:27 INFO - mozversion INFO | platform_buildid: 20151118204944 21:02:27 INFO - mozversion INFO | platform_changeset: 3c747d782958267e847037c20fa37e14abc4de6c 21:02:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:02:27 INFO - mozversion INFO | platform_version: 45.0a1 21:02:27 INFO - 2015-11-18 21:02:27,726 DEBUG : using testdate: 1447909347 21:02:27 INFO - 2015-11-18 21:02:27,726 DEBUG : actual date: 1447909347 21:02:27 INFO - 2015-11-18 21:02:27,733 INFO : starting webserver on 'localhost:39212' 21:02:27 INFO - 2015-11-18 21:02:27,734 INFO : Starting test suite talos-linux64-ix-011 21:02:27 INFO - 2015-11-18 21:02:27,734 INFO : Starting test dromaeo_css 21:02:27 INFO - 2015-11-18 21:02:27,734 DEBUG : operating with platform_type : linux_ 21:02:27 INFO - 2015-11-18 21:02:27,735 INFO : Initialising browser for dromaeo_css test... 21:02:27 INFO - 2015-11-18 21:02:27,743 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGu3zBI/profile http://localhost:39212/getInfo.html 21:02:34 INFO - 2015-11-18 21:02:34,910 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:02:34 INFO - 2015-11-18 21:02:34,910 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:02:34 INFO - 2015-11-18 21:02:34,910 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:02:34 INFO - 2015-11-18 21:02:34,910 DEBUG : BROWSER_OUTPUT: __metrics 21:02:35 INFO - 2015-11-18 21:02:35,052 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:02:36 INFO - 2015-11-18 21:02:36,512 INFO : Browser initialized. 21:02:36 INFO - 2015-11-18 21:02:36,513 INFO : Running cycle 1/1 for dromaeo_css test... 21:02:36 INFO - 2015-11-18 21:02:36,513 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGu3zBI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:02:48 INFO - 2015-11-18 21:02:48,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 21:02:48 INFO - 2015-11-18 21:02:48,554 DEBUG : BROWSER_OUTPUT: 21:03:39 INFO - 2015-11-18 21:03:39,793 DEBUG : BROWSER_OUTPUT: 1447909419791 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] 21:05:51 INFO - 2015-11-18 21:05:51,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39212/tests/dromaeo/cssquery-ext.html) 21:05:52 INFO - 2015-11-18 21:05:52,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 250241024 21:05:52 INFO - 2015-11-18 21:05:52,665 DEBUG : BROWSER_OUTPUT: 21:08:55 INFO - 2015-11-18 21:08:55,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-ext.html (next: http://localhost:39212/tests/dromaeo/cssquery-jquery.html) 21:08:55 INFO - 2015-11-18 21:08:55,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 211894272 21:08:55 INFO - 2015-11-18 21:08:55,694 DEBUG : BROWSER_OUTPUT: 21:11:57 INFO - 2015-11-18 21:11:57,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39212/tests/dromaeo/cssquery-mootools.html) 21:11:58 INFO - 2015-11-18 21:11:58,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 207728640 21:11:58 INFO - 2015-11-18 21:11:58,188 DEBUG : BROWSER_OUTPUT: 21:15:00 INFO - 2015-11-18 21:15:00,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39212/tests/dromaeo/cssquery-prototype.html) 21:15:00 INFO - 2015-11-18 21:15:00,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 197750784 21:15:00 INFO - 2015-11-18 21:15:00,774 DEBUG : BROWSER_OUTPUT: 21:18:03 INFO - 2015-11-18 21:18:03,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39212/tests/dromaeo/cssquery-yui.html) 21:18:04 INFO - 2015-11-18 21:18:04,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 206647296 21:18:04 INFO - 2015-11-18 21:18:04,099 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/dromaeo/cssquery-yui.html (next: http://localhost:39212/tests/dromaeo/cssquery-dojo.html) 21:21:06 INFO - 2015-11-18 21:21:06,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 247332864 21:21:06 INFO - 2015-11-18 21:21:06,952 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,953 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:21:06 INFO - 2015-11-18 21:21:06,953 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:21:06 INFO - 2015-11-18 21:21:06,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:21:06 INFO - 2015-11-18 21:21:06,954 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:21:06 INFO - 2015-11-18 21:21:06,955 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.1525911708254;2699.5275826730317;2737.7946654000943;2740.7944404169693;2755;4515.300128480083;4576.313552967056;4653.6044436222965;4688.109259240742;4692.085043416535;4571.3600095986585;4608.5852273295395;4620.330052142437;4701.717896926187;4716;4293.076988447483;4301.419308393358;4309.461317335333;4338.284183109791;4360.10617823347;4083.4895638045246;4392.0557080227745;4423.66822488313;4451.243288640922;4468.4414448193975;4270.935935960963;4280.550542193072;4350.086481838817;4368.868933931987;4377.058932329564;4313.051128751669;4326.437563116806;4332.523422423531;4350.58669426404;4365.148795984785;4105.0763578194965;4305.375720520507;4319.8488052918;4327.221100201962;4370.060437006059;4579.015511665008;4587.7706114694465;4684.36761037259;4693.296005599153;4718.811247550128;5078.060558796635;5095.643304968654;5103.56619687327;5107.61692873036;5141.485851414866;4796.5203479651755;4927.852164435073;5127.9743601282125;5150.27896094547;5157.071727089123;4622.583967442946;4655.278431843104;4709.199436095803;4744.928826067612;4778.5699287063635;5137.794488220504;5139.306193663882;5146.279520867081;5181.481851814864;5196.68819870809;4719.976400117977;4840.927386089212;4927.975360123248;4933.802647894044;4950.480199579064;4855.174620314484;4989.850304490871;5059.8988020239385;5064.569511591482;5081.00920320534;4968.975155124202;4972.975135124301;4978.103941290602;5011.223260394645;5017.096922553976;4693.272542755878;4827.034593081397;4943.110240156734;4972.303877457159;4993.7503124843615;4057.69567282455;4071.9389209161886;4120.175964806991;4138.317177665712;4176.7076304658385;3662.1943172502006;3668.211334563082;3685.7788532687587;3700.888973330804;3711.9443208351895;4063.7358571692744;4168.687348448879;4327.610515053598;4334.718243314174;4379.627731642782;4871.707697538159;4933.309336692866;4945.109880221523;4945.530174633404;4987.650864439527;4360.825566977349;4407.801648925806;4412.294032954776;4416.646668266531;4450.332450132506;4227.133437645275;4339.1104823511105;4569.977150114228;4570.497245303014;4597.747123908217;4681.67228294023;4740.7392593407;4802.087603355351;4839.128956787812;4843.321934929042;5032.194848824171;5129.769160387867;5133.281340612392;5138.691678499302;5179.093658609803;4481.932771008373;4833.3958255218095;4857.53853383928;4861.611071114373;4906.681065730716;4793.13723529768;4811.903761924812;4934.457209707001;5007.824726134568;5047;5052.393712754493;5085.5931525477135;5087.160618497906;5090.898182036412;5127.717975511234;4573.679842410999;4900.068986892479;4905.043516514245;4907.871189626478;4908.214685650279;4717.528247175255;4764.166270902509;4779.426468823764;4780.139574876555;4804.01517688866;4786.329913812138;4787.40157480315;4799.352087468287;4807.351007613927;4828.8792780180775;4701.741404222664;4929.482404347492;4940.60475161979;4942.357493525818;4957.132501812096;4563.269876819693;4571.679982401333;4702.647301452474;4784.593309568726;4804.807807687793 21:21:06 INFO - 2015-11-18 21:21:06,959 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.0231836656164;569.9344575373831;580.9854753631162;581.2850194261058;587.5710731166247;25109.121180758677;34009.659903400956;34374.828125859334;34394.82802585984;34407.13982150441;39770.403443948366;41108;41112.58887411125;41113.383299250534;41114.58885411153;6940.930590694079;7064.152301723775;8087.110417854032;8234.83530329393;8237.917620823804;10306.587736490532;10475.476226188699;10551.261411701184;10564.049235568797;10568.101711354544;10216.693499195037;10257.589696412135;10280.485975701185;10298.691039268797;10298.691039268833;7140;7333.486655934087;7338.119425668954;7357.705691772323;10185;7028.543144695578;10279.588816447333;10583.523741431654;10585.523651435627;10592.894071059267;37249.44125838114;37790.81104594487;37818.621813781785;37840;37870;2822.040506227872;2831.8725657345262;2901;3469.6356882527225;3715.442683597455;28595.285117872012;28609.76518822214;29064.12807615775;29174.41651166986;29783.25541861449;2839.5882597023524;2940.617719696426;2978.9851050744824;3026.243439140215;3035.438443887888;249674;254998;255317;255541.72229138922;256484;57197.14204286939;57799.4220057794;57923.71038144867;58004.4199557999;58039;61553;61673.383266167664;61866;62144.68927655333;62260.377396226366;12066.336351500751;12252.754944901051;12258.938705306417;12405.75188496225;12405.937970310091;9501.952490237505;9609.51952402391;9609.567569459392;9614.086661767122;9615.807683846284;19605.411837644893;19833.305834296018;19885.403437896886;19934.50163745918;20019.09914053871;7736.303732664087;7870.645820938072;7967;7972.202779722097;7981;796.3987189671876;805.9234372734699;886.472548833443;925.486355072941;1059.51262419288;26376;26406.072977545693;26443.735562644128;26644.333891652863;26747.319219136574;832.4672209785742;880.5685214244974;901.5312037740339;934.514052692596;1007.5667462990984;13530.323483825769;13960.720785584232;14089.636832625709;14172.149671019772;14215.50245741394;331698;333828;334187;336074;336457;48638.270425943636;49105.75447122742;49219;49262;49306.260406093934;1048.9895101049044;1090.0788833435734;1097.308695521832;1108.4014632098576;1111.8665760108677;25303.240902772945;25827.483450331263;26465.206043818715;26604;26781.46437071209;39592.208155836146;40189;40207.59792402039;40210.39684404678;40243;244796;245954;246775;246823;246871;24654;25135.74864251334;29144.417111658073;29655.85172074126;29730.55404168896;36585.817070914476;37066.258674826895;37270;37779.43330850094;38138.42792358062;31923;32405.35189296248;32830.83584582062;33293.83353083219;33317;26152.60771088397;32106.19734506656;32197;32424.83787581047;33037.17407064843;29674.554881677224;30117.69882301149;30178;30193.245168870955;30233.69766302309;24347.878260608584;27587.31031724223;27801.304967375167;28381.574276385458;29852.850735746182;22851.71577816114;23019.88490057539;23254.41863953347;23419.765802341757;25323.493530128926 21:21:06 INFO - 2015-11-18 21:21:06,959 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.57386233135946;310.968903109689;311.8409611098339;314.3932210833094;314.867755542672;11832.23090499117;12135.271883686984;14836.332365043572;14987.625309367259;15187.46843860465;14383.568492945229;14761.55715328542;14813.333399996998;15230.314635841387;15242.314095865684;3971.6028397160344;4343.978280108595;4689.460712018119;4844.055409195208;4860.343853579757;3552.1652411683235;3679.7240206984584;4770.21291486906;5336.38631557372;5507.504324610784;5575.303087114111;5580.135079062731;5592.86017849555;5593.944060559383;5621.297337832771;5445.809396671118;5538.224648549206;5576.749046292886;5580.693061881595;5582.665040097607;4804.567588917014;4806.663533552653;4813.975930120362;4819.9036019279765;4821.855344339676;18506.35227767035;18798.53003674919;19147.904260478746;19375.3218637347;19386.127624256802;542.3573065916901;543.3479824210963;543.4348277791092;543.5542854859017;1721.0913556090293;12076.335801530913;12361.32012739299;12492.0630952678;12547.184433011826;12718.173318734252;1754.2544418622163;1781.1361489677497;1793.7219730941724;1823.0520129532702;1849.260295881658;50154.49845501571;51113.48886511162;51547;51766.99999999962;51973.7401312991;8393.496390216607;8410;8623.741287761377;8652.74041778735;8687.34844886636;10571.735706607396;10577.153827693919;10585.206109541816;10604.787904241872;10630.946845265724;6478.902816457757;6511.0558968949235;6513.348665133543;6568.474522038226;6588.868222635616;6190.566660333823;6207.503399728011;6223.284322302902;6321.051842223703;6354.3010268870385;5377.865553361197;5405.945940540623;5419.214213939035;5425.9186112208345;5470.070088084955;1408.4084684432562;1471;1477.8596033377028;1481.2667729473765;1522.956774609396;762.4434163060886;809.8339840332718;828.5939889454245;947.2989987409268;952.7951490429591;16244.67510649804;16437;16591.917040414963;16982.40561580339;17061.40285090016;404.63784912503144;405.35548477920247;407.60055145956534;413.179838021527;417.607448997947;5585.273914391184;5585.609007369527;5597.720113994284;5657.57568182388;5757.107648314518;393331;475960;485016;493343;495264;57244.71377643085;58524.707376463695;59728.70135649294;62213;65813.67093164503;463.6870112673932;475.2419890275006;475.97858096385744;476.4877756411871;477.12685785013343;9350.906490935276;9376.109269619375;9413.058694130532;9567.952160239154;9585.281103917094;30573;30735.385292294475;31520.527192092595;32045;32085.197870053435;41850.58149418467;42000.57999419967;42081.78959105185;43137.35293970656;43174.78412607917;5549.72251387421;5757.366689664217;5758.510526605285;5760.6255593386295;5973.074173503114;10136.543855526372;10166.796664066826;10168.186545076524;10227.795444090927;10389.48052597352;9677.564509597225;9693.41839489633;9714.125728684452;9734.075262850018;9791.461469618955;9342.626294948397;9347.532623368668;9370.203532699798;9422.858657120012;9714;9521.238300936047;9642.132208101304;9708.805823883624;10004.949480304464;10015.549300281651;5711.971440142773;5773.1051686988585;5799.82600521985;5804.448577385142;5804.564657650609;9199.09585801185;9519.524023798644;9545.140937315675;9589.808203835744;9719.611215551582 21:21:06 INFO - 2015-11-18 21:21:06,962 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1385.2727318157959;1622.456477080178;1633.1017940132924;1644.087531420062;1685.7471379293108;5478.315210598676;6281.780137695182;6475.611463312204;6476.708548115334;6476.8380790480205;6595.1096601958725;6697.631630260346;6702.865942681144;6704.061431399596;6705.497087718429;1621.26232564183;1642.1132588402309;1935.1968932892903;1996.8702034367757;2018.5760990192077;1993.083181736403;1996.5308152584132;1999.4901300168438;2000.3998800359907;2001.949951251216;1939.94180174595;1956.8923709195988;1992.1533348326975;1996.9700454493195;1998.1807458941837;1955.3742802303268;1984.3848406993807;1991.4822146242082;1996.0219492448741;2008.3673642802544;1974.7037944308468;1989.5622962948273;1991.332903477337;1993.6511110555596;1997.670384386589;6751.088603038576;6795.286494918061;6811.591304521745;6814.386705196556;6829.043933849265;3948.3879998599978;4048.291548978946;4049.2913740095364;4052.027513396793;4056.4523789288364;2317.40906068953;2619.292790946434;2764.3227409284855;2788.2750484873877;2810.747032767061;766.6051983228642;836.0928392693935;842.4439869685978;866.9263112635433;896.8475359188953;8929.598168082452;8958.104189581056;8966.730998070003;8986.955065224633;9039.141281578306;3691.7231207659534;3694.5751238607368;3720.7023438125425;3777.0934975606206;3778.24435112973;7815.726449574237;7829.138794732575;7829.256220659028;7845;7856.25365590268;4037.515498140242;4070.247004304154;4076.1236334188293;4079.5104587449696;4080.020795009236;3715.1640880802142;3716.479692843004;3719.330520506335;3720.1443667956523;3722.7952462614817;3275.1484614000533;3289.7203737682084;3298.993806888874;3313.9171520712175;3319.867205311809;1010.2726037253166;1013.2096964367805;1020.6937918624383;1031.138998935882;1034.234666346913;859.1108203009854;918.9891119768201;1168.4391492083678;1176.9058475321954;1185.247367921359;6169.136320915076;6239.812805615838;6261.874762504815;6271.6550589718;6284;998.6205242007991;1005.1255407795119;1036.2953191829629;1043.9895601044045;1074.4681382715605;5168;5217.165253559412;5219.895602087937;5226.869328266824;5228.503292187313;7060.71757129709;7213.098362704662;7558.697652093964;7590.278923502258;7651.846963060708;7540.886886696704;7714.15144334134;7732.110807257125;7741.845163096819;7772.7668169954995;6358.936410635927;6414.486841052704;6422.165118534561;6426;6440.0661904023655;6223;6408.102865598913;6418;6439.356064393523;6440.388163124496;7166.175889772534;7230.783076507713;7309.853802924018;7465.253474652492;7474.887876681745;7400.592967386845;7520.435967302365;7597.848043038997;7676.270754278335;7687.654055567401;6538.967305163444;6618.437432818072;6618.536702430783;6622.304658010839;6638.037484564615;6564.146660934048;6568.27748947625;6587.901181482377;6666.366695163952;6723.4957378197805;6352.618842869442;6364.840878977878;6369.649669268235;6423.197100362455;6502.837429064311;6239.344868788893;6240.095186198067;6253.09330147117;6355.745770169141;6364.936350636434;6183.84540386494;6189.35011823752;6295.96852015737;6302.117703521419;6335.746570137143;5696.829095127153;5735.168400581976;5738.569607279387;5743.253377061123;5761.683107429131;5994.250718660168;5999.550033747573;6031.728572214173;6057.939420605914;6058.182145410313 21:21:06 INFO - 2015-11-18 21:21:06,964 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.8246730858596;278.4250522670686;279.90343331550616;285.8870746055308;286.46431173705173;5231.293775340328;5263.631545791796;5345.0646136926025;5347.973260133699;5383.59623028273;5221.86945326367;5399.136138217886;5410.702411367373;5416.4312747161575;5418.8916221675645;4178.143480586487;4179.979100104495;4182.477190351206;4184.288670925935;4184.309588917825;3929.764214147146;4007.519097708279;4182.686298527623;4185.539590645027;4186.937195942063;3965.6232657897453;4026.8590599329027;4045.9595404045876;4060.0255938574824;4076.5311989121333;4055.7363771354767;4058.69559783016;4062.7156099073077;4065.2479291331197;4065.3292206785845;3517.4196257617464;3519.8384533104013;3523.894283171509;3524.84138213781;3525.8589656413715;5220.738963051832;5223.451537588537;5228.163493840967;5233.267342572043;5240.423553409122;4585;4735.73953432561;4738.597219236369;4746;4750.762461876892;5656;5670.064439367499;5673.560369041311;5675.744591493351;5676.716164191774;3718.9442158367647;3834.9424758628643;3923.7645741255615;3926.921461570781;3928.626780455852;5833.416658334175;5967.313758917693;5984.670843103628;5989.3112292086535;5992.310884248323;4011.859584914514;4036.0313524754433;4036.8183431745642;4041.8989525262105;4043.292423825819;4099.426080348753;4100.897477563025;4113.753174809462;4115.32097203958;4115.855945041909;4600.677952543289;4700.929486057712;4709.0817290628;4720.645951553579;4737.715737055788;5685.488306052475;5689.943100569024;5690.089585666274;5694.06048002075;5696.829095127153;1424.3875133692611;1452.8329242137079;1452.978205326921;1454.4763885001391;1455.3450947073648;953.1374106433689;964.7346979580672;975.2490582251627;993.6770549571419;997.5560875410517;4944.381952255968;4972.875678108004;4979.228219625964;4980.078685443204;4989.975050124726;5850.473457388855;5874.295084589877;5877.4122587740885;5881.5882888198275;5882.970585147133;4956.231784073474;4961.925571116436;4968.205087186033;4970.527799859007;4975.179095449283;3102.1779228504465;3151.700588444094;3178.7298079663487;3187.6493585705553;3201.9199520012185;5588.860278492989;5634.464725851038;5654.830355089354;5681.34664513578;5683.0338842396895;6150.138980542728;6152.876942461216;6153.077038444269;6158.230221222348;6164.383561643889;5659.830205093854;5674.716264186774;5676.886462270814;5677.744501497443;5685.232493613392;5768.855778605568;5974.312954010345;5981.342052374148;5984.281886173687;5991.281046274475;5583;5820.272465941757;5832.387599302012;5834.416558344132;5835.649861008353;5502.724863756876;5559.63862348946;5635.408282130317;5658.85852853682;5683.119116536944;3983.581723918947;4056.350983842571;4073.85741499058;4074.0425999890595;4076.144009757984;5868.647881127146;5896.14505896634;5898.056310990221;5899.557533184942;5906.143609176731;5508.678701795209;5596.608237423504;5622.156676498558;5625.268715067015;5643.012472817159;5582.441755824548;5587.916181257366;5588.832335029955;5593.105103183471;5604.8318550443555;5510.3938566758425;5530.585206109638;5535.142052981794;5538.501534861882;5542.140968149944;5565.972170139124;5704.11586204139;5706.172604972338;5706.657600543981;5724.169995350568;5485.094959331665;5519.254900588369;5521.944780552143;5523.171524271231;5529.419410961791 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: |5;yui.html;630.1241274628268;663.7311888685084;722.2127880610135;777.7161336112318;810.0239211749835;11617.18679692422;11654.009409200218;11845.881541184597;11871.584494542682;12699.61901142965;12247;12257.570985015525;12298;12374.505019799197;12386.442610082546;610.1031483718948;618.2395653346387;783.6865253898443;794.8370584030259;803.3252068262658;795.5346122518333;802.1497212954258;805.1023109233192;808.2119933065273;808.2523665609287;826.68999125328;843.4981186194204;844.890164278646;845.5265051571109;845.5772113943028;638.7125793392969;647.1069923505556;818.0388044048279;832.8334333133337;834.9916500834975;613.3039000734154;616.5037145098194;619.4455961914061;620.3331418724889;620.5501011766478;12143.453544590426;12411.944984676313;12414.068944829174;12430.316332601704;12448.06639502032;10956.780864382747;11514.194006419553;11646.941765291203;11674.824877626843;12018.879811201863;9493.952530237373;9526.380785248937;9537.380070295478;9594.42433453995;9631.470269135194;3208.1658768720067;3225.179328943373;3252.3983063133396;3263;3266.6896644818703;34101.147471313416;40224.597754022376;40255;40381.59618403837;40393;6508.153939987866;6659.86680266392;6694.062831203635;6700.296468870796;6745.628990405575;10348.37909725404;10547.525361358757;10553.47232638365;10558.472076396303;10590.735231619117;5612.607117501817;5676.545876329884;5700.429957004267;5810.302763668386;5814.418558144236;3262.0866157475944;3296.027671836814;3296.093574267096;3310.155910242921;3423.58916929965;2398.2205783120557;2412.8311018228906;2423.0671191591364;2424.3090719144957;2428.8785560721894;368.48596208289285;369.7208607501319;370.25948103792416;370.97217708671957;385.27952728397514;392.8389360362238;566.1140315406376;569.0979797021766;583.6964778315253;604.2084868821858;7778;7940.761777146695;7945.32464740492;8019.318357939641;8219.219174178443;474.87653210164916;478.7773685236382;545.1985581195636;609.9176611157437;620.268083661284;3552.378333791576;3752.981235093807;3770.3967365221433;3830.157365379612;3846.942295865564;51190.74404627953;51538.74230628898;51732.482675173516;51813;51984.48015519872;45765;45843.31235031477;45990.310145347845;46580.301295480596;46616;41000;42095.57904420917;42273.78863105665;43198.352024719024;43213.567864320954;7598.12621548529;7666.19504951972;8037.879431808411;8068.870358149747;8527.232549070613;32091.35817283688;32668.83665581657;33123.33753324872;33296.1675958103;33527.664723352456;39339.60660393359;39930.80034599808;40054.39918401168;40465.79767101146;40972.590274096874;7159.964200178966;7225.783226503213;7514.135874374517;7590.392768578611;7783.844323113619;10879.78240435171;10890.29213101146;11591.362475063952;11743.530258789553;11838.467268972745;10636.734081648021;10725.141988641046;10762.19283553721;11154.609588664358;11515.424228788695;10858.185636077484;10892.346459212473;10903.618373356894;11340.773184536429;11352.829707554558;7714;9288.953555232181;9686.07982241686;9819.852702209615;11280.041196498389;8807.251383632207;8915.643374265217;9325.741024961544;9337.766555835886;9442.48066356357;9288.72133835986;9382.202512786489;9421.952890235505;9539.809203816023;9557.378770379903 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,954 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:21:06 INFO - 2015-11-18 21:21:06,965 DEBUG : BROWSER_OUTPUT: __startTimestamp1447910466951__endTimestamp 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4623.77 Median:4719.98 stddev:482.46 (10.2%) stddev-sans-first:458.37 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: Values: 2648.2 2699.5 2737.8 2740.8 2755.0 4515.3 4576.3 4653.6 4688.1 4692.1 4571.4 4608.6 4620.3 4701.7 4716.0 4293.1 4301.4 4309.5 4338.3 4360.1 4083.5 4392.1 4423.7 4451.2 4468.4 4270.9 4280.6 4350.1 4368.9 4377.1 4313.1 4326.4 4332.5 4350.6 4365.1 4105.1 4305.4 4319.8 4327.2 4370.1 4579.0 4587.8 4684.4 4693.3 4718.8 5078.1 5095.6 5103.6 5107.6 5141.5 4796.5 4927.9 5128.0 5150.3 5157.1 4622.6 4655.3 4709.2 4744.9 4778.6 5137.8 5139.3 5146.3 5181.5 5196.7 4720.0 4840.9 4928.0 4933.8 4950.5 4855.2 4989.9 5059.9 5064.6 5081.0 4969.0 4973.0 4978.1 5011.2 5017.1 4693.3 4827.0 4943.1 4972.3 4993.8 4057.7 4071.9 4120.2 4138.3 4176.7 3662.2 3668.2 3685.8 3700.9 3711.9 4063.7 4168.7 4327.6 4334.7 4379.6 4871.7 4933.3 4945.1 4945.5 4987.7 4360.8 4407.8 4412.3 4416.6 4450.3 4227.1 4339.1 4570.0 4570.5 4597.7 4681.7 4740.7 4802.1 4839.1 4843.3 5032.2 5129.8 5133.3 5138.7 5179.1 4481.9 4833.4 4857.5 4861.6 4906.7 4793.1 4811.9 4934.5 5007.8 5047.0 5052.4 5085.6 5087.2 5090.9 5127.7 4573.7 4900.1 4905.0 4907.9 4908.2 4717.5 4764.2 4779.4 4780.1 4804.0 4786.3 4787.4 4799.4 4807.4 4828.9 4701.7 4929.5 4940.6 4942.4 4957.1 4563.3 4571.7 4702.6 4784.6 4804.8 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43509.73 Median:3030.84 stddev:73699.63 (2431.7%) stddev-sans-first:73835.82 21:21:06 INFO - 2015-11-18 21:21:06,966 DEBUG : BROWSER_OUTPUT: Values: 556.0 569.9 581.0 581.3 587.6 25109.1 34009.7 34374.8 34394.8 34407.1 39770.4 41108.0 41112.6 41113.4 41114.6 6940.9 7064.2 8087.1 8234.8 8237.9 10306.6 10475.5 10551.3 10564.0 10568.1 10216.7 10257.6 10280.5 10298.7 10298.7 7140.0 7333.5 7338.1 7357.7 10185.0 7028.5 10279.6 10583.5 10585.5 10592.9 37249.4 37790.8 37818.6 37840.0 37870.0 2822.0 2831.9 2901.0 3469.6 3715.4 28595.3 28609.8 29064.1 29174.4 29783.3 2839.6 2940.6 2979.0 3026.2 3035.4 249674.0 254998.0 255317.0 255541.7 256484.0 57197.1 57799.4 57923.7 58004.4 58039.0 61553.0 61673.4 61866.0 62144.7 62260.4 12066.3 12252.8 12258.9 12405.8 12405.9 9502.0 9609.5 9609.6 9614.1 9615.8 19605.4 19833.3 19885.4 19934.5 20019.1 7736.3 7870.6 7967.0 7972.2 7981.0 796.4 805.9 886.5 925.5 1059.5 26376.0 26406.1 26443.7 26644.3 26747.3 832.5 880.6 901.5 934.5 1007.6 13530.3 13960.7 14089.6 14172.1 14215.5 331698.0 333828.0 334187.0 336074.0 336457.0 48638.3 49105.8 49219.0 49262.0 49306.3 1049.0 1090.1 1097.3 1108.4 1111.9 25303.2 25827.5 26465.2 26604.0 26781.5 39592.2 40189.0 40207.6 40210.4 40243.0 244796.0 245954.0 246775.0 246823.0 246871.0 24654.0 25135.7 29144.4 29655.9 29730.6 36585.8 37066.3 37270.0 37779.4 38138.4 31923.0 32405.4 32830.8 33293.8 33317.0 26152.6 32106.2 32197.0 32424.8 33037.2 29674.6 30117.7 30178.0 30193.2 30233.7 24347.9 27587.3 27801.3 28381.6 29852.9 22851.7 23019.9 23254.4 23419.8 25323.5 21:21:06 INFO - 2015-11-18 21:21:06,967 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,967 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24308.36 Median:272709.25 stddev:76803.99 (28.2%) stddev-sans-first:76998.30 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: Values: 306.6 311.0 311.8 314.4 314.9 11832.2 12135.3 14836.3 14987.6 15187.5 14383.6 14761.6 14813.3 15230.3 15242.3 3971.6 4344.0 4689.5 4844.1 4860.3 3552.2 3679.7 4770.2 5336.4 5507.5 5575.3 5580.1 5592.9 5593.9 5621.3 5445.8 5538.2 5576.7 5580.7 5582.7 4804.6 4806.7 4814.0 4819.9 4821.9 18506.4 18798.5 19147.9 19375.3 19386.1 542.4 543.3 543.4 543.6 1721.1 12076.3 12361.3 12492.1 12547.2 12718.2 1754.3 1781.1 1793.7 1823.1 1849.3 50154.5 51113.5 51547.0 51767.0 51973.7 8393.5 8410.0 8623.7 8652.7 8687.3 10571.7 10577.2 10585.2 10604.8 10630.9 6478.9 6511.1 6513.3 6568.5 6588.9 6190.6 6207.5 6223.3 6321.1 6354.3 5377.9 5405.9 5419.2 5425.9 5470.1 1408.4 1471.0 1477.9 1481.3 1523.0 762.4 809.8 828.6 947.3 952.8 16244.7 16437.0 16591.9 16982.4 17061.4 404.6 405.4 407.6 413.2 417.6 5585.3 5585.6 5597.7 5657.6 5757.1 393331.0 475960.0 485016.0 493343.0 495264.0 57244.7 58524.7 59728.7 62213.0 65813.7 463.7 475.2 476.0 476.5 477.1 9350.9 9376.1 9413.1 9568.0 9585.3 30573.0 30735.4 31520.5 32045.0 32085.2 41850.6 42000.6 42081.8 43137.4 43174.8 5549.7 5757.4 5758.5 5760.6 5973.1 10136.5 10166.8 10168.2 10227.8 10389.5 9677.6 9693.4 9714.1 9734.1 9791.5 9342.6 9347.5 9370.2 9422.9 9714.0 9521.2 9642.1 9708.8 10004.9 10015.5 5712.0 5773.1 5799.8 5804.4 5804.6 9199.1 9519.5 9545.1 9589.8 9719.6 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4766.96 Median:6206.18 stddev:2411.87 (38.9%) stddev-sans-first:2405.24 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: Values: 1385.3 1622.5 1633.1 1644.1 1685.7 5478.3 6281.8 6475.6 6476.7 6476.8 6595.1 6697.6 6702.9 6704.1 6705.5 1621.3 1642.1 1935.2 1996.9 2018.6 1993.1 1996.5 1999.5 2000.4 2001.9 1939.9 1956.9 1992.2 1997.0 1998.2 1955.4 1984.4 1991.5 1996.0 2008.4 1974.7 1989.6 1991.3 1993.7 1997.7 6751.1 6795.3 6811.6 6814.4 6829.0 3948.4 4048.3 4049.3 4052.0 4056.5 2317.4 2619.3 2764.3 2788.3 2810.7 766.6 836.1 842.4 866.9 896.8 8929.6 8958.1 8966.7 8987.0 9039.1 3691.7 3694.6 3720.7 3777.1 3778.2 7815.7 7829.1 7829.3 7845.0 7856.3 4037.5 4070.2 4076.1 4079.5 4080.0 3715.2 3716.5 3719.3 3720.1 3722.8 3275.1 3289.7 3299.0 3313.9 3319.9 1010.3 1013.2 1020.7 1031.1 1034.2 859.1 919.0 1168.4 1176.9 1185.2 6169.1 6239.8 6261.9 6271.7 6284.0 998.6 1005.1 1036.3 1044.0 1074.5 5168.0 5217.2 5219.9 5226.9 5228.5 7060.7 7213.1 7558.7 7590.3 7651.8 7540.9 7714.2 7732.1 7741.8 7772.8 6358.9 6414.5 6422.2 6426.0 6440.1 6223.0 6408.1 6418.0 6439.4 6440.4 7166.2 7230.8 7309.9 7465.3 7474.9 7400.6 7520.4 7597.8 7676.3 7687.7 6539.0 6618.4 6618.5 6622.3 6638.0 6564.1 6568.3 6587.9 6666.4 6723.5 6352.6 6364.8 6369.6 6423.2 6502.8 6239.3 6240.1 6253.1 6355.7 6364.9 6183.8 6189.4 6296.0 6302.1 6335.7 5696.8 5735.2 5738.6 5743.3 5761.7 5994.3 5999.6 6031.7 6057.9 6058.2 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,968 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4691.74 Median:5391.37 stddev:1399.79 (26.0%) stddev-sans-first:1363.84 21:21:06 INFO - 2015-11-18 21:21:06,969 DEBUG : BROWSER_OUTPUT: Values: 271.8 278.4 279.9 285.9 286.5 5231.3 5263.6 5345.1 5348.0 5383.6 5221.9 5399.1 5410.7 5416.4 5418.9 4178.1 4180.0 4182.5 4184.3 4184.3 3929.8 4007.5 4182.7 4185.5 4186.9 3965.6 4026.9 4046.0 4060.0 4076.5 4055.7 4058.7 4062.7 4065.2 4065.3 3517.4 3519.8 3523.9 3524.8 3525.9 5220.7 5223.5 5228.2 5233.3 5240.4 4585.0 4735.7 4738.6 4746.0 4750.8 5656.0 5670.1 5673.6 5675.7 5676.7 3718.9 3834.9 3923.8 3926.9 3928.6 5833.4 5967.3 5984.7 5989.3 5992.3 4011.9 4036.0 4036.8 4041.9 4043.3 4099.4 4100.9 4113.8 4115.3 4115.9 4600.7 4700.9 4709.1 4720.6 4737.7 5685.5 5689.9 5690.1 5694.1 5696.8 1424.4 1452.8 1453.0 1454.5 1455.3 953.1 964.7 975.2 993.7 997.6 4944.4 4972.9 4979.2 4980.1 4990.0 5850.5 5874.3 5877.4 5881.6 5883.0 4956.2 4961.9 4968.2 4970.5 4975.2 3102.2 3151.7 3178.7 3187.6 3201.9 5588.9 5634.5 5654.8 5681.3 5683.0 6150.1 6152.9 6153.1 6158.2 6164.4 5659.8 5674.7 5676.9 5677.7 5685.2 5768.9 5974.3 5981.3 5984.3 5991.3 5583.0 5820.3 5832.4 5834.4 5835.6 5502.7 5559.6 5635.4 5658.9 5683.1 3983.6 4056.4 4073.9 4074.0 4076.1 5868.6 5896.1 5898.1 5899.6 5906.1 5508.7 5596.6 5622.2 5625.3 5643.0 5582.4 5587.9 5588.8 5593.1 5604.8 5510.4 5530.6 5535.1 5538.5 5542.1 5566.0 5704.1 5706.2 5706.7 5724.2 5485.1 5519.3 5521.9 5523.2 5529.4 21:21:06 INFO - 2015-11-18 21:21:06,969 DEBUG : BROWSER_OUTPUT: 21:21:06 INFO - 2015-11-18 21:21:06,970 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12128.33 Median:46598.15 stddev:14236.72 (30.6%) stddev-sans-first:14250.48 21:21:06 INFO - 2015-11-18 21:21:06,970 DEBUG : BROWSER_OUTPUT: Values: 630.1 663.7 722.2 777.7 810.0 11617.2 11654.0 11845.9 11871.6 12699.6 12247.0 12257.6 12298.0 12374.5 12386.4 610.1 618.2 783.7 794.8 803.3 795.5 802.1 805.1 808.2 808.3 826.7 843.5 844.9 845.5 845.6 638.7 647.1 818.0 832.8 835.0 613.3 616.5 619.4 620.3 620.6 12143.5 12411.9 12414.1 12430.3 12448.1 10956.8 11514.2 11646.9 11674.8 12018.9 9494.0 9526.4 9537.4 9594.4 9631.5 3208.2 3225.2 3252.4 3263.0 3266.7 34101.1 40224.6 40255.0 40381.6 40393.0 6508.2 6659.9 6694.1 6700.3 6745.6 10348.4 10547.5 10553.5 10558.5 10590.7 5612.6 5676.5 5700.4 5810.3 5814.4 3262.1 3296.0 3296.1 3310.2 3423.6 2398.2 2412.8 2423.1 2424.3 2428.9 368.5 369.7 370.3 371.0 385.3 392.8 566.1 569.1 583.7 604.2 7778.0 7940.8 7945.3 8019.3 8219.2 474.9 478.8 545.2 609.9 620.3 3552.4 3753.0 3770.4 3830.2 3846.9 51190.7 51538.7 51732.5 51813.0 51984.5 45765.0 45843.3 45990.3 46580.3 46616.0 41000.0 42095.6 42273.8 43198.4 43213.6 7598.1 7666.2 8037.9 8068.9 8527.2 32091.4 32668.8 33123.3 33296.2 33527.7 39339.6 39930.8 40054.4 40465.8 40972.6 7160.0 7225.8 7514.1 7590.4 7783.8 10879.8 10890.3 11591.4 11743.5 11838.5 10636.7 10725.1 10762.2 11154.6 11515.4 10858.2 10892.3 10903.6 11340.8 11352.8 7714.0 9289.0 9686.1 9819.9 11280.0 8807.3 8915.6 9325.7 9337.8 9442.5 9288.7 9382.2 9422.0 9539.8 9557.4 21:21:06 INFO - 2015-11-18 21:21:06,970 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:21:06 INFO - 2015-11-18 21:21:06,970 DEBUG : BROWSER_OUTPUT: 21:21:07 INFO - 2015-11-18 21:21:07,660 INFO : Browser exited with error code: 0 21:21:07 INFO - 2015-11-18 21:21:07,681 INFO : Completed test dromaeo_css (00:18:39) 21:21:07 INFO - 2015-11-18 21:21:07,681 INFO : Starting test kraken 21:21:07 INFO - 2015-11-18 21:21:07,681 DEBUG : operating with platform_type : linux_ 21:21:07 INFO - 2015-11-18 21:21:07,681 INFO : Initialising browser for kraken test... 21:21:07 INFO - 2015-11-18 21:21:07,687 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY1dQxd/profile http://localhost:39212/getInfo.html 21:21:12 INFO - 2015-11-18 21:21:12,091 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:21:12 INFO - 2015-11-18 21:21:12,091 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:21:12 INFO - 2015-11-18 21:21:12,091 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:21:12 INFO - 2015-11-18 21:21:12,091 DEBUG : BROWSER_OUTPUT: __metrics 21:21:12 INFO - 2015-11-18 21:21:12,228 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:21:13 INFO - 2015-11-18 21:21:13,001 DEBUG : BROWSER_OUTPUT: console.error: 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: Stack: 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 21:21:13 INFO - 2015-11-18 21:21:13,002 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 21:21:13 INFO - 2015-11-18 21:21:13,004 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 21:21:13 INFO - 2015-11-18 21:21:13,004 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 21:21:13 INFO - 2015-11-18 21:21:13,004 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 21:21:13 INFO - 2015-11-18 21:21:13,004 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 21:21:13 INFO - 2015-11-18 21:21:13,005 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 21:21:13 INFO - 2015-11-18 21:21:13,005 DEBUG : BROWSER_OUTPUT: 21:21:13 INFO - 2015-11-18 21:21:13,608 INFO : Browser initialized. 21:21:13 INFO - 2015-11-18 21:21:13,608 INFO : Running cycle 1/1 for kraken test... 21:21:13 INFO - 2015-11-18 21:21:13,608 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY1dQxd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:21:25 INFO - 2015-11-18 21:21:25,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 140099584 21:21:25 INFO - 2015-11-18 21:21:25,592 DEBUG : BROWSER_OUTPUT: 21:21:28 INFO - 2015-11-18 21:21:28,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39212/tests/kraken/driver.html?testName=audio-beat-detection) 21:21:28 INFO - 2015-11-18 21:21:28,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 179236864 21:21:28 INFO - 2015-11-18 21:21:28,819 DEBUG : BROWSER_OUTPUT: 21:21:31 INFO - 2015-11-18 21:21:31,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39212/tests/kraken/driver.html?testName=audio-dft) 21:21:32 INFO - 2015-11-18 21:21:32,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 168038400 21:21:32 INFO - 2015-11-18 21:21:32,109 DEBUG : BROWSER_OUTPUT: 21:21:35 INFO - 2015-11-18 21:21:35,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39212/tests/kraken/driver.html?testName=audio-fft) 21:21:35 INFO - 2015-11-18 21:21:35,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 151867392 21:21:35 INFO - 2015-11-18 21:21:35,666 DEBUG : BROWSER_OUTPUT: 21:21:37 INFO - 2015-11-18 21:21:37,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39212/tests/kraken/driver.html?testName=audio-oscillator) 21:21:38 INFO - 2015-11-18 21:21:38,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 154558464 21:21:38 INFO - 2015-11-18 21:21:38,305 DEBUG : BROWSER_OUTPUT: 21:21:40 INFO - 2015-11-18 21:21:40,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:21:41 INFO - 2015-11-18 21:21:41,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 156819456 21:21:41 INFO - 2015-11-18 21:21:41,100 DEBUG : BROWSER_OUTPUT: 21:21:44 INFO - 2015-11-18 21:21:44,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39212/tests/kraken/driver.html?testName=imaging-darkroom) 21:21:44 INFO - 2015-11-18 21:21:44,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 155717632 21:21:44 INFO - 2015-11-18 21:21:44,641 DEBUG : BROWSER_OUTPUT: 21:21:48 INFO - 2015-11-18 21:21:48,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39212/tests/kraken/driver.html?testName=imaging-desaturate) 21:21:48 INFO - 2015-11-18 21:21:48,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 156520448 21:21:48 INFO - 2015-11-18 21:21:48,691 DEBUG : BROWSER_OUTPUT: 21:21:51 INFO - 2015-11-18 21:21:51,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39212/tests/kraken/driver.html?testName=json-parse-financial) 21:21:52 INFO - 2015-11-18 21:21:52,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 155590656 21:21:52 INFO - 2015-11-18 21:21:52,075 DEBUG : BROWSER_OUTPUT: 21:21:53 INFO - 2015-11-18 21:21:53,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:21:54 INFO - 2015-11-18 21:21:54,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 167297024 21:21:54 INFO - 2015-11-18 21:21:54,409 DEBUG : BROWSER_OUTPUT: 21:21:56 INFO - 2015-11-18 21:21:56,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:21:56 INFO - 2015-11-18 21:21:56,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 167739392 21:21:56 INFO - 2015-11-18 21:21:56,897 DEBUG : BROWSER_OUTPUT: 21:21:59 INFO - 2015-11-18 21:21:59,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:21:59 INFO - 2015-11-18 21:21:59,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 173830144 21:21:59 INFO - 2015-11-18 21:21:59,618 DEBUG : BROWSER_OUTPUT: 21:22:02 INFO - 2015-11-18 21:22:02,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:22:02 INFO - 2015-11-18 21:22:02,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 182628352 21:22:02 INFO - 2015-11-18 21:22:02,723 DEBUG : BROWSER_OUTPUT: 21:22:05 INFO - 2015-11-18 21:22:05,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:22:05 INFO - 2015-11-18 21:22:05,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 180359168 21:22:05 INFO - 2015-11-18 21:22:05,935 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39212/tests/kraken/driver.html?testName=ai-astar) 21:22:07 INFO - 2015-11-18 21:22:07,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 240672768 21:22:07 INFO - 2015-11-18 21:22:07,957 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,957 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:22:07 INFO - 2015-11-18 21:22:07,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:22:07 INFO - 2015-11-18 21:22:07,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:22:07 INFO - 2015-11-18 21:22:07,957 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;114;115;116;121;114;112;114;114 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;134;156;164;139;155;153;140;174;134 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;160;160;159;161;163;162;163 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;86;90;74;72;72;101;91;72 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;131;92;93;91;128;91;92;141 21:22:07 INFO - 2015-11-18 21:22:07,958 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;109;109;109;109 21:22:07 INFO - 2015-11-18 21:22:07,959 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;148;148;148;147;149;148;149 21:22:07 INFO - 2015-11-18 21:22:07,959 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;74;74;72;72;73;80;70;71 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;68;69;69;69;69;70 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;87;86;85;83;84;84;83;83 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;132;121;125;121;124;124;120;127;130;123 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;143;157;144;153;146;166;152;151;142 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;69;69;71;70;69;69;68;69 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:22:07 INFO - 2015-11-18 21:22:07,960 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:22:07 INFO - 2015-11-18 21:22:07,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,964 21:22:07 INFO - 2015-11-18 21:22:07,961 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:22:07 INFO - 2015-11-18 21:22:07,961 DEBUG : BROWSER_OUTPUT: __startTimestamp1447910527956__endTimestamp 21:22:07 INFO - 2015-11-18 21:22:07,961 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:3.03 (2.6%) stddev-sans-first:3.20 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 114.0 115.0 116.0 121.0 114.0 112.0 114.0 114.0 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.00 stddev:13.33 (8.6%) stddev-sans-first:14.03 21:22:07 INFO - 2015-11-18 21:22:07,964 DEBUG : BROWSER_OUTPUT: Values: 155.0 134.0 156.0 164.0 139.0 155.0 153.0 140.0 174.0 134.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 160.0 160.0 159.0 161.0 163.0 162.0 163.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:10.67 (14.4%) stddev-sans-first:10.87 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 86.0 90.0 74.0 72.0 72.0 101.0 91.0 72.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:91.50 stddev:20.37 (22.3%) stddev-sans-first:21.04 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 131.0 92.0 93.0 91.0 128.0 91.0 92.0 141.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 148.0 148.0 148.0 147.0 149.0 148.0 149.0 21:22:07 INFO - 2015-11-18 21:22:07,965 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.00 stddev:2.73 (3.7%) stddev-sans-first:2.89 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 74.0 74.0 72.0 72.0 73.0 80.0 70.0 71.0 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 70.0 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.51 (1.8%) stddev-sans-first:1.51 21:22:07 INFO - 2015-11-18 21:22:07,966 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 87.0 86.0 85.0 83.0 84.0 84.0 83.0 83.0 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.50 stddev:3.95 (3.2%) stddev-sans-first:3.18 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: Values: 132.0 121.0 125.0 121.0 124.0 124.0 120.0 127.0 130.0 123.0 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:152.50 stddev:7.36 (4.8%) stddev-sans-first:7.76 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: Values: 153.0 143.0 157.0 144.0 153.0 146.0 166.0 152.0 151.0 142.0 21:22:07 INFO - 2015-11-18 21:22:07,967 DEBUG : BROWSER_OUTPUT: 21:22:07 INFO - 2015-11-18 21:22:07,968 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 21:22:07 INFO - 2015-11-18 21:22:07,968 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 71.0 70.0 69.0 69.0 68.0 69.0 21:22:07 INFO - 2015-11-18 21:22:07,968 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:22:07 INFO - 2015-11-18 21:22:07,968 DEBUG : BROWSER_OUTPUT: 21:22:08 INFO - 2015-11-18 21:22:08,940 INFO : Browser exited with error code: 0 21:22:08 INFO - 2015-11-18 21:22:08,993 INFO : Completed test kraken (00:01:01) 21:22:08 INFO - 2015-11-18 21:22:08,993 INFO : Starting test v8_7 21:22:08 INFO - 2015-11-18 21:22:08,993 DEBUG : operating with platform_type : linux_ 21:22:08 INFO - 2015-11-18 21:22:08,993 INFO : Initialising browser for v8_7 test... 21:22:08 INFO - 2015-11-18 21:22:08,999 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzJTaDE/profile http://localhost:39212/getInfo.html 21:22:13 INFO - 2015-11-18 21:22:13,407 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:22:13 INFO - 2015-11-18 21:22:13,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:22:13 INFO - 2015-11-18 21:22:13,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:22:13 INFO - 2015-11-18 21:22:13,407 DEBUG : BROWSER_OUTPUT: __metrics 21:22:13 INFO - 2015-11-18 21:22:13,569 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:15 INFO - 2015-11-18 21:22:15,004 INFO : Browser initialized. 21:22:15 INFO - 2015-11-18 21:22:15,005 INFO : Running cycle 1/1 for v8_7 test... 21:22:15 INFO - 2015-11-18 21:22:15,005 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzJTaDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:22:26 INFO - 2015-11-18 21:22:26,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 140054528 21:22:26 INFO - 2015-11-18 21:22:26,985 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39212/tests/v8_7/run.html (next: http://localhost:39212/tests/v8_7/run.html) 21:22:48 INFO - 2015-11-18 21:22:48,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 439619584 21:22:48 INFO - 2015-11-18 21:22:48,614 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,614 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:22:48 INFO - 2015-11-18 21:22:48,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:22:48 INFO - 2015-11-18 21:22:48,615 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:22:48 INFO - 2015-11-18 21:22:48,615 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:22:48 INFO - 2015-11-18 21:22:48,616 DEBUG : BROWSER_OUTPUT: |0;Richards;163.02575806977504 21:22:48 INFO - 2015-11-18 21:22:48,616 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.5287569573284 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2020.20202020202 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 21:22:48 INFO - 2015-11-18 21:22:48,617 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: |8;Splay;620.9230769230769 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: __startTimestamp1447910568614__endTimestamp 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:22:48 INFO - 2015-11-18 21:22:48,619 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:22:48 INFO - 2015-11-18 21:22:48,619 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,619 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.03 Median:163.03 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,619 DEBUG : BROWSER_OUTPUT: Values: 163.0 21:22:48 INFO - 2015-11-18 21:22:48,619 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,620 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.53 Median:185.53 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,620 DEBUG : BROWSER_OUTPUT: Values: 185.5 21:22:48 INFO - 2015-11-18 21:22:48,621 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,621 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,621 DEBUG : BROWSER_OUTPUT: Values: 279.7 21:22:48 INFO - 2015-11-18 21:22:48,621 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: Values: 5025.1 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2020.20 Median:2020.20 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: Values: 2020.2 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,622 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: Values: 784.9 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: Values: 12268.3 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: Values: 26342.1 21:22:48 INFO - 2015-11-18 21:22:48,623 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.92 Median:620.92 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: Values: 620.9 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: Values: 4830.9 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:22:48 INFO - 2015-11-18 21:22:48,624 DEBUG : BROWSER_OUTPUT: 21:22:49 INFO - 2015-11-18 21:22:49,552 INFO : Browser exited with error code: 0 21:22:49 INFO - 2015-11-18 21:22:49,569 INFO : Completed test v8_7 (00:00:40) 21:22:49 INFO - 2015-11-18 21:22:49,670 INFO : Completed test suite (00:20:21) 21:22:49 INFO - 2015-11-18 21:22:49,670 DEBUG : Working with test: dromaeo_css 21:22:49 INFO - 2015-11-18 21:22:49,670 DEBUG : Generating results file: dromaeo_css 21:22:49 INFO - 2015-11-18 21:22:49,671 DEBUG : Working with test: kraken 21:22:49 INFO - 2015-11-18 21:22:49,671 DEBUG : Generating results file: kraken 21:22:49 INFO - 2015-11-18 21:22:49,672 INFO : javascript benchmark 21:22:49 INFO - 2015-11-18 21:22:49,672 DEBUG : Working with test: v8_7 21:22:49 INFO - 2015-11-18 21:22:49,672 DEBUG : Generating results file: v8_7 21:22:49 INFO - 2015-11-18 21:22:49,672 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:22:49 INFO - 2015-11-18 21:22:49,742 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 21:22:49 INFO - 2015-11-18 21:22:49,743 DEBUG : process_Request line: dromaeo_css 6063.12 graph.html#tests=[[72,132,35]] 21:22:49 INFO - 2015-11-18 21:22:49,743 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:22:49 INFO - 2015-11-18 21:22:49,773 DEBUG : process_Request line: kraken 1534.50 graph.html#tests=[[232,132,35]] 21:22:49 INFO - 2015-11-18 21:22:49,773 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:22:49 INFO - 2015-11-18 21:22:49,813 DEBUG : process_Request line: v8_7 19855.11 graph.html#tests=[[230,132,35]] 21:22:49 INFO - 2015-11-18 21:22:49,814 INFO : javascript benchmark 21:22:49 INFO - 2015-11-18 21:22:49,816 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.1525911708254, 2699.5275826730317, 2737.7946654000943, 2740.7944404169693, 2755.0, 4515.300128480083, 4576.313552967056, 4653.6044436222965, 4688.109259240742, 4692.085043416535, 4571.3600095986585, 4608.5852273295395, 4620.330052142437, 4701.717896926187, 4716.0, 4293.076988447483, 4301.419308393358, 4309.461317335333, 4338.284183109791, 4360.10617823347, 4083.4895638045246, 4392.0557080227745, 4423.66822488313, 4451.243288640922, 4468.4414448193975, 4270.935935960963, 4280.550542193072, 4350.086481838817, 4368.868933931987, 4377.058932329564, 4313.051128751669, 4326.437563116806, 4332.523422423531, 4350.58669426404, 4365.148795984785, 4105.0763578194965, 4305.375720520507, 4319.8488052918, 4327.221100201962, 4370.060437006059, 4579.015511665008, 4587.7706114694465, 4684.36761037259, 4693.296005599153, 4718.811247550128, 5078.060558796635, 5095.643304968654, 5103.56619687327, 5107.61692873036, 5141.485851414866, 4796.5203479651755, 4927.852164435073, 5127.9743601282125, 5150.27896094547, 5157.071727089123, 4622.583967442946, 4655.278431843104, 4709.199436095803, 4744.928826067612, 4778.5699287063635, 5137.794488220504, 5139.306193663882, 5146.279520867081, 5181.481851814864, 5196.68819870809, 4719.976400117977, 4840.927386089212, 4927.975360123248, 4933.802647894044, 4950.480199579064, 4855.174620314484, 4989.850304490871, 5059.8988020239385, 5064.569511591482, 5081.00920320534, 4968.975155124202, 4972.975135124301, 4978.103941290602, 5011.223260394645, 5017.096922553976, 4693.272542755878, 4827.034593081397, 4943.110240156734, 4972.303877457159, 4993.7503124843615, 4057.69567282455, 4071.9389209161886, 4120.175964806991, 4138.317177665712, 4176.7076304658385, 3662.1943172502006, 3668.211334563082, 3685.7788532687587, 3700.888973330804, 3711.9443208351895, 4063.7358571692744, 4168.687348448879, 4327.610515053598, 4334.718243314174, 4379.627731642782, 4871.707697538159, 4933.309336692866, 4945.109880221523, 4945.530174633404, 4987.650864439527, 4360.825566977349, 4407.801648925806, 4412.294032954776, 4416.646668266531, 4450.332450132506, 4227.133437645275, 4339.1104823511105, 4569.977150114228, 4570.497245303014, 4597.747123908217, 4681.67228294023, 4740.7392593407, 4802.087603355351, 4839.128956787812, 4843.321934929042, 5032.194848824171, 5129.769160387867, 5133.281340612392, 5138.691678499302, 5179.093658609803, 4481.932771008373, 4833.3958255218095, 4857.53853383928, 4861.611071114373, 4906.681065730716, 4793.13723529768, 4811.903761924812, 4934.457209707001, 5007.824726134568, 5047.0, 5052.393712754493, 5085.5931525477135, 5087.160618497906, 5090.898182036412, 5127.717975511234, 4573.679842410999, 4900.068986892479, 4905.043516514245, 4907.871189626478, 4908.214685650279, 4717.528247175255, 4764.166270902509, 4779.426468823764, 4780.139574876555, 4804.01517688866, 4786.329913812138, 4787.40157480315, 4799.352087468287, 4807.351007613927, 4828.8792780180775, 4701.741404222664, 4929.482404347492, 4940.60475161979, 4942.357493525818, 4957.132501812096, 4563.269876819693, 4571.679982401333, 4702.647301452474, 4784.593309568726, 4804.807807687793], "unit": "ms", "name": "dojo.html", "value": 4594.4894751442525}, {"lowerIsBetter": false, "replicates": [556.0231836656164, 569.9344575373831, 580.9854753631162, 581.2850194261058, 587.5710731166247, 25109.121180758677, 34009.659903400956, 34374.828125859334, 34394.82802585984, 34407.13982150441, 39770.403443948366, 41108.0, 41112.58887411125, 41113.383299250534, 41114.58885411153, 6940.930590694079, 7064.152301723775, 8087.110417854032, 8234.83530329393, 8237.917620823804, 10306.587736490532, 10475.476226188699, 10551.261411701184, 10564.049235568797, 10568.101711354544, 10216.693499195037, 10257.589696412135, 10280.485975701185, 10298.691039268797, 10298.691039268833, 7140.0, 7333.486655934087, 7338.119425668954, 7357.705691772323, 10185.0, 7028.543144695578, 10279.588816447333, 10583.523741431654, 10585.523651435627, 10592.894071059267, 37249.44125838114, 37790.81104594487, 37818.621813781785, 37840.0, 37870.0, 2822.040506227872, 2831.8725657345262, 2901.0, 3469.6356882527225, 3715.442683597455, 28595.285117872012, 28609.76518822214, 29064.12807615775, 29174.41651166986, 29783.25541861449, 2839.5882597023524, 2940.617719696426, 2978.9851050744824, 3026.243439140215, 3035.438443887888, 249674.0, 254998.0, 255317.0, 255541.72229138922, 256484.0, 57197.14204286939, 57799.4220057794, 57923.71038144867, 58004.4199557999, 58039.0, 61553.0, 61673.383266167664, 61866.0, 62144.68927655333, 62260.377396226366, 12066.336351500751, 12252.754944901051, 12258.938705306417, 12405.75188496225, 12405.937970310091, 9501.952490237505, 9609.51952402391, 9609.567569459392, 9614.086661767122, 9615.807683846284, 19605.411837644893, 19833.305834296018, 19885.403437896886, 19934.50163745918, 20019.09914053871, 7736.303732664087, 7870.645820938072, 7967.0, 7972.202779722097, 7981.0, 796.3987189671876, 805.9234372734699, 886.472548833443, 925.486355072941, 1059.51262419288, 26376.0, 26406.072977545693, 26443.735562644128, 26644.333891652863, 26747.319219136574, 832.4672209785742, 880.5685214244974, 901.5312037740339, 934.514052692596, 1007.5667462990984, 13530.323483825769, 13960.720785584232, 14089.636832625709, 14172.149671019772, 14215.50245741394, 331698.0, 333828.0, 334187.0, 336074.0, 336457.0, 48638.270425943636, 49105.75447122742, 49219.0, 49262.0, 49306.260406093934, 1048.9895101049044, 1090.0788833435734, 1097.308695521832, 1108.4014632098576, 1111.8665760108677, 25303.240902772945, 25827.483450331263, 26465.206043818715, 26604.0, 26781.46437071209, 39592.208155836146, 40189.0, 40207.59792402039, 40210.39684404678, 40243.0, 244796.0, 245954.0, 246775.0, 246823.0, 246871.0, 24654.0, 25135.74864251334, 29144.417111658073, 29655.85172074126, 29730.55404168896, 36585.817070914476, 37066.258674826895, 37270.0, 37779.43330850094, 38138.42792358062, 31923.0, 32405.35189296248, 32830.83584582062, 33293.83353083219, 33317.0, 26152.60771088397, 32106.19734506656, 32197.0, 32424.83787581047, 33037.17407064843, 29674.554881677224, 30117.69882301149, 30178.0, 30193.245168870955, 30233.69766302309, 24347.878260608584, 27587.31031724223, 27801.304967375167, 28381.574276385458, 29852.850735746182, 22851.71577816114, 23019.88490057539, 23254.41863953347, 23419.765802341757, 25323.493530128926], "unit": "ms", "name": "ext.html", "value": 17101.733298297688}, {"lowerIsBetter": false, "replicates": [306.57386233135946, 310.968903109689, 311.8409611098339, 314.3932210833094, 314.867755542672, 11832.23090499117, 12135.271883686984, 14836.332365043572, 14987.625309367259, 15187.46843860465, 14383.568492945229, 14761.55715328542, 14813.333399996998, 15230.314635841387, 15242.314095865684, 3971.6028397160344, 4343.978280108595, 4689.460712018119, 4844.055409195208, 4860.343853579757, 3552.1652411683235, 3679.7240206984584, 4770.21291486906, 5336.38631557372, 5507.504324610784, 5575.303087114111, 5580.135079062731, 5592.86017849555, 5593.944060559383, 5621.297337832771, 5445.809396671118, 5538.224648549206, 5576.749046292886, 5580.693061881595, 5582.665040097607, 4804.567588917014, 4806.663533552653, 4813.975930120362, 4819.9036019279765, 4821.855344339676, 18506.35227767035, 18798.53003674919, 19147.904260478746, 19375.3218637347, 19386.127624256802, 542.3573065916901, 543.3479824210963, 543.4348277791092, 543.5542854859017, 1721.0913556090293, 12076.335801530913, 12361.32012739299, 12492.0630952678, 12547.184433011826, 12718.173318734252, 1754.2544418622163, 1781.1361489677497, 1793.7219730941724, 1823.0520129532702, 1849.260295881658, 50154.49845501571, 51113.48886511162, 51547.0, 51766.99999999962, 51973.7401312991, 8393.496390216607, 8410.0, 8623.741287761377, 8652.74041778735, 8687.34844886636, 10571.735706607396, 10577.153827693919, 10585.206109541816, 10604.787904241872, 10630.946845265724, 6478.902816457757, 6511.0558968949235, 6513.348665133543, 6568.474522038226, 6588.868222635616, 6190.566660333823, 6207.503399728011, 6223.284322302902, 6321.051842223703, 6354.3010268870385, 5377.865553361197, 5405.945940540623, 5419.214213939035, 5425.9186112208345, 5470.070088084955, 1408.4084684432562, 1471.0, 1477.8596033377028, 1481.2667729473765, 1522.956774609396, 762.4434163060886, 809.8339840332718, 828.5939889454245, 947.2989987409268, 952.7951490429591, 16244.67510649804, 16437.0, 16591.917040414963, 16982.40561580339, 17061.40285090016, 404.63784912503144, 405.35548477920247, 407.60055145956534, 413.179838021527, 417.607448997947, 5585.273914391184, 5585.609007369527, 5597.720113994284, 5657.57568182388, 5757.107648314518, 393331.0, 475960.0, 485016.0, 493343.0, 495264.0, 57244.71377643085, 58524.707376463695, 59728.70135649294, 62213.0, 65813.67093164503, 463.6870112673932, 475.2419890275006, 475.97858096385744, 476.4877756411871, 477.12685785013343, 9350.906490935276, 9376.109269619375, 9413.058694130532, 9567.952160239154, 9585.281103917094, 30573.0, 30735.385292294475, 31520.527192092595, 32045.0, 32085.197870053435, 41850.58149418467, 42000.57999419967, 42081.78959105185, 43137.35293970656, 43174.78412607917, 5549.72251387421, 5757.366689664217, 5758.510526605285, 5760.6255593386295, 5973.074173503114, 10136.543855526372, 10166.796664066826, 10168.186545076524, 10227.795444090927, 10389.48052597352, 9677.564509597225, 9693.41839489633, 9714.125728684452, 9734.075262850018, 9791.461469618955, 9342.626294948397, 9347.532623368668, 9370.203532699798, 9422.858657120012, 9714.0, 9521.238300936047, 9642.132208101304, 9708.805823883624, 10004.949480304464, 10015.549300281651, 5711.971440142773, 5773.1051686988585, 5799.82600521985, 5804.448577385142, 5804.564657650609, 9199.09585801185, 9519.524023798644, 9545.140937315675, 9589.808203835744, 9719.611215551582], "unit": "ms", "name": "jquery.html", "value": 6907.937687120924}, {"lowerIsBetter": false, "replicates": [1385.2727318157959, 1622.456477080178, 1633.1017940132924, 1644.087531420062, 1685.7471379293108, 5478.315210598676, 6281.780137695182, 6475.611463312204, 6476.708548115334, 6476.8380790480205, 6595.1096601958725, 6697.631630260346, 6702.865942681144, 6704.061431399596, 6705.497087718429, 1621.26232564183, 1642.1132588402309, 1935.1968932892903, 1996.8702034367757, 2018.5760990192077, 1993.083181736403, 1996.5308152584132, 1999.4901300168438, 2000.3998800359907, 2001.949951251216, 1939.94180174595, 1956.8923709195988, 1992.1533348326975, 1996.9700454493195, 1998.1807458941837, 1955.3742802303268, 1984.3848406993807, 1991.4822146242082, 1996.0219492448741, 2008.3673642802544, 1974.7037944308468, 1989.5622962948273, 1991.332903477337, 1993.6511110555596, 1997.670384386589, 6751.088603038576, 6795.286494918061, 6811.591304521745, 6814.386705196556, 6829.043933849265, 3948.3879998599978, 4048.291548978946, 4049.2913740095364, 4052.027513396793, 4056.4523789288364, 2317.40906068953, 2619.292790946434, 2764.3227409284855, 2788.2750484873877, 2810.747032767061, 766.6051983228642, 836.0928392693935, 842.4439869685978, 866.9263112635433, 896.8475359188953, 8929.598168082452, 8958.104189581056, 8966.730998070003, 8986.955065224633, 9039.141281578306, 3691.7231207659534, 3694.5751238607368, 3720.7023438125425, 3777.0934975606206, 3778.24435112973, 7815.726449574237, 7829.138794732575, 7829.256220659028, 7845.0, 7856.25365590268, 4037.515498140242, 4070.247004304154, 4076.1236334188293, 4079.5104587449696, 4080.020795009236, 3715.1640880802142, 3716.479692843004, 3719.330520506335, 3720.1443667956523, 3722.7952462614817, 3275.1484614000533, 3289.7203737682084, 3298.993806888874, 3313.9171520712175, 3319.867205311809, 1010.2726037253166, 1013.2096964367805, 1020.6937918624383, 1031.138998935882, 1034.234666346913, 859.1108203009854, 918.9891119768201, 1168.4391492083678, 1176.9058475321954, 1185.247367921359, 6169.136320915076, 6239.812805615838, 6261.874762504815, 6271.6550589718, 6284.0, 998.6205242007991, 1005.1255407795119, 1036.2953191829629, 1043.9895601044045, 1074.4681382715605, 5168.0, 5217.165253559412, 5219.895602087937, 5226.869328266824, 5228.503292187313, 7060.71757129709, 7213.098362704662, 7558.697652093964, 7590.278923502258, 7651.846963060708, 7540.886886696704, 7714.15144334134, 7732.110807257125, 7741.845163096819, 7772.7668169954995, 6358.936410635927, 6414.486841052704, 6422.165118534561, 6426.0, 6440.0661904023655, 6223.0, 6408.102865598913, 6418.0, 6439.356064393523, 6440.388163124496, 7166.175889772534, 7230.783076507713, 7309.853802924018, 7465.253474652492, 7474.887876681745, 7400.592967386845, 7520.435967302365, 7597.848043038997, 7676.270754278335, 7687.654055567401, 6538.967305163444, 6618.437432818072, 6618.536702430783, 6622.304658010839, 6638.037484564615, 6564.146660934048, 6568.27748947625, 6587.901181482377, 6666.366695163952, 6723.4957378197805, 6352.618842869442, 6364.840878977878, 6369.649669268235, 6423.197100362455, 6502.837429064311, 6239.344868788893, 6240.095186198067, 6253.09330147117, 6355.745770169141, 6364.936350636434, 6183.84540386494, 6189.35011823752, 6295.96852015737, 6302.117703521419, 6335.746570137143, 5696.829095127153, 5735.168400581976, 5738.569607279387, 5743.253377061123, 5761.683107429131, 5994.250718660168, 5999.550033747573, 6031.728572214173, 6057.939420605914, 6058.182145410313], "unit": "ms", "name": "mootools.html", "value": 3941.684138680625}, {"lowerIsBetter": false, "replicates": [271.8246730858596, 278.4250522670686, 279.90343331550616, 285.8870746055308, 286.46431173705173, 5231.293775340328, 5263.631545791796, 5345.0646136926025, 5347.973260133699, 5383.59623028273, 5221.86945326367, 5399.136138217886, 5410.702411367373, 5416.4312747161575, 5418.8916221675645, 4178.143480586487, 4179.979100104495, 4182.477190351206, 4184.288670925935, 4184.309588917825, 3929.764214147146, 4007.519097708279, 4182.686298527623, 4185.539590645027, 4186.937195942063, 3965.6232657897453, 4026.8590599329027, 4045.9595404045876, 4060.0255938574824, 4076.5311989121333, 4055.7363771354767, 4058.69559783016, 4062.7156099073077, 4065.2479291331197, 4065.3292206785845, 3517.4196257617464, 3519.8384533104013, 3523.894283171509, 3524.84138213781, 3525.8589656413715, 5220.738963051832, 5223.451537588537, 5228.163493840967, 5233.267342572043, 5240.423553409122, 4585.0, 4735.73953432561, 4738.597219236369, 4746.0, 4750.762461876892, 5656.0, 5670.064439367499, 5673.560369041311, 5675.744591493351, 5676.716164191774, 3718.9442158367647, 3834.9424758628643, 3923.7645741255615, 3926.921461570781, 3928.626780455852, 5833.416658334175, 5967.313758917693, 5984.670843103628, 5989.3112292086535, 5992.310884248323, 4011.859584914514, 4036.0313524754433, 4036.8183431745642, 4041.8989525262105, 4043.292423825819, 4099.426080348753, 4100.897477563025, 4113.753174809462, 4115.32097203958, 4115.855945041909, 4600.677952543289, 4700.929486057712, 4709.0817290628, 4720.645951553579, 4737.715737055788, 5685.488306052475, 5689.943100569024, 5690.089585666274, 5694.06048002075, 5696.829095127153, 1424.3875133692611, 1452.8329242137079, 1452.978205326921, 1454.4763885001391, 1455.3450947073648, 953.1374106433689, 964.7346979580672, 975.2490582251627, 993.6770549571419, 997.5560875410517, 4944.381952255968, 4972.875678108004, 4979.228219625964, 4980.078685443204, 4989.975050124726, 5850.473457388855, 5874.295084589877, 5877.4122587740885, 5881.5882888198275, 5882.970585147133, 4956.231784073474, 4961.925571116436, 4968.205087186033, 4970.527799859007, 4975.179095449283, 3102.1779228504465, 3151.700588444094, 3178.7298079663487, 3187.6493585705553, 3201.9199520012185, 5588.860278492989, 5634.464725851038, 5654.830355089354, 5681.34664513578, 5683.0338842396895, 6150.138980542728, 6152.876942461216, 6153.077038444269, 6158.230221222348, 6164.383561643889, 5659.830205093854, 5674.716264186774, 5676.886462270814, 5677.744501497443, 5685.232493613392, 5768.855778605568, 5974.312954010345, 5981.342052374148, 5984.281886173687, 5991.281046274475, 5583.0, 5820.272465941757, 5832.387599302012, 5834.416558344132, 5835.649861008353, 5502.724863756876, 5559.63862348946, 5635.408282130317, 5658.85852853682, 5683.119116536944, 3983.581723918947, 4056.350983842571, 4073.85741499058, 4074.0425999890595, 4076.144009757984, 5868.647881127146, 5896.14505896634, 5898.056310990221, 5899.557533184942, 5906.143609176731, 5508.678701795209, 5596.608237423504, 5622.156676498558, 5625.268715067015, 5643.012472817159, 5582.441755824548, 5587.916181257366, 5588.832335029955, 5593.105103183471, 5604.8318550443555, 5510.3938566758425, 5530.585206109638, 5535.142052981794, 5538.501534861882, 5542.140968149944, 5565.972170139124, 5704.11586204139, 5706.172604972338, 5706.657600543981, 5724.169995350568, 5485.094959331665, 5519.254900588369, 5521.944780552143, 5523.171524271231, 5529.419410961791], "unit": "ms", "name": "prototype.html", "value": 4232.895996597477}, {"lowerIsBetter": false, "replicates": [630.1241274628268, 663.7311888685084, 722.2127880610135, 777.7161336112318, 810.0239211749835, 11617.18679692422, 11654.009409200218, 11845.881541184597, 11871.584494542682, 12699.61901142965, 12247.0, 12257.570985015525, 12298.0, 12374.505019799197, 12386.442610082546, 610.1031483718948, 618.2395653346387, 783.6865253898443, 794.8370584030259, 803.3252068262658, 795.5346122518333, 802.1497212954258, 805.1023109233192, 808.2119933065273, 808.2523665609287, 826.68999125328, 843.4981186194204, 844.890164278646, 845.5265051571109, 845.5772113943028, 638.7125793392969, 647.1069923505556, 818.0388044048279, 832.8334333133337, 834.9916500834975, 613.3039000734154, 616.5037145098194, 619.4455961914061, 620.3331418724889, 620.5501011766478, 12143.453544590426, 12411.944984676313, 12414.068944829174, 12430.316332601704, 12448.06639502032, 10956.780864382747, 11514.194006419553, 11646.941765291203, 11674.824877626843, 12018.879811201863, 9493.952530237373, 9526.380785248937, 9537.380070295478, 9594.42433453995, 9631.470269135194, 3208.1658768720067, 3225.179328943373, 3252.3983063133396, 3263.0, 3266.6896644818703, 34101.147471313416, 40224.597754022376, 40255.0, 40381.59618403837, 40393.0, 6508.153939987866, 6659.86680266392, 6694.062831203635, 6700.296468870796, 6745.628990405575, 10348.37909725404, 10547.525361358757, 10553.47232638365, 10558.472076396303, 10590.735231619117, 5612.607117501817, 5676.545876329884, 5700.429957004267, 5810.302763668386, 5814.418558144236, 3262.0866157475944, 3296.027671836814, 3296.093574267096, 3310.155910242921, 3423.58916929965, 2398.2205783120557, 2412.8311018228906, 2423.0671191591364, 2424.3090719144957, 2428.8785560721894, 368.48596208289285, 369.7208607501319, 370.25948103792416, 370.97217708671957, 385.27952728397514, 392.8389360362238, 566.1140315406376, 569.0979797021766, 583.6964778315253, 604.2084868821858, 7778.0, 7940.761777146695, 7945.32464740492, 8019.318357939641, 8219.219174178443, 474.87653210164916, 478.7773685236382, 545.1985581195636, 609.9176611157437, 620.268083661284, 3552.378333791576, 3752.981235093807, 3770.3967365221433, 3830.157365379612, 3846.942295865564, 51190.74404627953, 51538.74230628898, 51732.482675173516, 51813.0, 51984.48015519872, 45765.0, 45843.31235031477, 45990.310145347845, 46580.301295480596, 46616.0, 41000.0, 42095.57904420917, 42273.78863105665, 43198.352024719024, 43213.567864320954, 7598.12621548529, 7666.19504951972, 8037.879431808411, 8068.870358149747, 8527.232549070613, 32091.35817283688, 32668.83665581657, 33123.33753324872, 33296.1675958103, 33527.664723352456, 39339.60660393359, 39930.80034599808, 40054.39918401168, 40465.79767101146, 40972.590274096874, 7159.964200178966, 7225.783226503213, 7514.135874374517, 7590.392768578611, 7783.844323113619, 10879.78240435171, 10890.29213101146, 11591.362475063952, 11743.530258789553, 11838.467268972745, 10636.734081648021, 10725.141988641046, 10762.19283553721, 11154.609588664358, 11515.424228788695, 10858.185636077484, 10892.346459212473, 10903.618373356894, 11340.773184536429, 11352.829707554558, 7714.0, 9288.953555232181, 9686.07982241686, 9819.852702209615, 11280.041196498389, 8807.251383632207, 8915.643374265217, 9325.741024961544, 9337.766555835886, 9442.48066356357, 9288.72133835986, 9382.202512786489, 9421.952890235505, 9539.809203816023, 9557.378770379903], "unit": "ms", "name": "yui.html", "value": 5485.130474259687}], "name": "dromaeo_css", "value": 6063.12036692952}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 115.0, 116.0, 121.0, 114.0, 112.0, 114.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 156.0, 164.0, 139.0, 155.0, 153.0, 140.0, 174.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 160.0, 159.0, 161.0, 163.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 86.0, 90.0, 74.0, 72.0, 72.0, 101.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 131.0, 92.0, 93.0, 91.0, 128.0, 91.0, 92.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 104.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 74.0, 72.0, 72.0, 73.0, 80.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 87.0, 86.0, 85.0, 83.0, 84.0, 84.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [132.0, 121.0, 125.0, 121.0, 124.0, 124.0, 120.0, 127.0, 130.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [153.0, 143.0, 157.0, 144.0, 153.0, 146.0, 166.0, 152.0, 151.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 71.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1534.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.02575806977504], "unit": "score", "name": "Richards", "value": 216.5424679999999}, {"lowerIsBetter": false, "replicates": [185.5287569573284], "unit": "score", "name": "DeltaBlue", "value": 356.3760199999999}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [2020.20202020202], "unit": "score", "name": "RayTrace", "value": 366.2945550000002}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [620.9230769230769], "unit": "score", "name": "Splay", "value": 131.24169970267596}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19855.108860182343}]} 21:22:49 INFO - RETURN: dromaeo_css: 6063.12 21:22:49 INFO - RETURN: kraken: 1534.50 21:22:49 INFO - RETURN: v8_7: 19855.11 21:22:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19855.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1534.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6063.12"}}} 21:22:49 INFO - Return code: 0 21:22:49 INFO - # TBPL SUCCESS # 21:22:49 INFO - Running post-action listener: _resource_record_post_action 21:22:49 INFO - Running post-run listener: _resource_record_post_run 21:22:50 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505344000; Read time: 392; Write time: 837696 21:22:50 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 95080448; Read time: 0; Write time: 152760 21:22:51 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 352772096; Read time: 392; Write time: 569240 21:22:51 INFO - Running post-run listener: _upload_blobber_files 21:22:51 INFO - Blob upload gear active. 21:22:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:22:51 INFO - Copying logs to upload dir... 21:22:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.326110 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-18 21:22:50.873364) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:22:50.876591) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009925 build_url: 'https://queue.taskcluster.net/v1/task/mSFUisRnQAWkN6wKTFRESg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 21:22:50.928119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:22:50.928433) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447905295.615431-113661317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 21:22:50.978115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 21:22:50.978429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 21:22:50.978830) ========= ========= Total master_lag: 0.29 =========