builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1447867846.92 results: success (0) buildid: 20151118081929 builduid: ff41da31ee5d4350a42d3faf12670d9b revision: 43075970a44ea086084135bb0a100245ecb3bde7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.924725) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.925256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.925603) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006534 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.946522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.946965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.954919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:46.955234) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.004497) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.004813) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.005148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.005422) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 09:30:47-- 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% 32.9M=0s 2015-11-18 09:30:47 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105766 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.124052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.124454) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022300 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:47.173822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 09:30:47.174365) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43075970a44ea086084135bb0a100245ecb3bde7 --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 43075970a44ea086084135bb0a100245ecb3bde7 --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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 09:30:47,486 truncating revision to first 12 chars 2015-11-18 09:30:47,486 Setting DEBUG logging. 2015-11-18 09:30:47,486 attempt 1/10 2015-11-18 09:30:47,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43075970a44e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 09:30:48,225 unpacking tar archive at: fx-team-43075970a44e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042721 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 09:30:48.230081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:48.230399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:48.238271) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:48.238663) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 09:30:48.239095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 09:30:48.239377) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:48 INFO - MultiFileLogger online at 20151118 09:30:48 in /builds/slave/test 09:30:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:30:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:48 INFO - {'append_to_log': False, 09:30:48 INFO - 'base_work_dir': '/builds/slave/test', 09:30:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:30:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:48 INFO - 'branch': 'Fx-Team-Non-PGO', 09:30:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:48 INFO - 'config_files': ('talos/linux_config.py',), 09:30:48 INFO - 'default_actions': ('clobber', 09:30:48 INFO - 'read-buildbot-config', 09:30:48 INFO - 'download-and-extract', 09:30:48 INFO - 'populate-webroot', 09:30:48 INFO - 'create-virtualenv', 09:30:48 INFO - 'install', 09:30:48 INFO - 'run-tests'), 09:30:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:48 INFO - 'download_minidump_stackwalk': True, 09:30:48 INFO - 'download_symbols': 'ondemand', 09:30:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:48 INFO - 'installer_path': 'installer.exe', 09:30:48 INFO - 'log_level': 'info', 09:30:48 INFO - 'log_name': 'talos', 09:30:48 INFO - 'log_to_console': True, 09:30:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:48 INFO - 'opt_config_files': (), 09:30:48 INFO - 'pip_index': False, 09:30:48 INFO - 'sps_profile': False, 09:30:48 INFO - 'sps_profile_interval': 0, 09:30:48 INFO - 'suite': 'dromaeojs-e10s', 09:30:48 INFO - 'system_bits': '64', 09:30:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:48 INFO - 'title': 'talos-linux64-ix-060', 09:30:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:48 INFO - 'use_talos_json': True, 09:30:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:48 INFO - 'work_dir': 'build'} 09:30:48 INFO - ##### 09:30:48 INFO - ##### Running clobber step. 09:30:48 INFO - ##### 09:30:48 INFO - Running pre-action listener: _resource_record_pre_action 09:30:48 INFO - Running main action method: clobber 09:30:48 INFO - rmtree: /builds/slave/test/build 09:30:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:49 INFO - Running post-action listener: _resource_record_post_action 09:30:49 INFO - ##### 09:30:49 INFO - ##### Running read-buildbot-config step. 09:30:49 INFO - ##### 09:30:49 INFO - Running pre-action listener: _resource_record_pre_action 09:30:49 INFO - Running main action method: read_buildbot_config 09:30:49 INFO - Using buildbot properties: 09:30:49 INFO - { 09:30:49 INFO - "properties": { 09:30:49 INFO - "buildnumber": 419, 09:30:49 INFO - "product": "firefox", 09:30:49 INFO - "script_repo_revision": "production", 09:30:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:30:49 INFO - "repository": "", 09:30:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:30:49 INFO - "buildid": "20151118081929", 09:30:49 INFO - "slavename": "talos-linux64-ix-060", 09:30:49 INFO - "pgo_build": "False", 09:30:49 INFO - "basedir": "/builds/slave/test", 09:30:49 INFO - "project": "", 09:30:49 INFO - "platform": "ubuntu64_hw", 09:30:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:30:49 INFO - "slavebuilddir": "test", 09:30:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:30:49 INFO - "branch": "fx-team", 09:30:49 INFO - "repo_path": "integration/fx-team", 09:30:49 INFO - "stage_platform": "linux64", 09:30:49 INFO - "builduid": "ff41da31ee5d4350a42d3faf12670d9b", 09:30:49 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 09:30:49 INFO - }, 09:30:49 INFO - "sourcestamp": { 09:30:49 INFO - "repository": "", 09:30:49 INFO - "hasPatch": false, 09:30:49 INFO - "project": "", 09:30:49 INFO - "branch": "fx-team-linux64-talos", 09:30:49 INFO - "changes": [ 09:30:49 INFO - { 09:30:49 INFO - "category": null, 09:30:49 INFO - "files": [ 09:30:49 INFO - { 09:30:49 INFO - "url": null, 09:30:49 INFO - "name": "https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:30:49 INFO - } 09:30:49 INFO - ], 09:30:49 INFO - "repository": "", 09:30:49 INFO - "rev": "43075970a44ea086084135bb0a100245ecb3bde7", 09:30:49 INFO - "who": "mdeboer@mozilla.com", 09:30:49 INFO - "when": 1447865904, 09:30:49 INFO - "number": 6677674, 09:30:49 INFO - "comments": "Bug 1048850 - Part 6: make sure our mochi tests don't depend on mozLoopAPI anymore and move relevant ones to xpcshell. r=Standard8", 09:30:49 INFO - "project": "", 09:30:49 INFO - "at": "Wed 18 Nov 2015 08:58:24", 09:30:49 INFO - "branch": "fx-team-linux64-talos", 09:30:49 INFO - "revlink": "", 09:30:49 INFO - "properties": [ 09:30:49 INFO - [ 09:30:49 INFO - "buildid", 09:30:49 INFO - "20151118081929", 09:30:49 INFO - "Change" 09:30:49 INFO - ], 09:30:49 INFO - [ 09:30:49 INFO - "builduid", 09:30:49 INFO - "ff41da31ee5d4350a42d3faf12670d9b", 09:30:49 INFO - "Change" 09:30:49 INFO - ], 09:30:49 INFO - [ 09:30:49 INFO - "pgo_build", 09:30:49 INFO - "False", 09:30:49 INFO - "Change" 09:30:49 INFO - ] 09:30:49 INFO - ], 09:30:49 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 09:30:49 INFO - } 09:30:49 INFO - ], 09:30:49 INFO - "revision": "43075970a44ea086084135bb0a100245ecb3bde7" 09:30:49 INFO - } 09:30:49 INFO - } 09:30:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:30:49 INFO - Running post-action listener: _resource_record_post_action 09:30:49 INFO - ##### 09:30:49 INFO - ##### Running download-and-extract step. 09:30:49 INFO - ##### 09:30:49 INFO - Running pre-action listener: _resource_record_pre_action 09:30:49 INFO - Running main action method: download_and_extract 09:30:49 INFO - mkdir: /builds/slave/test/build/tests 09:30: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')]} 09:30:49 INFO - https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/test_packages.json 09:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/test_packages.json 09:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:30:50 INFO - Downloaded 1302 bytes. 09:30:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:30:50 INFO - Using the following test package requirements: 09:30:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:30:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'jsshell-linux-x86_64.zip'], 09:30:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:30:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:30:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:30:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:30:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:30:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:30:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:30:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:50 INFO - https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:51 INFO - Downloaded 21291001 bytes. 09:30: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 09:30:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30: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 09:30:52 INFO - Return code: 0 09:30:52 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 09:30: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')]} 09:30:52 INFO - https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:54 INFO - Downloaded 21291001 bytes. 09:30:54 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 09:30:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:30:54 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 09:30:55 INFO - Return code: 0 09:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:55 INFO - https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:56 INFO - Downloaded 11130997 bytes. 09:30:56 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 09:30:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:30:56 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 09:30:57 INFO - Return code: 0 09:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:57 INFO - https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:30:58 INFO - Downloaded 55667654 bytes. 09:30:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:30:58 INFO - mkdir: /builds/slave/test/properties 09:30:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:58 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:58 INFO - Contents: 09:30:58 INFO - build_url:https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:30:58 INFO - Running post-action listener: _resource_record_post_action 09:30:58 INFO - Running post-action listener: set_extra_try_arguments 09:30:58 INFO - ##### 09:30:58 INFO - ##### Running populate-webroot step. 09:30:58 INFO - ##### 09:30:58 INFO - Running pre-action listener: _resource_record_pre_action 09:30:58 INFO - Running main action method: populate_webroot 09:30:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:30:58 INFO - '../fennec_ids.txt'], 09:30:58 INFO - 'tests': ['tcheck2']}, 09:30:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:58 INFO - '--tppagecycles', 09:30:58 INFO - '7'], 09:30:58 INFO - 'tests': ['tsvgm']}}, 09:30:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:30:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:30:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:30:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'tests': ['damp', 'tps']}, 09:30:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['damp', 'tps']}, 09:30:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:30:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:58 INFO - 'other': {'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'other_l64': {'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:30:58 INFO - 'ts_paint', 09:30:58 INFO - 'tpaint', 09:30:58 INFO - 'sessionrestore', 09:30:58 INFO - 'sessionrestore_no_auto_restore']}, 09:30:58 INFO - 'svgr': {'tests': ['tsvgx', 09:30:58 INFO - 'tsvgr_opacity', 09:30:58 INFO - 'tart', 09:30:58 INFO - 'tscrollx', 09:30:58 INFO - 'cart']}, 09:30:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['tsvgx', 09:30:58 INFO - 'tsvgr_opacity', 09:30:58 INFO - 'tart', 09:30:58 INFO - 'tscrollx', 09:30:58 INFO - 'cart']}, 09:30:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'tests': ['tp5o']}, 09:30:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'talos_options': ['--e10s'], 09:30:58 INFO - 'tests': ['tp5o']}, 09:30:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'talos_options': ['--xperf_path', 09:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:58 INFO - 'tests': ['tp5n']}, 09:30:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:58 INFO - 'talos_options': ['--e10s', 09:30:58 INFO - '--xperf_path', 09:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:58 INFO - 'tests': ['tp5n']}}, 09:30:58 INFO - 'talos.zip': {'path': '', 09:30:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:58 INFO - Running post-action listener: _resource_record_post_action 09:30:58 INFO - ##### 09:30:58 INFO - ##### Running create-virtualenv step. 09:30:58 INFO - ##### 09:30:58 INFO - Running pre-action listener: _resource_record_pre_action 09:30:58 INFO - Running main action method: create_virtualenv 09:30:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:58 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 09:30:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:58 INFO - Using real prefix '/usr' 09:30:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:01 INFO - Installing pip.................done. 09:31:01 INFO - Return code: 0 09:31:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:01 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:01 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 09:31:01 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 09:31:01 INFO - Using env: {'DISPLAY': ':0', 09:31:01 INFO - 'HOME': '/home/cltbld', 09:31:01 INFO - 'LANG': 'en_US.UTF-8', 09:31:01 INFO - 'LANGUAGE': 'en_US:en', 09:31:01 INFO - 'LOGNAME': 'cltbld', 09:31:01 INFO - 'MAIL': '/var/mail/cltbld', 09:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:01 INFO - 'MOZ_NO_REMOTE': '1', 09:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:01 INFO - 'NO_EM_RESTART': '1', 09:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:01 INFO - 'PWD': '/builds/slave/test', 09:31:01 INFO - 'SHELL': '/bin/bash', 09:31:01 INFO - 'SHLVL': '1', 09:31:01 INFO - 'TERM': 'linux', 09:31:01 INFO - 'TMOUT': '86400', 09:31:01 INFO - 'USER': 'cltbld', 09:31:01 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:01 INFO - '_': '/tools/buildbot/bin/python'} 09:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:01 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 09:31:01 INFO - Cleaning up... 09:31:01 INFO - Return code: 0 09:31:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:01 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:01 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 09:31:01 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 09:31:01 INFO - Using env: {'DISPLAY': ':0', 09:31:01 INFO - 'HOME': '/home/cltbld', 09:31:01 INFO - 'LANG': 'en_US.UTF-8', 09:31:01 INFO - 'LANGUAGE': 'en_US:en', 09:31:01 INFO - 'LOGNAME': 'cltbld', 09:31:01 INFO - 'MAIL': '/var/mail/cltbld', 09:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:01 INFO - 'MOZ_NO_REMOTE': '1', 09:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:01 INFO - 'NO_EM_RESTART': '1', 09:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:01 INFO - 'PWD': '/builds/slave/test', 09:31:01 INFO - 'SHELL': '/bin/bash', 09:31:01 INFO - 'SHLVL': '1', 09:31:01 INFO - 'TERM': 'linux', 09:31:01 INFO - 'TMOUT': '86400', 09:31:01 INFO - 'USER': 'cltbld', 09:31:01 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:01 INFO - '_': '/tools/buildbot/bin/python'} 09:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:01 INFO - Downloading/unpacking psutil>=0.7.1 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:31:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:03 INFO - Installing collected packages: psutil 09:31:03 INFO - Running setup.py install for psutil 09:31:03 INFO - building 'psutil._psutil_linux' extension 09:31:03 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 09:31:03 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 09:31:03 INFO - building 'psutil._psutil_posix' extension 09:31:03 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 09:31:04 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 09:31:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:04 INFO - Successfully installed psutil 09:31:04 INFO - Cleaning up... 09:31:04 INFO - Return code: 0 09:31:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:04 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:04 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 09:31:04 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 09:31:04 INFO - Using env: {'DISPLAY': ':0', 09:31:04 INFO - 'HOME': '/home/cltbld', 09:31:04 INFO - 'LANG': 'en_US.UTF-8', 09:31:04 INFO - 'LANGUAGE': 'en_US:en', 09:31:04 INFO - 'LOGNAME': 'cltbld', 09:31:04 INFO - 'MAIL': '/var/mail/cltbld', 09:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:04 INFO - 'MOZ_NO_REMOTE': '1', 09:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:04 INFO - 'NO_EM_RESTART': '1', 09:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:04 INFO - 'PWD': '/builds/slave/test', 09:31:04 INFO - 'SHELL': '/bin/bash', 09:31:04 INFO - 'SHLVL': '1', 09:31:04 INFO - 'TERM': 'linux', 09:31:04 INFO - 'TMOUT': '86400', 09:31:04 INFO - 'USER': 'cltbld', 09:31:04 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:04 INFO - '_': '/tools/buildbot/bin/python'} 09:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:31:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:31:06 INFO - Installing collected packages: mozsystemmonitor 09:31:06 INFO - Running setup.py install for mozsystemmonitor 09:31:06 INFO - Successfully installed mozsystemmonitor 09:31:06 INFO - Cleaning up... 09:31:06 INFO - Return code: 0 09:31:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:06 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:06 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 09:31:06 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 09:31:06 INFO - Using env: {'DISPLAY': ':0', 09:31:06 INFO - 'HOME': '/home/cltbld', 09:31:06 INFO - 'LANG': 'en_US.UTF-8', 09:31:06 INFO - 'LANGUAGE': 'en_US:en', 09:31:06 INFO - 'LOGNAME': 'cltbld', 09:31:06 INFO - 'MAIL': '/var/mail/cltbld', 09:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:06 INFO - 'MOZ_NO_REMOTE': '1', 09:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:06 INFO - 'NO_EM_RESTART': '1', 09:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:06 INFO - 'PWD': '/builds/slave/test', 09:31:06 INFO - 'SHELL': '/bin/bash', 09:31:06 INFO - 'SHLVL': '1', 09:31:06 INFO - 'TERM': 'linux', 09:31:06 INFO - 'TMOUT': '86400', 09:31:06 INFO - 'USER': 'cltbld', 09:31:06 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:06 INFO - '_': '/tools/buildbot/bin/python'} 09:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:31:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:08 INFO - Downloading docopt-0.6.1.tar.gz 09:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:08 INFO - Running setup.py install for blobuploader 09:31:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:31:08 INFO - Running setup.py install for requests 09:31:09 INFO - Running setup.py install for docopt 09:31:09 INFO - Successfully installed blobuploader requests docopt 09:31:09 INFO - Cleaning up... 09:31:09 INFO - Return code: 0 09:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:09 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:09 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 09:31:09 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 09:31:09 INFO - Using env: {'DISPLAY': ':0', 09:31:09 INFO - 'HOME': '/home/cltbld', 09:31:09 INFO - 'LANG': 'en_US.UTF-8', 09:31:09 INFO - 'LANGUAGE': 'en_US:en', 09:31:09 INFO - 'LOGNAME': 'cltbld', 09:31:09 INFO - 'MAIL': '/var/mail/cltbld', 09:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:09 INFO - 'MOZ_NO_REMOTE': '1', 09:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:09 INFO - 'NO_EM_RESTART': '1', 09:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:09 INFO - 'PWD': '/builds/slave/test', 09:31:09 INFO - 'SHELL': '/bin/bash', 09:31:09 INFO - 'SHLVL': '1', 09:31:09 INFO - 'TERM': 'linux', 09:31:09 INFO - 'TMOUT': '86400', 09:31:09 INFO - 'USER': 'cltbld', 09:31:09 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:09 INFO - '_': '/tools/buildbot/bin/python'} 09:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:09 INFO - Running setup.py (path:/tmp/pip-ocBkM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:09 INFO - Running setup.py (path:/tmp/pip-x6CaiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:09 INFO - Running setup.py (path:/tmp/pip-NCHYSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:09 INFO - Running setup.py (path:/tmp/pip-oFJvHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:09 INFO - Running setup.py (path:/tmp/pip-wu71XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:10 INFO - Running setup.py (path:/tmp/pip-k25L1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:10 INFO - Running setup.py (path:/tmp/pip-idTVmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:10 INFO - Running setup.py (path:/tmp/pip-qOUXgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:10 INFO - Running setup.py (path:/tmp/pip-0foYye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:10 INFO - Running setup.py (path:/tmp/pip-SA8RMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:10 INFO - Running setup.py (path:/tmp/pip-OEgPzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:10 INFO - Running setup.py (path:/tmp/pip-N9zw6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:10 INFO - Running setup.py (path:/tmp/pip-RgEvFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:10 INFO - Running setup.py (path:/tmp/pip-rixwp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:10 INFO - Running setup.py (path:/tmp/pip-9l1IqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:10 INFO - Running setup.py (path:/tmp/pip-s2TBR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:10 INFO - Running setup.py (path:/tmp/pip-qJmM_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:10 INFO - Running setup.py install for manifestparser 09:31:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:31:10 INFO - Running setup.py install for mozcrash 09:31:11 INFO - Running setup.py install for mozdebug 09:31:11 INFO - Running setup.py install for mozdevice 09:31:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Running setup.py install for mozfile 09:31:11 INFO - Running setup.py install for mozhttpd 09:31:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Running setup.py install for mozinfo 09:31:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Running setup.py install for mozInstall 09:31:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Running setup.py install for mozleak 09:31:11 INFO - Running setup.py install for mozlog 09:31:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Running setup.py install for moznetwork 09:31:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Running setup.py install for mozprocess 09:31:12 INFO - Running setup.py install for mozprofile 09:31:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Running setup.py install for mozrunner 09:31:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Running setup.py install for mozscreenshot 09:31:12 INFO - Running setup.py install for moztest 09:31:12 INFO - Running setup.py install for mozversion 09:31:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:31:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:12 INFO - Cleaning up... 09:31:12 INFO - Return code: 0 09:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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/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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31: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/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 09:31: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/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 09:31:12 INFO - Using env: {'DISPLAY': ':0', 09:31:12 INFO - 'HOME': '/home/cltbld', 09:31:12 INFO - 'LANG': 'en_US.UTF-8', 09:31:12 INFO - 'LANGUAGE': 'en_US:en', 09:31:12 INFO - 'LOGNAME': 'cltbld', 09:31:12 INFO - 'MAIL': '/var/mail/cltbld', 09:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:12 INFO - 'MOZ_NO_REMOTE': '1', 09:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:12 INFO - 'NO_EM_RESTART': '1', 09:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:12 INFO - 'PWD': '/builds/slave/test', 09:31:12 INFO - 'SHELL': '/bin/bash', 09:31:12 INFO - 'SHLVL': '1', 09:31:12 INFO - 'TERM': 'linux', 09:31:12 INFO - 'TMOUT': '86400', 09:31:12 INFO - 'USER': 'cltbld', 09:31:12 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:12 INFO - '_': '/tools/buildbot/bin/python'} 09:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:12 INFO - Running setup.py (path:/tmp/pip-Wat7NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:12 INFO - Running setup.py (path:/tmp/pip-90RHpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:13 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)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:13 INFO - Running setup.py (path:/tmp/pip-yZfKns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:13 INFO - Running setup.py (path:/tmp/pip-m4_QDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:13 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)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:13 INFO - Running setup.py (path:/tmp/pip-XCwqol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:13 INFO - Running setup.py (path:/tmp/pip-mUsr0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:13 INFO - Running setup.py (path:/tmp/pip-X1EEyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:13 INFO - Running setup.py (path:/tmp/pip-nLLAzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:13 INFO - Running setup.py (path:/tmp/pip-o0Vvng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:13 INFO - Running setup.py (path:/tmp/pip-upZrMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:13 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)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:13 INFO - Running setup.py (path:/tmp/pip-rIaIgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:13 INFO - Running setup.py (path:/tmp/pip-vl2Wf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:13 INFO - Running setup.py (path:/tmp/pip-ODem5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:13 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)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:13 INFO - Running setup.py (path:/tmp/pip-tyzZMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:13 INFO - Running setup.py (path:/tmp/pip-mFwlcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:13 INFO - Running setup.py (path:/tmp/pip-qhTjIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:14 INFO - Running setup.py (path:/tmp/pip-zHruVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:15 INFO - Downloading blessings-1.5.1.tar.gz 09:31:15 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 09:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:15 INFO - Installing collected packages: blessings 09:31:15 INFO - Running setup.py install for blessings 09:31:15 INFO - Successfully installed blessings 09:31:15 INFO - Cleaning up... 09:31:15 INFO - Return code: 0 09:31:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:16 INFO - Reading from file tmpfile_stdout 09:31:16 INFO - Current package versions: 09:31:16 INFO - argparse == 1.2.1 09:31:16 INFO - blessings == 1.5.1 09:31:16 INFO - blobuploader == 1.2.4 09:31:16 INFO - docopt == 0.6.1 09:31:16 INFO - manifestparser == 1.1 09:31:16 INFO - mozInstall == 1.12 09:31:16 INFO - mozcrash == 0.16 09:31:16 INFO - mozdebug == 0.1 09:31:16 INFO - mozdevice == 0.47 09:31:16 INFO - mozfile == 1.2 09:31:16 INFO - mozhttpd == 0.7 09:31:16 INFO - mozinfo == 0.9 09:31:16 INFO - mozleak == 0.1 09:31:16 INFO - mozlog == 3.0 09:31:16 INFO - moznetwork == 0.27 09:31:16 INFO - mozprocess == 0.22 09:31:16 INFO - mozprofile == 0.27 09:31:16 INFO - mozrunner == 6.11 09:31:16 INFO - mozscreenshot == 0.1 09:31:16 INFO - mozsystemmonitor == 0.0 09:31:16 INFO - moztest == 0.7 09:31:16 INFO - mozversion == 1.4 09:31:16 INFO - psutil == 3.1.1 09:31:16 INFO - requests == 1.2.3 09:31:16 INFO - wsgiref == 0.1.2 09:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:16 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 0x7f8d7a05ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2592900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', '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 09:31:16 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 09:31:16 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 09:31:16 INFO - Using env: {'DISPLAY': ':0', 09:31:16 INFO - 'HOME': '/home/cltbld', 09:31:16 INFO - 'LANG': 'en_US.UTF-8', 09:31:16 INFO - 'LANGUAGE': 'en_US:en', 09:31:16 INFO - 'LOGNAME': 'cltbld', 09:31:16 INFO - 'MAIL': '/var/mail/cltbld', 09:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:16 INFO - 'MOZ_NO_REMOTE': '1', 09:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:16 INFO - 'NO_EM_RESTART': '1', 09:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:16 INFO - 'PWD': '/builds/slave/test', 09:31:16 INFO - 'SHELL': '/bin/bash', 09:31:16 INFO - 'SHLVL': '1', 09:31:16 INFO - 'TERM': 'linux', 09:31:16 INFO - 'TMOUT': '86400', 09:31:16 INFO - 'USER': 'cltbld', 09:31:16 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:16 INFO - '_': '/tools/buildbot/bin/python'} 09:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:31:16 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)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:16 INFO - Cleaning up... 09:31:16 INFO - Return code: 0 09:31:16 INFO - Running post-action listener: _resource_record_post_action 09:31:16 INFO - Running post-action listener: _start_resource_monitoring 09:31:16 INFO - Starting resource monitoring. 09:31:16 INFO - ##### 09:31:16 INFO - ##### Running install step. 09:31:16 INFO - ##### 09:31:16 INFO - Running pre-action listener: _resource_record_pre_action 09:31:16 INFO - Running main action method: install 09:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:16 INFO - Reading from file tmpfile_stdout 09:31:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:31:16 INFO - Reading from file tmpfile_stdout 09:31:16 INFO - Output received: 09:31:16 INFO - Usage: mozinstall [options] installer 09:31:16 INFO - Options: 09:31:16 INFO - -h, --help show this help message and exit 09:31:16 INFO - -d DEST, --destination=DEST 09:31:16 INFO - Directory to install application into. [default: 09:31:16 INFO - "/builds/slave/test"] 09:31:16 INFO - --app=APP Application being installed. [default: firefox] 09:31:16 INFO - mkdir: /builds/slave/test/build/application 09:31:16 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'] 09:31:16 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 09:31:30 INFO - Reading from file tmpfile_stdout 09:31:30 INFO - Output received: 09:31:30 INFO - /builds/slave/test/build/application/firefox/firefox 09:31:30 INFO - Running post-action listener: _resource_record_post_action 09:31:30 INFO - ##### 09:31:30 INFO - ##### Running run-tests step. 09:31:30 INFO - ##### 09:31:30 INFO - Running pre-action listener: _resource_record_pre_action 09:31:30 INFO - Running main action method: run_tests 09:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:30 INFO - Python 2.7.3 09:31:30 INFO - Return code: 0 09:31:30 INFO - grabbing minidump binary from tooltool 09:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:30 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 0x25d8b70>, '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 0x2629dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x262a250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:30 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 09:31:30 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 09:31:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:30 INFO - Return code: 0 09:31:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:31:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:31:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test/build 09:31:30 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 09:31:30 INFO - Using env: {'DISPLAY': ':0', 09:31:30 INFO - 'HOME': '/home/cltbld', 09:31:30 INFO - 'LANG': 'en_US.UTF-8', 09:31:30 INFO - 'LANGUAGE': 'en_US:en', 09:31:30 INFO - 'LOGNAME': 'cltbld', 09:31:30 INFO - 'MAIL': '/var/mail/cltbld', 09:31:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:30 INFO - 'MOZ_NO_REMOTE': '1', 09:31:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:30 INFO - 'NO_EM_RESTART': '1', 09:31:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:30 INFO - 'PWD': '/builds/slave/test', 09:31:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:30 INFO - 'SHELL': '/bin/bash', 09:31:30 INFO - 'SHLVL': '1', 09:31:30 INFO - 'TERM': 'linux', 09:31:30 INFO - 'TMOUT': '86400', 09:31:30 INFO - 'USER': 'cltbld', 09:31:30 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895', 09:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:30 INFO - '_': '/tools/buildbot/bin/python'} 09:31:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 09:31:31 INFO - mozversion INFO | application_buildid: 20151118081929 09:31:31 INFO - mozversion INFO | application_changeset: 43075970a44ea086084135bb0a100245ecb3bde7 09:31:31 INFO - mozversion INFO | application_display_name: Nightly 09:31:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:31 INFO - mozversion INFO | application_name: Firefox 09:31:31 INFO - mozversion INFO | application_remotingname: firefox 09:31:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:31:31 INFO - mozversion INFO | application_vendor: Mozilla 09:31:31 INFO - mozversion INFO | application_version: 45.0a1 09:31:31 INFO - mozversion INFO | platform_buildid: 20151118081929 09:31:31 INFO - mozversion INFO | platform_changeset: 43075970a44ea086084135bb0a100245ecb3bde7 09:31:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:31:31 INFO - mozversion INFO | platform_version: 45.0a1 09:31:31 INFO - 2015-11-18 09:31:31,088 DEBUG : using testdate: 1447867891 09:31:31 INFO - 2015-11-18 09:31:31,088 DEBUG : actual date: 1447867891 09:31:31 INFO - 2015-11-18 09:31:31,096 INFO : starting webserver on 'localhost:44724' 09:31:31 INFO - 2015-11-18 09:31:31,097 INFO : Starting test suite talos-linux64-ix-060.e 09:31:31 INFO - 2015-11-18 09:31:31,097 INFO : Starting test dromaeo_css 09:31:31 INFO - 2015-11-18 09:31:31,097 DEBUG : operating with platform_type : linux_ 09:31:31 INFO - 2015-11-18 09:31:31,098 INFO : Initialising browser for dromaeo_css test... 09:31:31 INFO - 2015-11-18 09:31:31,112 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5R1Jc/profile http://localhost:44724/getInfo.html 09:31:36 INFO - 2015-11-18 09:31:36,258 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:31:36 INFO - 2015-11-18 09:31:36,258 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:31:36 INFO - 2015-11-18 09:31:36,258 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:31:36 INFO - 2015-11-18 09:31:36,259 DEBUG : BROWSER_OUTPUT: __metrics 09:31:37 INFO - 2015-11-18 09:31:37,285 INFO : Browser initialized. 09:31:37 INFO - 2015-11-18 09:31:37,286 INFO : Running cycle 1/1 for dromaeo_css test... 09:31:37 INFO - 2015-11-18 09:31:37,286 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA5R1Jc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:31:49 INFO - 2015-11-18 09:31:49,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 09:31:49 INFO - 2015-11-18 09:31:49,318 DEBUG : BROWSER_OUTPUT: 09:32:38 INFO - 2015-11-18 09:32:38,973 DEBUG : BROWSER_OUTPUT: 1447867958970 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] 09:34:50 INFO - 2015-11-18 09:34:50,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44724/tests/dromaeo/cssquery-ext.html) 09:34:51 INFO - 2015-11-18 09:34:51,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 145068032 09:34:51 INFO - 2015-11-18 09:34:51,433 DEBUG : BROWSER_OUTPUT: 09:37:53 INFO - 2015-11-18 09:37:53,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-ext.html (next: http://localhost:44724/tests/dromaeo/cssquery-jquery.html) 09:37:54 INFO - 2015-11-18 09:37:54,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 141815808 09:37:54 INFO - 2015-11-18 09:37:54,060 DEBUG : BROWSER_OUTPUT: 09:40:55 INFO - 2015-11-18 09:40:55,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44724/tests/dromaeo/cssquery-mootools.html) 09:40:56 INFO - 2015-11-18 09:40:56,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 142499840 09:40:56 INFO - 2015-11-18 09:40:56,408 DEBUG : BROWSER_OUTPUT: 09:43:58 INFO - 2015-11-18 09:43:58,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44724/tests/dromaeo/cssquery-prototype.html) 09:43:58 INFO - 2015-11-18 09:43:58,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 140050432 09:43:58 INFO - 2015-11-18 09:43:58,756 DEBUG : BROWSER_OUTPUT: 09:47:01 INFO - 2015-11-18 09:47:01,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44724/tests/dromaeo/cssquery-yui.html) 09:47:01 INFO - 2015-11-18 09:47:01,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 141422592 09:47:01 INFO - 2015-11-18 09:47:01,914 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/dromaeo/cssquery-yui.html (next: http://localhost:44724/tests/dromaeo/cssquery-dojo.html) 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 143486976 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:50:04 INFO - 2015-11-18 09:50:04,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:50:04 INFO - 2015-11-18 09:50:04,742 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2693.1247344613002;2698.37937274427;2734.5898115282694;2736.9726302736967;2760.447910417917;4526.569975852297;4631.120087183433;4668.859934201971;4711.363965864607;4776.426828780543;4612.354270402138;4699.647526435514;4747.311639812234;4751.667383283171;4759.095771803355;4309.1381723655395;4344.348347747848;4358.629516491102;4360.08438227971;4382.8904277393;4390.714603550759;4393.604575588196;4453.354263631772;4459.17505261526;4496.572825581581;4165.10450253194;4178.477690288699;4231.449911511484;4248.065425606362;4280.700350975433;4276.144771045803;4293;4325.567443255681;4334;4344.23975804233;4096.078382363944;4257.446531950857;4274.166537525184;4281.229378711831;4284.121755040241;4498.595126438636;4568.885777855547;4654.069186162781;4681.274402467623;4708.952910470885;5094.974525127388;5139.15203991341;5144.176931690949;5148.948510514884;5191;4842;4968.354113965162;5143.562797162245;5160.14857548504;5196.350456192976;4659.138059459011;4682.882927926829;4721.3390125382475;4724.6692731508465;4762.857114286577;5154.201098829687;5166.070107380632;5177.870553236124;5186.896262074737;5231.215317702299;4754.738489383048;4864.537868902519;4920.5571498565305;4992.326035985168;5064.164412871909;5124.538791508782;5165.431802501722;5178.378594568676;5191.480851914854;5201.817936372209;5085.313482679865;5100.311457953203;5104.540591346797;5109.897802044013;5145.07388670043;4784.617230621542;4890.975545122252;4962.354893863775;5040.36995375578;5067.113255180328;4244.660427165819;4262.190183865056;4279.251131052053;4299.828006879752;4332.241857674894;3756.2111956489443;3782.243551289753;3795.886123416302;3799;3800.657940785343;4192.706510544293;4287.97856010718;4344.4352234209355;4423.535528769497;4455.977720111444;5085.821996230188;5143.151380022255;5169.198774190007;5172.948270517247;5212.061828870839;4168.416421700964;4434.911301773946;4454.866354009385;4455.6658250631335;4495.280755079171;4396.428464299621;4446.466424029072;4485.192665320208;4496.3705081288645;4526;4859.246816743411;4882.829100981448;4890.828820991248;4892.535209155125;4893.6329775266995;4854.9514504855915;4973.154563724248;5132.769025393941;5137.820176293962;5187.144121219956;4751.928721069117;4788.473267940593;4816.518348165156;4822.565969062801;4848.660593758403;4929.704217746947;4981.701097934136;4991.6006719463085;5006.749662516932;5075.720835354091;4725.929111063406;4851.830185943475;4915.139850526215;5066.9239961401345;5094.770735316845;4946.480619535041;4963.081829861487;4978.352814134139;4986.376702912136;4996.750162491933;4915.11527924977;4929.630277729113;4947.45577986414;4957.504249575014;4959.355283813081;4615.93076103852;4700.365450664253;4704.435467743892;4823.059503396804;4886.096072226649;4960.107180707508;4960.528749768766;4969.155243608523;4974.502549744997;5008.048470790538;4798.1123492154065;4850.587700045395;4851.636127290538;4852.102361063215;4859.246816743411 09:50:04 INFO - 2015-11-18 09:50:04,742 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.822776711452;556.0991194265291;576.0466428061558;580.2456806152002;580.6748220996243;27649.72350276499;28340.716592834066;35952;36764.26471470569;36844.631553684456;39173.608263917355;39866;39866.40200396989;39966.40050399247;39967.40048899269;7944.841103177948;8116.1478044805335;8126.878096828523;8130.634121464548;8135.959320203391;7818;7943.24539168778;7945.324647404977;7971.561564113971;7986.243026534182;7902.723404680837;7993.120756716757;7994.9600251998945;8056.718014869481;8057.194280571925;7859.8035049123655;7926;7995.200479952016;7995.200479952016;8003.559804210766;7870.331021863149;7987.840243195162;8003.639836207385;8013.639386227634;8033.678652853879;36331.273374532364;36742.632573674186;36816.63183368186;36846.44730329047;36927.446088308694;2859.4138201668607;2969.435807196626;3146.5437511560926;3566.4472006838982;3656.6526180012856;27977;28334.574981375295;28533.85733071342;28787.71212287871;29161;2962.4075184963094;3034.0746072447896;3073.231692076981;3075.9077227683206;3147.5750773645495;215807;216305.9184704082;216747;216772;218571;51824.74087629538;53093.469065309626;55533.88932221333;55856.44143558593;56357.15464268039;61440.69279653573;62696.686516567126;62732;62761.68619156875;62768.05847912285;12634.81047784284;12916.677083072998;13020.609381718563;13021.739565208643;13039.478420863059;9326.90673093274;9332.90667093334;9375.24998000172;9379.202767764817;9535.761605959906;19267.456498698895;19584.41246762571;19597.706034409497;19651.115699793543;19663.60672786536;7794.844103117905;7884.132745398002;7952.017993252531;7955;7967.123616402191;795.9164287749819;836.7825263052958;875.7197696737111;951.3150531617224;1071.8124328242682;26390.73609263921;26580.202593922215;29637.703622963927;30556.442918180695;30874.845625772177;822.8313195794848;828.4449418889359;838.8070743728977;840.6385254340693;968.9563969621242;13516.93241533786;13540.729185416236;13769.31153442344;13788.379522921492;13839.308034598229;299013;301938;302965;303104;303512;46496.7675161622;46556;46861.12555497742;46983.06033879303;46994;1103.3600511703194;1115.8828323026128;1118.3792994887754;1139.4986206069302;1142.8000099982637;25921;26454.603180952687;26462.867685661447;26516.204513864614;26887.327816803954;39345.40981885331;39963.2007359857;39989.600103998586;40092.59907401005;40176;238271;238376;240570;240963;241316;28781.712182878742;41892;42847.5715242856;42879.57120428756;43338.56661433345;45619.54380456153;46254.76872615615;46869.765651171525;46987;47141.29288060613;32319.09128178381;32815.507767383984;33301.16747081342;33759;33913.49129763006;33922.49116263307;38243.617563825115;38361.616383835804;39175;39776.60223397729;31882.043538693877;33091.66908330982;33173.83413082919;34423.48364774581;34474;29772.255693607833;30240.84879575588;30843;30890.0732978011;30923.536146957365;24312.27063188107;24409.75590244075;24538.631920521562;24587;24605.753942461062 09:50:04 INFO - 2015-11-18 09:50:04,746 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.2155913200905;309;311.85031185031187;317.20065435103527;317.67279701907034;10831;11207.831882521768;15132.092074475526;15764.448244311452;15794.605134871634;9677.70966870995;9744.171745401649;9790.167835733953;9916.55375508102;10035.949820250908;3967.960320396795;4098.077932465201;4098.344264917614;4102.97948510257;4108.15782764534;3490.354284457371;4017;4049.1699201663737;4065.7560546367163;4070.694697897655;4301.376300436435;4398.208322501949;4404.273294906337;4468.285074388098;4488.910221795562;4289.871303860874;4311.267084595626;4316.309390497537;4327.956720432802;4342.044750154961;3535.982320088383;3922.2547715934165;3941.862034828796;3942.25097231528;3963.9405408918888;11502.137339699557;11604.30374177552;11699.883001169965;11796.94101529487;12119.636410907688;1646.9094199819006;1700.7023770840053;1740.4343588333843;1764.2237415537122;1794.2015802967685;8879.911200887973;8924.464532128028;8979.416337938013;9073.047330030318;9122.22461090808;1583.7545180496927;1584.382090984517;1601.807783066028;1607.9678406431922;1626.544567521096;51498.22752658713;52174.21738673923;52486.47513524854;52550.21174682383;54135;5995.670238136944;6109.297430795426;6121.602095863755;6142.477889379364;6169.074638804215;7144.9285507145305;7224;7225.096862892138;7226.7109315626785;7236.855262894713;4637.582617564435;4642.303654451792;4646.024334889711;4680.836170734008;4690.742009189527;4555.703879247904;4562.885927851764;4613.5847773700525;4624.12141693084;4646.83736069236;2800.1879454958244;2845.644294463192;2851.1019029005797;2858.1568437311043;2870.6124673169275;993.8658281132099;1005.648023191877;1013.3312014070679;1018.8930162332997;1071.0039663113223;334.2329354132272;343.5430876933672;345.4507333340001;348.6931500279738;361.0738455860709;8683.2185103341;9163.541822908828;9306.348555601178;9373.718788436357;9405.106514881076;355.48632226432557;362.38937390497097;364.71552189292396;385.77624977512977;396.7837528546949;5006.098902197639;5129.8717532062;5144.456663001085;5145.253938178943;5155.896882062413;478253;489346;492693;495374;499149;64475.67762161159;65721;66624;66738.66630666815;67150;400.46937807405305;405.6349285642945;406.2078946055145;406.8392984770999;407.32994224501124;8766.824663506566;8828.911710883065;8933.687320943736;8941.508217048126;8978.326625503245;30002.54996175103;30261.243468913453;30518.84740576283;31157.376852463276;31250.843745781127;42239.155216896106;42826.14347713091;42909;43031.569684302754;43604.12791744211;5913.6747478887355;5926.7925622603;5954.880902381841;5980.8803823924145;5985.581009329305;10208.285420020527;10272.435016073889;10301.381917084998;10329.74175645615;10396.948015259875;8018.3184429324165;8244.83510329802;8287.12985136552;9741.853872192065;9822.214222862296;8690.435121717068;8782.736517904474;9042.140996605312;9058.275337972815;9115.407498512575;9185.67850125269;9554.04459554039;9828.901710982798;9845.655402060893;9891.851622225528;5767.452092051249;5863.648181109147;5882.94117058841;5923.466887980103;5941.643501389931;8599.226069653761;9302.488363140092;9549.570269338035;9574.281928855224;9601.759956001157 09:50:04 INFO - 2015-11-18 09:50:04,746 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1481.4666719980812;1597.281223449448;1662.6425318556508;1663.093613980381;1680.731083026716;5475.534579560742;5712.428757124286;6465.9676701616545;6864.622445765481;6868.8969665455;6373.107764912916;6656.101426307447;6687.197536295639;6688.3646053624825;6711.966440167792;1921.5868588253488;1943.7667479902432;1950.2101648832174;1953.6092781443697;1960.0297852563;1878.2862512245329;1880.58627102038;1883.0867029490687;1972.1322618048084;1976.505873531617;1930.5849242412878;1945.5816999345138;1948.6589846776828;1952;1965.7935916728752;1763.7266223735342;1792.8027916929193;1793.9192736326831;1801.0544464156292;1803.0624075480678;1766.2669991953453;1780.7863056433182;1923.422973108062;1935.77738560066;1942.815432533907;6669.399754022162;6687.632180230085;6726.764563240263;6746.460283177334;6748.527603067787;3763.8682646107527;3825.9808700956596;3838.366669499529;3840.577536470986;3841.7118716096406;2304.2626359564947;2370.194133994433;2679.410529683486;2710.566309390488;2735.8221715588425;853.2789792625284;868.3227082875368;880.8414485392627;881.154092071612;888.0852721696663;8914.55427228636;8918.241949434307;8946.55267236642;8969;8990.730278091602;3524.6122926478065;3597.406427939413;3694.7783133012103;3710.406334986389;3715.5727091384297;7271.527350722186;7402.222766609429;7406.7037318506655;7407;7443.2184620615135;3865.4201869719204;3872.1674839909556;3874.6900247980093;3878.0886491674432;3881.7670939743707;3535.381308271042;3537.699295559855;3539.823008849547;3544.911377215539;3554.7156227501737;2929.6484421869513;2930.6190195274476;2953.985230073879;2955.054382597591;2966.2880908581783;854.3933806997102;855.5508358112041;859.0679113162164;861.2421069458961;872.5637181409295;972.1396564040733;1055.994720026395;1066.4081434803759;1076.8115579773664;1088.216484131424;6343.746250149942;6371.649559274284;6425.261094974137;6427.550071495044;6437.613743175424;964.4213471916934;983.4787562591838;989.618996686281;1001.6544292219173;1007.0433088565892;5038.697678139323;5052.722100284446;5077.898442031139;5226.372835259793;5232.2413250078525;6972.1284839395075;7207.639618019078;7650.923490765021;7942.205779422012;7998.160193179749;7917.960410198028;7924.326432253323;7934.166912474223;7956;7985.161558036439;6218.31598524162;6279.340669229665;6289.999999999908;6291.9685401573615;6370.0763389308295;6358.0780786784735;6369;6394.200724909387;6400.55196136266;6434.195725534309;7034.824129396806;7085.681144348414;7092.574445533284;7120.572765634079;7125.893111603226;7140.2859714030255;7167.749128780468;7210.423166146591;7378.409727221917;7390.482666213528;5754.7122643866805;5834.329052159056;5841.415858414124;5841.620294680833;5842.415758424124;6369.522285828674;6397.072424498515;6406.807795766134;6446.065320528591;6475.935240647722;6260.812175634738;6274.592151510137;6326.493880489642;6392.264889537762;6401.487880969605;5898.1152827076285;6057.697115144313;6131.877362452815;6200.131981522501;6227.408396202353;6046.7278972445465;6185.536084793748;6261.968690156702;6300.21247344082;6337.7148028337915;5805.767769289181;5823.242978412949;5838.386969368155;5844.327902291291;5849.444302791228;5823.650580965155;5829.8251052468495;5833.737481813244;5841.737121829443;5844.912326315194 09:50:04 INFO - 2015-11-18 09:50:04,747 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.1012991931746;272.1441067841638;278.84942131249124;279.3226425917152;281.52703458190257;5624.77500899964;5638.746256418461;5683.886322273557;5691.288588926384;5752.482276595106;5556.055470570002;5602.971985140079;5618.0449323614985;5630.211770352154;5631.57763167762;4138.793060346986;4180.184863951523;4181.121964387482;4181.916361672765;4191.979040104795;4183.686223533232;4188.350805625133;4188.371744238373;4188.518320393148;4189.6438802701805;4002.6597739192057;4092.85675001375;4099.139180772041;4136.751794892301;4145.5647157048525;4096.795160241976;4098.446709694198;4119.938200926988;4132.896677583054;4138.91722165555;3502.597201321855;3505.3339865425487;3505.7020153287003;3510.1400156961454;3516.1561225306;5398.703071331075;5413.972930135364;5421.810236641738;5426.810061647863;5428.5928555358505;4588.197065513522;4714.858554243378;4758.881027974294;4778.713277203379;4786.545278198566;5673.914891276634;5824.592278540504;5881.05903055509;5890.8821823563285;5899.823005309848;3867.941980870289;3871.1483473635753;3888.863889763845;3890.9027274318087;3896.2207558488417;6130.325664176937;6159.353267906895;6175.814725558241;6203.565750397474;6210.65841378724;3895.6883449324555;3961.445397644332;3977.76133431995;3982.38273067675;3996.7801770902297;4051.230266249403;4052.65552428041;4055.3511438169753;4055.371417430303;4056.9797151014054;4762.59517940972;4765.404324459442;4771.260454629538;4782.641301902371;4783.091212669651;5871.735771890275;5904.439078287556;5909.8227053188475;5912.526997840248;5919.260092488439;1376.43566137885;1395.5255213227551;1407.1064873805208;1419.6025112968384;1424.6865689548283;916.4089162490156;923.8198551282435;925.7225029459303;929.8279818233649;936.9859452108224;5043.798248070036;5065.6200784941275;5118.667286626357;5121.897562048738;5144.6913185209005;6087;6100.023996160682;6103.1455596216565;6104.4505994460715;6125.663088530174;5092.28707980883;5095.515925987025;5105.897882042413;5113.41195762492;5115.283860259492;3231.4829627259996;3269.4768836986445;3297.291082417292;3317.6018877734346;3320.6679332067083;5757.913631295534;5767.077267637158;5771.422857714195;5780.797672081457;5784.305883294031;6241.095041218998;6243.063540468966;6269.498440124779;6278.121063051177;6296.118543403927;5613.017721898733;5702.429757024264;5729.971350143306;5742;5744.913826292609;6057.939420605738;6072.332043475126;6087.969560152348;6094.878102437838;6102.694865256808;5944;5967.582269241111;5968.76124954997;5969.955257829949;5982.641041537521;5748.798792042258;5762.279715035621;5766.509846663081;5774.82675519735;5775.797847075332;3903.726739128234;3981.7610943343493;3989.7207195496035;3991.4212439196735;3997.620226078518;6006.279246490449;6079.817605471843;6084.543659225487;6092.086187071975;6121.3572574879;5918.644881306963;5928.49607783326;5929.644221346733;5936.614120082354;5937.643741375531;5832.9708351457975;5866.090755932837;5869.383714709894;5889.499392551681;5893.322267939242;5685.687287199244;5781.682007489629;5801;5804.622699524517;5806.535477161901;5991.970040149771;6001.36985616504;6001.4298641628975;6001.519878409804;6002.579819412599;5750.683712395691;5767.106098554731;5783.739731712168;5817.70911454434;5823.679697616672 09:50:04 INFO - 2015-11-18 09:50:04,748 DEBUG : BROWSER_OUTPUT: |5;yui.html;722.4978639845309;742.58415287439;785.6150486261731;794.5868148562746;819.799149208444;11948.581799637015;13474.932625336873;13672.794908076363;13701.520446784365;13717.176969381819;13044.673883152926;13145.802812957812;13167;13175.077744557884;13186.472541098345;763.6868883757646;776.2741836382971;776.4021703288464;777.7550071727388;778.6612823421801;757.5719718359137;778.2995304226214;778.5095389904352;781.2968328504363;787.1734678587488;801.1467786807061;804.047204063184;804.0913767442781;808.2604416958476;809.0534075132109;794.8211652378227;796.928276455116;799.0531220503722;800.7998000499875;802.6348011654742;590.3181824992141;590.4567797626195;590.5541316306204;590.5747861539727;592.8725324055306;11637.592684256011;11659.242149260355;11680.357580333079;11752.823707644393;11766.764664706743;9239.168474837297;9312.34813563051;9324.953375233148;9446.197073248713;9480.099390557885;8663.566821658891;8852.247558957497;9092.681756138569;9256.074392560757;10270.229732769998;2921.649402071765;2925.166327596625;2935.119464160743;2958.4378967996013;2998.61018067652;35467.11332216689;35486.64513354859;35649.46525802089;35736.285274294365;35774;6853.348931851466;7101.396381307543;7154.427645788324;7169.211386747558;7178.066851309296;10605.310654807412;10613.416262105504;10666.040056394962;10712.410817404962;10743.78512429747;5654.434556544313;5662.603617746719;5662.66024038559;5835.124731290255;5844.970775146182;3450.7066899313336;3452.223249768782;3463.757536972438;3486.5293185419646;3519.771214871025;2443.3280847767005;2447.5839107351794;2450.803935685141;2458.778709916116;2471.826972111971;383.3521348920316;388.2041814280713;391.5927435467082;394.99605003950165;396.6628365888971;476.33313361294466;553.7978637797255;594.9732262048218;606.2543072021439;607.1772747926584;8443.535605541754;8699.826003479895;8721.60752766127;8867.280314677604;9012.729618111336;460.19006548474925;464.9442066951987;472.93615361925697;527.1644443556928;581.3750218515113;4024.8591299304385;4094.529129150126;4096.91806163875;4150.750954942713;4233.745975241495;50858.745706271235;51282.23076653853;51585;51633.48366516362;51698.48301517012;44123.77938110289;50649.49350506521;51238.74380628073;51316.48683513192;51415.48584514182;43246.13507729828;44813.55186448159;45332.320015199795;45586;46027.53972460233;8121.918780812352;8234.588270586328;8253.050899146676;8261.83476330458;8531.488110713377;31443.528347074356;31586.368272633958;31836.84081579577;31895;32831.50752738663;40530.1893962125;40566.1886762269;40593.391099134125;41419.1716165681;41621.167576648906;10754.677359679223;10814.94580605415;10905.58227430429;11060.668179954615;11087.445627718744;11670.474828632561;11725.296482211095;11815;11842.171048026556;12550.87449125497;11159.888401115884;11340.432978351215;11636.650900473;11715.765684686428;11722.238054526428;10859.402732849769;10961.45192740344;10973.945130274298;11003.284786488852;11294.040006599202;10549.261551691308;10679.252452328263;10758.031777140095;11081.556737730723;11191.32852028881;9253.120953509406;9407.43555386679;9729.318947673595;9816.561714413832;10005.599776008878;8868.379213455255;9483.288753343664;9525.333226674065;9554.332588655656;9597.136257736836 09:50:04 INFO - 2015-11-18 09:50:04,748 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:50:04 INFO - 2015-11-18 09:50:04,748 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: __startTimestamp1447869004737__endTimestamp 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:50:04 INFO - 2015-11-18 09:50:04,749 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,750 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4670.60 Median:4788.47 stddev:490.87 (10.3%) stddev-sans-first:467.22 09:50:04 INFO - 2015-11-18 09:50:04,750 DEBUG : BROWSER_OUTPUT: Values: 2693.1 2698.4 2734.6 2737.0 2760.4 4526.6 4631.1 4668.9 4711.4 4776.4 4612.4 4699.6 4747.3 4751.7 4759.1 4309.1 4344.3 4358.6 4360.1 4382.9 4390.7 4393.6 4453.4 4459.2 4496.6 4165.1 4178.5 4231.4 4248.1 4280.7 4276.1 4293.0 4325.6 4334.0 4344.2 4096.1 4257.4 4274.2 4281.2 4284.1 4498.6 4568.9 4654.1 4681.3 4709.0 5095.0 5139.2 5144.2 5148.9 5191.0 4842.0 4968.4 5143.6 5160.1 5196.4 4659.1 4682.9 4721.3 4724.7 4762.9 5154.2 5166.1 5177.9 5186.9 5231.2 4754.7 4864.5 4920.6 4992.3 5064.2 5124.5 5165.4 5178.4 5191.5 5201.8 5085.3 5100.3 5104.5 5109.9 5145.1 4784.6 4891.0 4962.4 5040.4 5067.1 4244.7 4262.2 4279.3 4299.8 4332.2 3756.2 3782.2 3795.9 3799.0 3800.7 4192.7 4288.0 4344.4 4423.5 4456.0 5085.8 5143.2 5169.2 5172.9 5212.1 4168.4 4434.9 4454.9 4455.7 4495.3 4396.4 4446.5 4485.2 4496.4 4526.0 4859.2 4882.8 4890.8 4892.5 4893.6 4855.0 4973.2 5132.8 5137.8 5187.1 4751.9 4788.5 4816.5 4822.6 4848.7 4929.7 4981.7 4991.6 5006.7 5075.7 4725.9 4851.8 4915.1 5066.9 5094.8 4946.5 4963.1 4978.4 4986.4 4996.8 4915.1 4929.6 4947.5 4957.5 4959.4 4615.9 4700.4 4704.4 4823.1 4886.1 4960.1 4960.5 4969.2 4974.5 5008.0 4798.1 4850.6 4851.6 4852.1 4859.2 09:50:04 INFO - 2015-11-18 09:50:04,750 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,750 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42090.06 Median:36845.54 stddev:66715.72 (181.1%) stddev-sans-first:66829.98 09:50:04 INFO - 2015-11-18 09:50:04,750 DEBUG : BROWSER_OUTPUT: Values: 553.8 556.1 576.0 580.2 580.7 27649.7 28340.7 35952.0 36764.3 36844.6 39173.6 39866.0 39866.4 39966.4 39967.4 7944.8 8116.1 8126.9 8130.6 8136.0 7818.0 7943.2 7945.3 7971.6 7986.2 7902.7 7993.1 7995.0 8056.7 8057.2 7859.8 7926.0 7995.2 7995.2 8003.6 7870.3 7987.8 8003.6 8013.6 8033.7 36331.3 36742.6 36816.6 36846.4 36927.4 2859.4 2969.4 3146.5 3566.4 3656.7 27977.0 28334.6 28533.9 28787.7 29161.0 2962.4 3034.1 3073.2 3075.9 3147.6 215807.0 216305.9 216747.0 216772.0 218571.0 51824.7 53093.5 55533.9 55856.4 56357.2 61440.7 62696.7 62732.0 62761.7 62768.1 12634.8 12916.7 13020.6 13021.7 13039.5 9326.9 9332.9 9375.2 9379.2 9535.8 19267.5 19584.4 19597.7 19651.1 19663.6 7794.8 7884.1 7952.0 7955.0 7967.1 795.9 836.8 875.7 951.3 1071.8 26390.7 26580.2 29637.7 30556.4 30874.8 822.8 828.4 838.8 840.6 969.0 13516.9 13540.7 13769.3 13788.4 13839.3 299013.0 301938.0 302965.0 303104.0 303512.0 46496.8 46556.0 46861.1 46983.1 46994.0 1103.4 1115.9 1118.4 1139.5 1142.8 25921.0 26454.6 26462.9 26516.2 26887.3 39345.4 39963.2 39989.6 40092.6 40176.0 238271.0 238376.0 240570.0 240963.0 241316.0 28781.7 41892.0 42847.6 42879.6 43338.6 45619.5 46254.8 46869.8 46987.0 47141.3 32319.1 32815.5 33301.2 33759.0 33913.5 33922.5 38243.6 38361.6 39175.0 39776.6 31882.0 33091.7 33173.8 34423.5 34474.0 29772.3 30240.8 30843.0 30890.1 30923.5 24312.3 24409.8 24538.6 24587.0 24605.8 09:50:04 INFO - 2015-11-18 09:50:04,751 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,751 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23928.90 Median:4559.29 stddev:80475.24 (1765.1%) stddev-sans-first:80681.45 09:50:04 INFO - 2015-11-18 09:50:04,752 DEBUG : BROWSER_OUTPUT: Values: 308.2 309.0 311.9 317.2 317.7 10831.0 11207.8 15132.1 15764.4 15794.6 9677.7 9744.2 9790.2 9916.6 10035.9 3968.0 4098.1 4098.3 4103.0 4108.2 3490.4 4017.0 4049.2 4065.8 4070.7 4301.4 4398.2 4404.3 4468.3 4488.9 4289.9 4311.3 4316.3 4328.0 4342.0 3536.0 3922.3 3941.9 3942.3 3963.9 11502.1 11604.3 11699.9 11796.9 12119.6 1646.9 1700.7 1740.4 1764.2 1794.2 8879.9 8924.5 8979.4 9073.0 9122.2 1583.8 1584.4 1601.8 1608.0 1626.5 51498.2 52174.2 52486.5 52550.2 54135.0 5995.7 6109.3 6121.6 6142.5 6169.1 7144.9 7224.0 7225.1 7226.7 7236.9 4637.6 4642.3 4646.0 4680.8 4690.7 4555.7 4562.9 4613.6 4624.1 4646.8 2800.2 2845.6 2851.1 2858.2 2870.6 993.9 1005.6 1013.3 1018.9 1071.0 334.2 343.5 345.5 348.7 361.1 8683.2 9163.5 9306.3 9373.7 9405.1 355.5 362.4 364.7 385.8 396.8 5006.1 5129.9 5144.5 5145.3 5155.9 478253.0 489346.0 492693.0 495374.0 499149.0 64475.7 65721.0 66624.0 66738.7 67150.0 400.5 405.6 406.2 406.8 407.3 8766.8 8828.9 8933.7 8941.5 8978.3 30002.5 30261.2 30518.8 31157.4 31250.8 42239.2 42826.1 42909.0 43031.6 43604.1 5913.7 5926.8 5954.9 5980.9 5985.6 10208.3 10272.4 10301.4 10329.7 10396.9 8018.3 8244.8 8287.1 9741.9 9822.2 8690.4 8782.7 9042.1 9058.3 9115.4 9185.7 9554.0 9828.9 9845.7 9891.9 5767.5 5863.6 5882.9 5923.5 5941.6 8599.2 9302.5 9549.6 9574.3 9601.8 09:50:04 INFO - 2015-11-18 09:50:04,752 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,752 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4662.12 Median:6094.79 stddev:2399.42 (39.4%) stddev-sans-first:2394.24 09:50:04 INFO - 2015-11-18 09:50:04,753 DEBUG : BROWSER_OUTPUT: Values: 1481.5 1597.3 1662.6 1663.1 1680.7 5475.5 5712.4 6466.0 6864.6 6868.9 6373.1 6656.1 6687.2 6688.4 6712.0 1921.6 1943.8 1950.2 1953.6 1960.0 1878.3 1880.6 1883.1 1972.1 1976.5 1930.6 1945.6 1948.7 1952.0 1965.8 1763.7 1792.8 1793.9 1801.1 1803.1 1766.3 1780.8 1923.4 1935.8 1942.8 6669.4 6687.6 6726.8 6746.5 6748.5 3763.9 3826.0 3838.4 3840.6 3841.7 2304.3 2370.2 2679.4 2710.6 2735.8 853.3 868.3 880.8 881.2 888.1 8914.6 8918.2 8946.6 8969.0 8990.7 3524.6 3597.4 3694.8 3710.4 3715.6 7271.5 7402.2 7406.7 7407.0 7443.2 3865.4 3872.2 3874.7 3878.1 3881.8 3535.4 3537.7 3539.8 3544.9 3554.7 2929.6 2930.6 2954.0 2955.1 2966.3 854.4 855.6 859.1 861.2 872.6 972.1 1056.0 1066.4 1076.8 1088.2 6343.7 6371.6 6425.3 6427.6 6437.6 964.4 983.5 989.6 1001.7 1007.0 5038.7 5052.7 5077.9 5226.4 5232.2 6972.1 7207.6 7650.9 7942.2 7998.2 7918.0 7924.3 7934.2 7956.0 7985.2 6218.3 6279.3 6290.0 6292.0 6370.1 6358.1 6369.0 6394.2 6400.6 6434.2 7034.8 7085.7 7092.6 7120.6 7125.9 7140.3 7167.7 7210.4 7378.4 7390.5 5754.7 5834.3 5841.4 5841.6 5842.4 6369.5 6397.1 6406.8 6446.1 6475.9 6260.8 6274.6 6326.5 6392.3 6401.5 5898.1 6057.7 6131.9 6200.1 6227.4 6046.7 6185.5 6262.0 6300.2 6337.7 5805.8 5823.2 5838.4 5844.3 5849.4 5823.7 5829.8 5833.7 5841.7 5844.9 09:50:04 INFO - 2015-11-18 09:50:04,753 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,753 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4813.23 Median:5630.89 stddev:1482.11 (26.3%) stddev-sans-first:1446.53 09:50:04 INFO - 2015-11-18 09:50:04,754 DEBUG : BROWSER_OUTPUT: Values: 271.1 272.1 278.8 279.3 281.5 5624.8 5638.7 5683.9 5691.3 5752.5 5556.1 5603.0 5618.0 5630.2 5631.6 4138.8 4180.2 4181.1 4181.9 4192.0 4183.7 4188.4 4188.4 4188.5 4189.6 4002.7 4092.9 4099.1 4136.8 4145.6 4096.8 4098.4 4119.9 4132.9 4138.9 3502.6 3505.3 3505.7 3510.1 3516.2 5398.7 5414.0 5421.8 5426.8 5428.6 4588.2 4714.9 4758.9 4778.7 4786.5 5673.9 5824.6 5881.1 5890.9 5899.8 3867.9 3871.1 3888.9 3890.9 3896.2 6130.3 6159.4 6175.8 6203.6 6210.7 3895.7 3961.4 3977.8 3982.4 3996.8 4051.2 4052.7 4055.4 4055.4 4057.0 4762.6 4765.4 4771.3 4782.6 4783.1 5871.7 5904.4 5909.8 5912.5 5919.3 1376.4 1395.5 1407.1 1419.6 1424.7 916.4 923.8 925.7 929.8 937.0 5043.8 5065.6 5118.7 5121.9 5144.7 6087.0 6100.0 6103.1 6104.5 6125.7 5092.3 5095.5 5105.9 5113.4 5115.3 3231.5 3269.5 3297.3 3317.6 3320.7 5757.9 5767.1 5771.4 5780.8 5784.3 6241.1 6243.1 6269.5 6278.1 6296.1 5613.0 5702.4 5730.0 5742.0 5744.9 6057.9 6072.3 6088.0 6094.9 6102.7 5944.0 5967.6 5968.8 5970.0 5982.6 5748.8 5762.3 5766.5 5774.8 5775.8 3903.7 3981.8 3989.7 3991.4 3997.6 6006.3 6079.8 6084.5 6092.1 6121.4 5918.6 5928.5 5929.6 5936.6 5937.6 5833.0 5866.1 5869.4 5889.5 5893.3 5685.7 5781.7 5801.0 5804.6 5806.5 5992.0 6001.4 6001.4 6001.5 6002.6 5750.7 5767.1 5783.7 5817.7 5823.7 09:50:04 INFO - 2015-11-18 09:50:04,754 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-18 09:50:04,754 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12393.30 Median:45459.16 stddev:14428.54 (31.7%) stddev-sans-first:14442.40 09:50:04 INFO - 2015-11-18 09:50:04,756 DEBUG : BROWSER_OUTPUT: Values: 722.5 742.6 785.6 794.6 819.8 11948.6 13474.9 13672.8 13701.5 13717.2 13044.7 13145.8 13167.0 13175.1 13186.5 763.7 776.3 776.4 777.8 778.7 757.6 778.3 778.5 781.3 787.2 801.1 804.0 804.1 808.3 809.1 794.8 796.9 799.1 800.8 802.6 590.3 590.5 590.6 590.6 592.9 11637.6 11659.2 11680.4 11752.8 11766.8 9239.2 9312.3 9325.0 9446.2 9480.1 8663.6 8852.2 9092.7 9256.1 10270.2 2921.6 2925.2 2935.1 2958.4 2998.6 35467.1 35486.6 35649.5 35736.3 35774.0 6853.3 7101.4 7154.4 7169.2 7178.1 10605.3 10613.4 10666.0 10712.4 10743.8 5654.4 5662.6 5662.7 5835.1 5845.0 3450.7 3452.2 3463.8 3486.5 3519.8 2443.3 2447.6 2450.8 2458.8 2471.8 383.4 388.2 391.6 395.0 396.7 476.3 553.8 595.0 606.3 607.2 8443.5 8699.8 8721.6 8867.3 9012.7 460.2 464.9 472.9 527.2 581.4 4024.9 4094.5 4096.9 4150.8 4233.7 50858.7 51282.2 51585.0 51633.5 51698.5 44123.8 50649.5 51238.7 51316.5 51415.5 43246.1 44813.6 45332.3 45586.0 46027.5 8121.9 8234.6 8253.1 8261.8 8531.5 31443.5 31586.4 31836.8 31895.0 32831.5 40530.2 40566.2 40593.4 41419.2 41621.2 10754.7 10814.9 10905.6 11060.7 11087.4 11670.5 11725.3 11815.0 11842.2 12550.9 11159.9 11340.4 11636.7 11715.8 11722.2 10859.4 10961.5 10973.9 11003.3 11294.0 10549.3 10679.3 10758.0 11081.6 11191.3 9253.1 9407.4 9729.3 9816.6 10005.6 8868.4 9483.3 9525.3 9554.3 9597.1 09:50:04 INFO - 2015-11-18 09:50:04,756 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:50:04 INFO - 2015-11-18 09:50:04,756 DEBUG : BROWSER_OUTPUT: 09:50:05 INFO - 2015-11-18 09:50:05,477 INFO : Browser exited with error code: 0 09:50:05 INFO - 2015-11-18 09:50:05,496 INFO : Completed test dromaeo_css (00:18:34) 09:50:05 INFO - 2015-11-18 09:50:05,496 INFO : Starting test kraken 09:50:05 INFO - 2015-11-18 09:50:05,496 DEBUG : operating with platform_type : linux_ 09:50:05 INFO - 2015-11-18 09:50:05,496 INFO : Initialising browser for kraken test... 09:50:05 INFO - 2015-11-18 09:50:05,502 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9zF4a/profile http://localhost:44724/getInfo.html 09:50:10 INFO - 2015-11-18 09:50:10,067 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:10 INFO - 2015-11-18 09:50:10,067 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:10 INFO - 2015-11-18 09:50:10,068 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:50:10 INFO - 2015-11-18 09:50:10,068 DEBUG : BROWSER_OUTPUT: __metrics 09:50:11 INFO - 2015-11-18 09:50:11,181 INFO : Browser initialized. 09:50:11 INFO - 2015-11-18 09:50:11,182 INFO : Running cycle 1/1 for kraken test... 09:50:11 INFO - 2015-11-18 09:50:11,182 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW9zF4a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:23 INFO - 2015-11-18 09:50:23,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 142016512 09:50:23 INFO - 2015-11-18 09:50:23,212 DEBUG : BROWSER_OUTPUT: 09:50:25 INFO - 2015-11-18 09:50:25,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44724/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:26 INFO - 2015-11-18 09:50:26,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 141373440 09:50:26 INFO - 2015-11-18 09:50:26,443 DEBUG : BROWSER_OUTPUT: 09:50:29 INFO - 2015-11-18 09:50:29,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44724/tests/kraken/driver.html?testName=audio-dft) 09:50:29 INFO - 2015-11-18 09:50:29,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 140926976 09:50:29 INFO - 2015-11-18 09:50:29,836 DEBUG : BROWSER_OUTPUT: 09:50:32 INFO - 2015-11-18 09:50:32,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44724/tests/kraken/driver.html?testName=audio-fft) 09:50:33 INFO - 2015-11-18 09:50:33,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 137809920 09:50:33 INFO - 2015-11-18 09:50:33,325 DEBUG : BROWSER_OUTPUT: 09:50:35 INFO - 2015-11-18 09:50:35,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44724/tests/kraken/driver.html?testName=audio-oscillator) 09:50:36 INFO - 2015-11-18 09:50:36,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 137281536 09:50:36 INFO - 2015-11-18 09:50:36,020 DEBUG : BROWSER_OUTPUT: 09:50:38 INFO - 2015-11-18 09:50:38,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44724/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:38 INFO - 2015-11-18 09:50:38,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 137293824 09:50:38 INFO - 2015-11-18 09:50:38,853 DEBUG : BROWSER_OUTPUT: 09:50:41 INFO - 2015-11-18 09:50:41,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44724/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:42 INFO - 2015-11-18 09:50:42,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 137216000 09:50:42 INFO - 2015-11-18 09:50:42,542 DEBUG : BROWSER_OUTPUT: 09:50:46 INFO - 2015-11-18 09:50:46,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44724/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:46 INFO - 2015-11-18 09:50:46,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 136237056 09:50:46 INFO - 2015-11-18 09:50:46,643 DEBUG : BROWSER_OUTPUT: 09:50:49 INFO - 2015-11-18 09:50:49,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44724/tests/kraken/driver.html?testName=json-parse-financial) 09:50:50 INFO - 2015-11-18 09:50:50,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 136871936 09:50:50 INFO - 2015-11-18 09:50:50,168 DEBUG : BROWSER_OUTPUT: 09:50:51 INFO - 2015-11-18 09:50:51,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44724/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:52 INFO - 2015-11-18 09:50:52,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 09:50:52 INFO - 2015-11-18 09:50:52,543 DEBUG : BROWSER_OUTPUT: 09:50:54 INFO - 2015-11-18 09:50:54,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:55 INFO - 2015-11-18 09:50:55,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 138424320 09:50:55 INFO - 2015-11-18 09:50:55,057 DEBUG : BROWSER_OUTPUT: 09:50:57 INFO - 2015-11-18 09:50:57,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:57 INFO - 2015-11-18 09:50:57,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 140124160 09:50:57 INFO - 2015-11-18 09:50:57,845 DEBUG : BROWSER_OUTPUT: 09:51:00 INFO - 2015-11-18 09:51:00,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:01 INFO - 2015-11-18 09:51:01,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 138924032 09:51:01 INFO - 2015-11-18 09:51:01,090 DEBUG : BROWSER_OUTPUT: 09:51:03 INFO - 2015-11-18 09:51:03,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:04 INFO - 2015-11-18 09:51:04,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 139767808 09:51:04 INFO - 2015-11-18 09:51:04,334 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44724/tests/kraken/driver.html?testName=ai-astar) 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;114;114;113;126;115;115;117;115 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;135;158;181;138;159;176;135;177;132 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;162;165;172;165;163;165;164 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;74;73;146;73;75;74;73;147 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;126;92;92;93;137;92;91;127 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;110;110;110;110;110 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;149;149;150;148;150;150;150;150;149 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;95;95;97;96;96;96;96;96 09:51:06 INFO - 2015-11-18 09:51:06,367 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;75;77;75;77;73;83;71;74 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;70;70;69;70;71;71;71;70 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;88;85;87;87;84;85;86;87;85 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;134;129;128;141;129;140;130;130;127 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;155;159;158;155;157;156;154;160;142 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;73;70;73;72;69;71;72;71 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,773 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: __startTimestamp1447869066362__endTimestamp 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,368 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:4.30 (3.7%) stddev-sans-first:4.56 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 114.0 114.0 113.0 126.0 115.0 115.0 117.0 115.0 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.40 Median:158.50 stddev:18.99 (12.0%) stddev-sans-first:20.13 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: Values: 153.0 135.0 158.0 181.0 138.0 159.0 176.0 135.0 177.0 132.0 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.88 (1.7%) stddev-sans-first:3.05 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 162.0 165.0 172.0 165.0 163.0 165.0 164.0 09:51:06 INFO - 2015-11-18 09:51:06,369 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.10 Median:73.50 stddev:30.79 (41.9%) stddev-sans-first:32.10 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 74.0 73.0 146.0 73.0 75.0 74.0 73.0 147.0 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:92.00 stddev:18.52 (20.1%) stddev-sans-first:19.25 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 126.0 92.0 92.0 93.0 137.0 92.0 91.0 127.0 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 09:51:06 INFO - 2015-11-18 09:51:06,370 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.50 Median:150.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: Values: 150.0 149.0 149.0 150.0 148.0 150.0 150.0 150.0 150.0 149.0 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 95.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:75.00 stddev:3.20 (4.3%) stddev-sans-first:3.40 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 75.0 77.0 75.0 77.0 73.0 83.0 71.0 74.0 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 70.0 69.0 70.0 71.0 71.0 71.0 70.0 09:51:06 INFO - 2015-11-18 09:51:06,372 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: Values: 86.0 88.0 85.0 87.0 87.0 84.0 85.0 86.0 87.0 85.0 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:130.00 stddev:5.67 (4.4%) stddev-sans-first:5.20 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: Values: 123.0 134.0 129.0 128.0 141.0 129.0 140.0 130.0 130.0 127.0 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:156.50 stddev:6.30 (4.0%) stddev-sans-first:5.30 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: Values: 143.0 155.0 159.0 158.0 155.0 157.0 156.0 154.0 160.0 142.0 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 73.0 70.0 73.0 72.0 69.0 71.0 72.0 71.0 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:06 INFO - 2015-11-18 09:51:06,373 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-18 09:51:07,357 INFO : Browser exited with error code: 0 09:51:07 INFO - 2015-11-18 09:51:07,413 INFO : Completed test kraken (00:01:01) 09:51:07 INFO - 2015-11-18 09:51:07,413 INFO : Starting test v8_7 09:51:07 INFO - 2015-11-18 09:51:07,414 DEBUG : operating with platform_type : linux_ 09:51:07 INFO - 2015-11-18 09:51:07,414 INFO : Initialising browser for v8_7 test... 09:51:07 INFO - 2015-11-18 09:51:07,420 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJKDpX/profile http://localhost:44724/getInfo.html 09:51:11 INFO - 2015-11-18 09:51:11,978 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:51:11 INFO - 2015-11-18 09:51:11,978 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:51:11 INFO - 2015-11-18 09:51:11,978 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:51:11 INFO - 2015-11-18 09:51:11,978 DEBUG : BROWSER_OUTPUT: __metrics 09:51:13 INFO - 2015-11-18 09:51:13,058 INFO : Browser initialized. 09:51:13 INFO - 2015-11-18 09:51:13,058 INFO : Running cycle 1/1 for v8_7 test... 09:51:13 INFO - 2015-11-18 09:51:13,058 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJKDpX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:51:25 INFO - 2015-11-18 09:51:25,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 142123008 09:51:25 INFO - 2015-11-18 09:51:25,053 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44724/tests/v8_7/run.html (next: http://localhost:44724/tests/v8_7/run.html) 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:46 INFO - 2015-11-18 09:51:46,806 DEBUG : BROWSER_OUTPUT: |0;Richards;164.04199475065616 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.7173211914248 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1078.7486515641856 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |5;Earley;730.4601899196493 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |7;RegExp;25897.4358974359 09:51:46 INFO - 2015-11-18 09:51:46,807 DEBUG : BROWSER_OUTPUT: |8;Splay;600.1188354129531 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: __startTimestamp1447869106804__endTimestamp 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.04 Median:164.04 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: Values: 164.0 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.72 Median:189.72 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: Values: 189.7 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,808 DEBUG : BROWSER_OUTPUT: Values: 280.1 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: Values: 5025.1 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: Values: 1078.7 09:51:46 INFO - 2015-11-18 09:51:46,809 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:730.46 Median:730.46 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: Values: 730.5 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: Values: 12219.5 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,810 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25897.44 Median:25897.44 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: Values: 25897.4 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.12 Median:600.12 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: Values: 600.1 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 09:51:46 INFO - 2015-11-18 09:51:46,811 DEBUG : BROWSER_OUTPUT: Values: 4854.4 09:51:46 INFO - 2015-11-18 09:51:46,812 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:46 INFO - 2015-11-18 09:51:46,812 DEBUG : BROWSER_OUTPUT: 09:51:47 INFO - 2015-11-18 09:51:47,709 INFO : Browser exited with error code: 0 09:51:47 INFO - 2015-11-18 09:51:47,721 INFO : Completed test v8_7 (00:00:40) 09:51:47 INFO - 2015-11-18 09:51:47,805 INFO : Completed test suite (00:20:16) 09:51:47 INFO - 2015-11-18 09:51:47,805 DEBUG : Working with test: dromaeo_css 09:51:47 INFO - 2015-11-18 09:51:47,805 DEBUG : Generating results file: dromaeo_css 09:51:47 INFO - 2015-11-18 09:51:47,806 DEBUG : Working with test: kraken 09:51:47 INFO - 2015-11-18 09:51:47,806 DEBUG : Generating results file: kraken 09:51:47 INFO - 2015-11-18 09:51:47,806 INFO : javascript benchmark 09:51:47 INFO - 2015-11-18 09:51:47,807 DEBUG : Working with test: v8_7 09:51:47 INFO - 2015-11-18 09:51:47,807 DEBUG : Generating results file: v8_7 09:51:47 INFO - 2015-11-18 09:51:47,807 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:47 INFO - 2015-11-18 09:51:47,856 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:51:47 INFO - 2015-11-18 09:51:47,856 DEBUG : process_Request line: dromaeo_css 5930.57 graph.html#tests=[[72,132,43]] 09:51:47 INFO - 2015-11-18 09:51:47,856 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:47 INFO - 2015-11-18 09:51:47,889 DEBUG : process_Request line: kraken 1569.30 graph.html#tests=[[232,132,43]] 09:51:47 INFO - 2015-11-18 09:51:47,889 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:47 INFO - 2015-11-18 09:51:47,920 DEBUG : process_Request line: v8_7 21339.67 graph.html#tests=[[230,132,43]] 09:51:47 INFO - 2015-11-18 09:51:47,922 INFO : javascript benchmark 09:51:47 INFO - 2015-11-18 09:51:47,925 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2693.1247344613002, 2698.37937274427, 2734.5898115282694, 2736.9726302736967, 2760.447910417917, 4526.569975852297, 4631.120087183433, 4668.859934201971, 4711.363965864607, 4776.426828780543, 4612.354270402138, 4699.647526435514, 4747.311639812234, 4751.667383283171, 4759.095771803355, 4309.1381723655395, 4344.348347747848, 4358.629516491102, 4360.08438227971, 4382.8904277393, 4390.714603550759, 4393.604575588196, 4453.354263631772, 4459.17505261526, 4496.572825581581, 4165.10450253194, 4178.477690288699, 4231.449911511484, 4248.065425606362, 4280.700350975433, 4276.144771045803, 4293.0, 4325.567443255681, 4334.0, 4344.23975804233, 4096.078382363944, 4257.446531950857, 4274.166537525184, 4281.229378711831, 4284.121755040241, 4498.595126438636, 4568.885777855547, 4654.069186162781, 4681.274402467623, 4708.952910470885, 5094.974525127388, 5139.15203991341, 5144.176931690949, 5148.948510514884, 5191.0, 4842.0, 4968.354113965162, 5143.562797162245, 5160.14857548504, 5196.350456192976, 4659.138059459011, 4682.882927926829, 4721.3390125382475, 4724.6692731508465, 4762.857114286577, 5154.201098829687, 5166.070107380632, 5177.870553236124, 5186.896262074737, 5231.215317702299, 4754.738489383048, 4864.537868902519, 4920.5571498565305, 4992.326035985168, 5064.164412871909, 5124.538791508782, 5165.431802501722, 5178.378594568676, 5191.480851914854, 5201.817936372209, 5085.313482679865, 5100.311457953203, 5104.540591346797, 5109.897802044013, 5145.07388670043, 4784.617230621542, 4890.975545122252, 4962.354893863775, 5040.36995375578, 5067.113255180328, 4244.660427165819, 4262.190183865056, 4279.251131052053, 4299.828006879752, 4332.241857674894, 3756.2111956489443, 3782.243551289753, 3795.886123416302, 3799.0, 3800.657940785343, 4192.706510544293, 4287.97856010718, 4344.4352234209355, 4423.535528769497, 4455.977720111444, 5085.821996230188, 5143.151380022255, 5169.198774190007, 5172.948270517247, 5212.061828870839, 4168.416421700964, 4434.911301773946, 4454.866354009385, 4455.6658250631335, 4495.280755079171, 4396.428464299621, 4446.466424029072, 4485.192665320208, 4496.3705081288645, 4526.0, 4859.246816743411, 4882.829100981448, 4890.828820991248, 4892.535209155125, 4893.6329775266995, 4854.9514504855915, 4973.154563724248, 5132.769025393941, 5137.820176293962, 5187.144121219956, 4751.928721069117, 4788.473267940593, 4816.518348165156, 4822.565969062801, 4848.660593758403, 4929.704217746947, 4981.701097934136, 4991.6006719463085, 5006.749662516932, 5075.720835354091, 4725.929111063406, 4851.830185943475, 4915.139850526215, 5066.9239961401345, 5094.770735316845, 4946.480619535041, 4963.081829861487, 4978.352814134139, 4986.376702912136, 4996.750162491933, 4915.11527924977, 4929.630277729113, 4947.45577986414, 4957.504249575014, 4959.355283813081, 4615.93076103852, 4700.365450664253, 4704.435467743892, 4823.059503396804, 4886.096072226649, 4960.107180707508, 4960.528749768766, 4969.155243608523, 4974.502549744997, 5008.048470790538, 4798.1123492154065, 4850.587700045395, 4851.636127290538, 4852.102361063215, 4859.246816743411], "unit": "ms", "name": "dojo.html", "value": 4640.333419053435}, {"lowerIsBetter": false, "replicates": [553.822776711452, 556.0991194265291, 576.0466428061558, 580.2456806152002, 580.6748220996243, 27649.72350276499, 28340.716592834066, 35952.0, 36764.26471470569, 36844.631553684456, 39173.608263917355, 39866.0, 39866.40200396989, 39966.40050399247, 39967.40048899269, 7944.841103177948, 8116.1478044805335, 8126.878096828523, 8130.634121464548, 8135.959320203391, 7818.0, 7943.24539168778, 7945.324647404977, 7971.561564113971, 7986.243026534182, 7902.723404680837, 7993.120756716757, 7994.9600251998945, 8056.718014869481, 8057.194280571925, 7859.8035049123655, 7926.0, 7995.200479952016, 7995.200479952016, 8003.559804210766, 7870.331021863149, 7987.840243195162, 8003.639836207385, 8013.639386227634, 8033.678652853879, 36331.273374532364, 36742.632573674186, 36816.63183368186, 36846.44730329047, 36927.446088308694, 2859.4138201668607, 2969.435807196626, 3146.5437511560926, 3566.4472006838982, 3656.6526180012856, 27977.0, 28334.574981375295, 28533.85733071342, 28787.71212287871, 29161.0, 2962.4075184963094, 3034.0746072447896, 3073.231692076981, 3075.9077227683206, 3147.5750773645495, 215807.0, 216305.9184704082, 216747.0, 216772.0, 218571.0, 51824.74087629538, 53093.469065309626, 55533.88932221333, 55856.44143558593, 56357.15464268039, 61440.69279653573, 62696.686516567126, 62732.0, 62761.68619156875, 62768.05847912285, 12634.81047784284, 12916.677083072998, 13020.609381718563, 13021.739565208643, 13039.478420863059, 9326.90673093274, 9332.90667093334, 9375.24998000172, 9379.202767764817, 9535.761605959906, 19267.456498698895, 19584.41246762571, 19597.706034409497, 19651.115699793543, 19663.60672786536, 7794.844103117905, 7884.132745398002, 7952.017993252531, 7955.0, 7967.123616402191, 795.9164287749819, 836.7825263052958, 875.7197696737111, 951.3150531617224, 1071.8124328242682, 26390.73609263921, 26580.202593922215, 29637.703622963927, 30556.442918180695, 30874.845625772177, 822.8313195794848, 828.4449418889359, 838.8070743728977, 840.6385254340693, 968.9563969621242, 13516.93241533786, 13540.729185416236, 13769.31153442344, 13788.379522921492, 13839.308034598229, 299013.0, 301938.0, 302965.0, 303104.0, 303512.0, 46496.7675161622, 46556.0, 46861.12555497742, 46983.06033879303, 46994.0, 1103.3600511703194, 1115.8828323026128, 1118.3792994887754, 1139.4986206069302, 1142.8000099982637, 25921.0, 26454.603180952687, 26462.867685661447, 26516.204513864614, 26887.327816803954, 39345.40981885331, 39963.2007359857, 39989.600103998586, 40092.59907401005, 40176.0, 238271.0, 238376.0, 240570.0, 240963.0, 241316.0, 28781.712182878742, 41892.0, 42847.5715242856, 42879.57120428756, 43338.56661433345, 45619.54380456153, 46254.76872615615, 46869.765651171525, 46987.0, 47141.29288060613, 32319.09128178381, 32815.507767383984, 33301.16747081342, 33759.0, 33913.49129763006, 33922.49116263307, 38243.617563825115, 38361.616383835804, 39175.0, 39776.60223397729, 31882.043538693877, 33091.66908330982, 33173.83413082919, 34423.48364774581, 34474.0, 29772.255693607833, 30240.84879575588, 30843.0, 30890.0732978011, 30923.536146957365, 24312.27063188107, 24409.75590244075, 24538.631920521562, 24587.0, 24605.753942461062], "unit": "ms", "name": "ext.html", "value": 17122.99470705599}, {"lowerIsBetter": false, "replicates": [308.2155913200905, 309.0, 311.85031185031187, 317.20065435103527, 317.67279701907034, 10831.0, 11207.831882521768, 15132.092074475526, 15764.448244311452, 15794.605134871634, 9677.70966870995, 9744.171745401649, 9790.167835733953, 9916.55375508102, 10035.949820250908, 3967.960320396795, 4098.077932465201, 4098.344264917614, 4102.97948510257, 4108.15782764534, 3490.354284457371, 4017.0, 4049.1699201663737, 4065.7560546367163, 4070.694697897655, 4301.376300436435, 4398.208322501949, 4404.273294906337, 4468.285074388098, 4488.910221795562, 4289.871303860874, 4311.267084595626, 4316.309390497537, 4327.956720432802, 4342.044750154961, 3535.982320088383, 3922.2547715934165, 3941.862034828796, 3942.25097231528, 3963.9405408918888, 11502.137339699557, 11604.30374177552, 11699.883001169965, 11796.94101529487, 12119.636410907688, 1646.9094199819006, 1700.7023770840053, 1740.4343588333843, 1764.2237415537122, 1794.2015802967685, 8879.911200887973, 8924.464532128028, 8979.416337938013, 9073.047330030318, 9122.22461090808, 1583.7545180496927, 1584.382090984517, 1601.807783066028, 1607.9678406431922, 1626.544567521096, 51498.22752658713, 52174.21738673923, 52486.47513524854, 52550.21174682383, 54135.0, 5995.670238136944, 6109.297430795426, 6121.602095863755, 6142.477889379364, 6169.074638804215, 7144.9285507145305, 7224.0, 7225.096862892138, 7226.7109315626785, 7236.855262894713, 4637.582617564435, 4642.303654451792, 4646.024334889711, 4680.836170734008, 4690.742009189527, 4555.703879247904, 4562.885927851764, 4613.5847773700525, 4624.12141693084, 4646.83736069236, 2800.1879454958244, 2845.644294463192, 2851.1019029005797, 2858.1568437311043, 2870.6124673169275, 993.8658281132099, 1005.648023191877, 1013.3312014070679, 1018.8930162332997, 1071.0039663113223, 334.2329354132272, 343.5430876933672, 345.4507333340001, 348.6931500279738, 361.0738455860709, 8683.2185103341, 9163.541822908828, 9306.348555601178, 9373.718788436357, 9405.106514881076, 355.48632226432557, 362.38937390497097, 364.71552189292396, 385.77624977512977, 396.7837528546949, 5006.098902197639, 5129.8717532062, 5144.456663001085, 5145.253938178943, 5155.896882062413, 478253.0, 489346.0, 492693.0, 495374.0, 499149.0, 64475.67762161159, 65721.0, 66624.0, 66738.66630666815, 67150.0, 400.46937807405305, 405.6349285642945, 406.2078946055145, 406.8392984770999, 407.32994224501124, 8766.824663506566, 8828.911710883065, 8933.687320943736, 8941.508217048126, 8978.326625503245, 30002.54996175103, 30261.243468913453, 30518.84740576283, 31157.376852463276, 31250.843745781127, 42239.155216896106, 42826.14347713091, 42909.0, 43031.569684302754, 43604.12791744211, 5913.6747478887355, 5926.7925622603, 5954.880902381841, 5980.8803823924145, 5985.581009329305, 10208.285420020527, 10272.435016073889, 10301.381917084998, 10329.74175645615, 10396.948015259875, 8018.3184429324165, 8244.83510329802, 8287.12985136552, 9741.853872192065, 9822.214222862296, 8690.435121717068, 8782.736517904474, 9042.140996605312, 9058.275337972815, 9115.407498512575, 9185.67850125269, 9554.04459554039, 9828.901710982798, 9845.655402060893, 9891.851622225528, 5767.452092051249, 5863.648181109147, 5882.94117058841, 5923.466887980103, 5941.643501389931, 8599.226069653761, 9302.488363140092, 9549.570269338035, 9574.281928855224, 9601.759956001157], "unit": "ms", "name": "jquery.html", "value": 5883.533579510334}, {"lowerIsBetter": false, "replicates": [1481.4666719980812, 1597.281223449448, 1662.6425318556508, 1663.093613980381, 1680.731083026716, 5475.534579560742, 5712.428757124286, 6465.9676701616545, 6864.622445765481, 6868.8969665455, 6373.107764912916, 6656.101426307447, 6687.197536295639, 6688.3646053624825, 6711.966440167792, 1921.5868588253488, 1943.7667479902432, 1950.2101648832174, 1953.6092781443697, 1960.0297852563, 1878.2862512245329, 1880.58627102038, 1883.0867029490687, 1972.1322618048084, 1976.505873531617, 1930.5849242412878, 1945.5816999345138, 1948.6589846776828, 1952.0, 1965.7935916728752, 1763.7266223735342, 1792.8027916929193, 1793.9192736326831, 1801.0544464156292, 1803.0624075480678, 1766.2669991953453, 1780.7863056433182, 1923.422973108062, 1935.77738560066, 1942.815432533907, 6669.399754022162, 6687.632180230085, 6726.764563240263, 6746.460283177334, 6748.527603067787, 3763.8682646107527, 3825.9808700956596, 3838.366669499529, 3840.577536470986, 3841.7118716096406, 2304.2626359564947, 2370.194133994433, 2679.410529683486, 2710.566309390488, 2735.8221715588425, 853.2789792625284, 868.3227082875368, 880.8414485392627, 881.154092071612, 888.0852721696663, 8914.55427228636, 8918.241949434307, 8946.55267236642, 8969.0, 8990.730278091602, 3524.6122926478065, 3597.406427939413, 3694.7783133012103, 3710.406334986389, 3715.5727091384297, 7271.527350722186, 7402.222766609429, 7406.7037318506655, 7407.0, 7443.2184620615135, 3865.4201869719204, 3872.1674839909556, 3874.6900247980093, 3878.0886491674432, 3881.7670939743707, 3535.381308271042, 3537.699295559855, 3539.823008849547, 3544.911377215539, 3554.7156227501737, 2929.6484421869513, 2930.6190195274476, 2953.985230073879, 2955.054382597591, 2966.2880908581783, 854.3933806997102, 855.5508358112041, 859.0679113162164, 861.2421069458961, 872.5637181409295, 972.1396564040733, 1055.994720026395, 1066.4081434803759, 1076.8115579773664, 1088.216484131424, 6343.746250149942, 6371.649559274284, 6425.261094974137, 6427.550071495044, 6437.613743175424, 964.4213471916934, 983.4787562591838, 989.618996686281, 1001.6544292219173, 1007.0433088565892, 5038.697678139323, 5052.722100284446, 5077.898442031139, 5226.372835259793, 5232.2413250078525, 6972.1284839395075, 7207.639618019078, 7650.923490765021, 7942.205779422012, 7998.160193179749, 7917.960410198028, 7924.326432253323, 7934.166912474223, 7956.0, 7985.161558036439, 6218.31598524162, 6279.340669229665, 6289.999999999908, 6291.9685401573615, 6370.0763389308295, 6358.0780786784735, 6369.0, 6394.200724909387, 6400.55196136266, 6434.195725534309, 7034.824129396806, 7085.681144348414, 7092.574445533284, 7120.572765634079, 7125.893111603226, 7140.2859714030255, 7167.749128780468, 7210.423166146591, 7378.409727221917, 7390.482666213528, 5754.7122643866805, 5834.329052159056, 5841.415858414124, 5841.620294680833, 5842.415758424124, 6369.522285828674, 6397.072424498515, 6406.807795766134, 6446.065320528591, 6475.935240647722, 6260.812175634738, 6274.592151510137, 6326.493880489642, 6392.264889537762, 6401.487880969605, 5898.1152827076285, 6057.697115144313, 6131.877362452815, 6200.131981522501, 6227.408396202353, 6046.7278972445465, 6185.536084793748, 6261.968690156702, 6300.21247344082, 6337.7148028337915, 5805.767769289181, 5823.242978412949, 5838.386969368155, 5844.327902291291, 5849.444302791228, 5823.650580965155, 5829.8251052468495, 5833.737481813244, 5841.737121829443, 5844.912326315194], "unit": "ms", "name": "mootools.html", "value": 3834.063223420121}, {"lowerIsBetter": false, "replicates": [271.1012991931746, 272.1441067841638, 278.84942131249124, 279.3226425917152, 281.52703458190257, 5624.77500899964, 5638.746256418461, 5683.886322273557, 5691.288588926384, 5752.482276595106, 5556.055470570002, 5602.971985140079, 5618.0449323614985, 5630.211770352154, 5631.57763167762, 4138.793060346986, 4180.184863951523, 4181.121964387482, 4181.916361672765, 4191.979040104795, 4183.686223533232, 4188.350805625133, 4188.371744238373, 4188.518320393148, 4189.6438802701805, 4002.6597739192057, 4092.85675001375, 4099.139180772041, 4136.751794892301, 4145.5647157048525, 4096.795160241976, 4098.446709694198, 4119.938200926988, 4132.896677583054, 4138.91722165555, 3502.597201321855, 3505.3339865425487, 3505.7020153287003, 3510.1400156961454, 3516.1561225306, 5398.703071331075, 5413.972930135364, 5421.810236641738, 5426.810061647863, 5428.5928555358505, 4588.197065513522, 4714.858554243378, 4758.881027974294, 4778.713277203379, 4786.545278198566, 5673.914891276634, 5824.592278540504, 5881.05903055509, 5890.8821823563285, 5899.823005309848, 3867.941980870289, 3871.1483473635753, 3888.863889763845, 3890.9027274318087, 3896.2207558488417, 6130.325664176937, 6159.353267906895, 6175.814725558241, 6203.565750397474, 6210.65841378724, 3895.6883449324555, 3961.445397644332, 3977.76133431995, 3982.38273067675, 3996.7801770902297, 4051.230266249403, 4052.65552428041, 4055.3511438169753, 4055.371417430303, 4056.9797151014054, 4762.59517940972, 4765.404324459442, 4771.260454629538, 4782.641301902371, 4783.091212669651, 5871.735771890275, 5904.439078287556, 5909.8227053188475, 5912.526997840248, 5919.260092488439, 1376.43566137885, 1395.5255213227551, 1407.1064873805208, 1419.6025112968384, 1424.6865689548283, 916.4089162490156, 923.8198551282435, 925.7225029459303, 929.8279818233649, 936.9859452108224, 5043.798248070036, 5065.6200784941275, 5118.667286626357, 5121.897562048738, 5144.6913185209005, 6087.0, 6100.023996160682, 6103.1455596216565, 6104.4505994460715, 6125.663088530174, 5092.28707980883, 5095.515925987025, 5105.897882042413, 5113.41195762492, 5115.283860259492, 3231.4829627259996, 3269.4768836986445, 3297.291082417292, 3317.6018877734346, 3320.6679332067083, 5757.913631295534, 5767.077267637158, 5771.422857714195, 5780.797672081457, 5784.305883294031, 6241.095041218998, 6243.063540468966, 6269.498440124779, 6278.121063051177, 6296.118543403927, 5613.017721898733, 5702.429757024264, 5729.971350143306, 5742.0, 5744.913826292609, 6057.939420605738, 6072.332043475126, 6087.969560152348, 6094.878102437838, 6102.694865256808, 5944.0, 5967.582269241111, 5968.76124954997, 5969.955257829949, 5982.641041537521, 5748.798792042258, 5762.279715035621, 5766.509846663081, 5774.82675519735, 5775.797847075332, 3903.726739128234, 3981.7610943343493, 3989.7207195496035, 3991.4212439196735, 3997.620226078518, 6006.279246490449, 6079.817605471843, 6084.543659225487, 6092.086187071975, 6121.3572574879, 5918.644881306963, 5928.49607783326, 5929.644221346733, 5936.614120082354, 5937.643741375531, 5832.9708351457975, 5866.090755932837, 5869.383714709894, 5889.499392551681, 5893.322267939242, 5685.687287199244, 5781.682007489629, 5801.0, 5804.622699524517, 5806.535477161901, 5991.970040149771, 6001.36985616504, 6001.4298641628975, 6001.519878409804, 6002.579819412599, 5750.683712395691, 5767.106098554731, 5783.739731712168, 5817.70911454434, 5823.679697616672], "unit": "ms", "name": "prototype.html", "value": 4316.714069798374}, {"lowerIsBetter": false, "replicates": [722.4978639845309, 742.58415287439, 785.6150486261731, 794.5868148562746, 819.799149208444, 11948.581799637015, 13474.932625336873, 13672.794908076363, 13701.520446784365, 13717.176969381819, 13044.673883152926, 13145.802812957812, 13167.0, 13175.077744557884, 13186.472541098345, 763.6868883757646, 776.2741836382971, 776.4021703288464, 777.7550071727388, 778.6612823421801, 757.5719718359137, 778.2995304226214, 778.5095389904352, 781.2968328504363, 787.1734678587488, 801.1467786807061, 804.047204063184, 804.0913767442781, 808.2604416958476, 809.0534075132109, 794.8211652378227, 796.928276455116, 799.0531220503722, 800.7998000499875, 802.6348011654742, 590.3181824992141, 590.4567797626195, 590.5541316306204, 590.5747861539727, 592.8725324055306, 11637.592684256011, 11659.242149260355, 11680.357580333079, 11752.823707644393, 11766.764664706743, 9239.168474837297, 9312.34813563051, 9324.953375233148, 9446.197073248713, 9480.099390557885, 8663.566821658891, 8852.247558957497, 9092.681756138569, 9256.074392560757, 10270.229732769998, 2921.649402071765, 2925.166327596625, 2935.119464160743, 2958.4378967996013, 2998.61018067652, 35467.11332216689, 35486.64513354859, 35649.46525802089, 35736.285274294365, 35774.0, 6853.348931851466, 7101.396381307543, 7154.427645788324, 7169.211386747558, 7178.066851309296, 10605.310654807412, 10613.416262105504, 10666.040056394962, 10712.410817404962, 10743.78512429747, 5654.434556544313, 5662.603617746719, 5662.66024038559, 5835.124731290255, 5844.970775146182, 3450.7066899313336, 3452.223249768782, 3463.757536972438, 3486.5293185419646, 3519.771214871025, 2443.3280847767005, 2447.5839107351794, 2450.803935685141, 2458.778709916116, 2471.826972111971, 383.3521348920316, 388.2041814280713, 391.5927435467082, 394.99605003950165, 396.6628365888971, 476.33313361294466, 553.7978637797255, 594.9732262048218, 606.2543072021439, 607.1772747926584, 8443.535605541754, 8699.826003479895, 8721.60752766127, 8867.280314677604, 9012.729618111336, 460.19006548474925, 464.9442066951987, 472.93615361925697, 527.1644443556928, 581.3750218515113, 4024.8591299304385, 4094.529129150126, 4096.91806163875, 4150.750954942713, 4233.745975241495, 50858.745706271235, 51282.23076653853, 51585.0, 51633.48366516362, 51698.48301517012, 44123.77938110289, 50649.49350506521, 51238.74380628073, 51316.48683513192, 51415.48584514182, 43246.13507729828, 44813.55186448159, 45332.320015199795, 45586.0, 46027.53972460233, 8121.918780812352, 8234.588270586328, 8253.050899146676, 8261.83476330458, 8531.488110713377, 31443.528347074356, 31586.368272633958, 31836.84081579577, 31895.0, 32831.50752738663, 40530.1893962125, 40566.1886762269, 40593.391099134125, 41419.1716165681, 41621.167576648906, 10754.677359679223, 10814.94580605415, 10905.58227430429, 11060.668179954615, 11087.445627718744, 11670.474828632561, 11725.296482211095, 11815.0, 11842.171048026556, 12550.87449125497, 11159.888401115884, 11340.432978351215, 11636.650900473, 11715.765684686428, 11722.238054526428, 10859.402732849769, 10961.45192740344, 10973.945130274298, 11003.284786488852, 11294.040006599202, 10549.261551691308, 10679.252452328263, 10758.031777140095, 11081.556737730723, 11191.32852028881, 9253.120953509406, 9407.43555386679, 9729.318947673595, 9816.561714413832, 10005.599776008878, 8868.379213455255, 9483.288753343664, 9525.333226674065, 9554.332588655656, 9597.136257736836], "unit": "ms", "name": "yui.html", "value": 5622.855609750088}], "name": "dromaeo_css", "value": 5930.575706681057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 114.0, 113.0, 126.0, 115.0, 115.0, 117.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 158.0, 181.0, 138.0, 159.0, 176.0, 135.0, 177.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 162.0, 165.0, 172.0, 165.0, 163.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 73.0, 146.0, 73.0, 75.0, 74.0, 73.0, 147.0], "unit": "ms", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 126.0, 92.0, 92.0, 93.0, 137.0, 92.0, 91.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 149.0, 150.0, 148.0, 150.0, 150.0, 150.0, 150.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 149.5}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 77.0, 75.0, 77.0, 73.0, 83.0, 71.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 71.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 85.0, 87.0, 87.0, 84.0, 85.0, 86.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [123.0, 134.0, 129.0, 128.0, 141.0, 129.0, 140.0, 130.0, 130.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.1}, {"lowerIsBetter": true, "replicates": [143.0, 155.0, 159.0, 158.0, 155.0, 157.0, 156.0, 154.0, 160.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.9}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 73.0, 70.0, 73.0, 72.0, 69.0, 71.0, 72.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1569.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.04199475065616], "unit": "score", "name": "Richards", "value": 215.20099200000004}, {"lowerIsBetter": false, "replicates": [189.7173211914248], "unit": "score", "name": "DeltaBlue", "value": 348.507978}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [730.4601899196493], "unit": "score", "name": "Earley", "value": 912.3878469999997}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25897.4358974359], "unit": "score", "name": "RegExp", "value": 35.17664851485149}, {"lowerIsBetter": false, "replicates": [600.1188354129531], "unit": "score", "name": "Splay", "value": 135.79143861386143}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21339.673890628867}]} 09:51:47 INFO - RETURN: dromaeo_css: 5930.57 09:51:47 INFO - RETURN: kraken: 1569.30 09:51:47 INFO - RETURN: v8_7: 21339.67 09:51:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21339.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1569.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5930.57"}}} 09:51:47 INFO - Return code: 0 09:51:47 INFO - # TBPL SUCCESS # 09:51:47 INFO - Running post-action listener: _resource_record_post_action 09:51:47 INFO - Running post-run listener: _resource_record_post_run 09:51:49 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501903360; Read time: 28; Write time: 420240 09:51:49 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 219926528; Read time: 0; Write time: 266892 09:51:49 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 278970368; Read time: 0; Write time: 131244 09:51:49 INFO - Running post-run listener: _upload_blobber_files 09:51:49 INFO - Blob upload gear active. 09:51:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:51:49 INFO - Copying logs to upload dir... 09:51:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1260.600105 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-18 09:51:48.854457) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 09:51:48.858181) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009873 build_url: 'https://queue.taskcluster.net/v1/task/EyJBlM76T9WLaSA5m6gtyQ/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 09:51:48.909407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:51:48.909757) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447867835.308070-889218895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 09:51:48.959971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 09:51:48.960438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 09:51:48.960785) ========= ========= Total master_lag: 0.21 =========