builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1448280817.64 results: success (0) buildid: 20151123025227 builduid: 7aa31ee9839b4c6280f36d4a4979eddb revision: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.637405) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.637768) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.638039) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.008415 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.665734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.665993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.683037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.683314) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.731565) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.731819) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.732145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.732444) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 04:13:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-23 04:13:38 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.877681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.877950) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.926998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:37.927319) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev db77a24c37698b4e71f8ba0fba170a0c157fc1f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev db77a24c37698b4e71f8ba0fba170a0c157fc1f9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 04:13:38,225 truncating revision to first 12 chars 2015-11-23 04:13:38,225 Setting DEBUG logging. 2015-11-23 04:13:38,225 attempt 1/10 2015-11-23 04:13:38,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/db77a24c3769?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:13:38,702 unpacking tar archive at: mozilla-central-db77a24c3769/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:38.699550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:38.699925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:38.710835) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:38.711106) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:13:38.711551) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-23 04:13:38.711864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:39 INFO - MultiFileLogger online at 20151123 04:13:39 in /builds/slave/test 04:13:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:39 INFO - {'append_to_log': False, 04:13:39 INFO - 'base_work_dir': '/builds/slave/test', 04:13:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:39 INFO - 'branch': 'Firefox-Non-PGO', 04:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:39 INFO - 'config_files': ('talos/linux_config.py',), 04:13:39 INFO - 'default_actions': ('clobber', 04:13:39 INFO - 'read-buildbot-config', 04:13:39 INFO - 'download-and-extract', 04:13:39 INFO - 'populate-webroot', 04:13:39 INFO - 'create-virtualenv', 04:13:39 INFO - 'install', 04:13:39 INFO - 'run-tests'), 04:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:39 INFO - 'download_minidump_stackwalk': True, 04:13:39 INFO - 'download_symbols': 'ondemand', 04:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:39 INFO - 'installer_path': 'installer.exe', 04:13:39 INFO - 'log_level': 'info', 04:13:39 INFO - 'log_name': 'talos', 04:13:39 INFO - 'log_to_console': True, 04:13:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:39 INFO - 'opt_config_files': (), 04:13:39 INFO - 'pip_index': False, 04:13:39 INFO - 'sps_profile': False, 04:13:39 INFO - 'sps_profile_interval': 0, 04:13:39 INFO - 'suite': 'dromaeojs', 04:13:39 INFO - 'system_bits': '64', 04:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:39 INFO - 'title': 'talos-linux64-ix-011', 04:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:39 INFO - 'use_talos_json': True, 04:13:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:39 INFO - 'work_dir': 'build'} 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running clobber step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: clobber 04:13:39 INFO - rmtree: /builds/slave/test/build 04:13:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running read-buildbot-config step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: read_buildbot_config 04:13:39 INFO - Using buildbot properties: 04:13:39 INFO - { 04:13:39 INFO - "properties": { 04:13:39 INFO - "buildnumber": 369, 04:13:39 INFO - "product": "firefox", 04:13:39 INFO - "script_repo_revision": "production", 04:13:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:13:39 INFO - "repository": "", 04:13:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:13:39 INFO - "buildid": "20151123025227", 04:13:39 INFO - "slavename": "talos-linux64-ix-011", 04:13:39 INFO - "pgo_build": "False", 04:13:39 INFO - "basedir": "/builds/slave/test", 04:13:39 INFO - "project": "", 04:13:39 INFO - "platform": "ubuntu64_hw", 04:13:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:39 INFO - "slavebuilddir": "test", 04:13:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:39 INFO - "branch": "mozilla-central", 04:13:39 INFO - "repo_path": "mozilla-central", 04:13:39 INFO - "stage_platform": "linux64", 04:13:39 INFO - "builduid": "7aa31ee9839b4c6280f36d4a4979eddb", 04:13:39 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:13:39 INFO - }, 04:13:39 INFO - "sourcestamp": { 04:13:39 INFO - "repository": "", 04:13:39 INFO - "hasPatch": false, 04:13:39 INFO - "project": "", 04:13:39 INFO - "branch": "mozilla-central-linux64-talos", 04:13:39 INFO - "changes": [ 04:13:39 INFO - { 04:13:39 INFO - "category": null, 04:13:39 INFO - "files": [ 04:13:39 INFO - { 04:13:39 INFO - "url": null, 04:13:39 INFO - "name": "https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:13:39 INFO - } 04:13:39 INFO - ], 04:13:39 INFO - "repository": "", 04:13:39 INFO - "rev": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9", 04:13:39 INFO - "who": "cbook@mozilla.com", 04:13:39 INFO - "when": 1448280796, 04:13:39 INFO - "number": 6694588, 04:13:39 INFO - "comments": "merge b2g-inbound to mozilla-central on a CLOSED TREE", 04:13:39 INFO - "project": "", 04:13:39 INFO - "at": "Mon 23 Nov 2015 04:13:16", 04:13:39 INFO - "branch": "mozilla-central-linux64-talos", 04:13:39 INFO - "revlink": "", 04:13:39 INFO - "properties": [ 04:13:39 INFO - [ 04:13:39 INFO - "buildid", 04:13:39 INFO - "20151123025227", 04:13:39 INFO - "Change" 04:13:39 INFO - ], 04:13:39 INFO - [ 04:13:39 INFO - "builduid", 04:13:39 INFO - "7aa31ee9839b4c6280f36d4a4979eddb", 04:13:39 INFO - "Change" 04:13:39 INFO - ], 04:13:39 INFO - [ 04:13:39 INFO - "pgo_build", 04:13:39 INFO - "False", 04:13:39 INFO - "Change" 04:13:39 INFO - ] 04:13:39 INFO - ], 04:13:39 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:13:39 INFO - } 04:13:39 INFO - ], 04:13:39 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:13:39 INFO - } 04:13:39 INFO - } 04:13:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:13:39 INFO - Running post-action listener: _resource_record_post_action 04:13:39 INFO - ##### 04:13:39 INFO - ##### Running download-and-extract step. 04:13:39 INFO - ##### 04:13:39 INFO - Running pre-action listener: _resource_record_pre_action 04:13:39 INFO - Running main action method: download_and_extract 04:13:39 INFO - mkdir: /builds/slave/test/build/tests 04:13:39 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')]} 04:13:39 INFO - https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/test_packages.json 04:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/test_packages.json 04:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:45 INFO - Downloaded 1302 bytes. 04:13:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:45 INFO - Using the following test package requirements: 04:13:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'jsshell-linux-x86_64.zip'], 04:13:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:45 INFO - https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:50 INFO - Downloaded 21338531 bytes. 04:13:50 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 04:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:50 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 04:13:51 INFO - Return code: 0 04:13: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 04:13: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')]} 04:13:52 INFO - https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:53 INFO - Downloaded 21338531 bytes. 04:13:53 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 04:13:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:53 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 04:13:54 INFO - Return code: 0 04:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:54 INFO - https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:55 INFO - Downloaded 11130997 bytes. 04:13:55 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 04:13:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:55 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 04:13:55 INFO - Return code: 0 04:13: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')]} 04:13:55 INFO - https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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 04:13:56 INFO - Downloaded 55910587 bytes. 04:13:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:56 INFO - mkdir: /builds/slave/test/properties 04:13:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:56 INFO - Contents: 04:13:56 INFO - build_url:https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:56 INFO - Running post-action listener: _resource_record_post_action 04:13:56 INFO - Running post-action listener: set_extra_try_arguments 04:13:56 INFO - ##### 04:13:56 INFO - ##### Running populate-webroot step. 04:13:56 INFO - ##### 04:13:56 INFO - Running pre-action listener: _resource_record_pre_action 04:13:56 INFO - Running main action method: populate_webroot 04:13:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:13:56 INFO - '../fennec_ids.txt'], 04:13:56 INFO - 'tests': ['tcheck2']}, 04:13:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:56 INFO - '--tppagecycles', 04:13:56 INFO - '7'], 04:13:56 INFO - 'tests': ['tsvgm']}}, 04:13:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'tests': ['damp', 'tps']}, 04:13:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['damp', 'tps']}, 04:13:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:56 INFO - 'other': {'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'other_l64': {'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:56 INFO - 'ts_paint', 04:13:56 INFO - 'tpaint', 04:13:56 INFO - 'sessionrestore', 04:13:56 INFO - 'sessionrestore_no_auto_restore']}, 04:13:56 INFO - 'svgr': {'tests': ['tsvgx', 04:13:56 INFO - 'tsvgr_opacity', 04:13:56 INFO - 'tart', 04:13:56 INFO - 'tscrollx', 04:13:56 INFO - 'cart']}, 04:13:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['tsvgx', 04:13:56 INFO - 'tsvgr_opacity', 04:13:56 INFO - 'tart', 04:13:56 INFO - 'tscrollx', 04:13:56 INFO - 'cart']}, 04:13:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'tests': ['tp5o']}, 04:13:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'talos_options': ['--e10s'], 04:13:56 INFO - 'tests': ['tp5o']}, 04:13:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'talos_options': ['--xperf_path', 04:13:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:56 INFO - 'tests': ['tp5n']}, 04:13:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:56 INFO - 'talos_options': ['--e10s', 04:13:56 INFO - '--xperf_path', 04:13:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:56 INFO - 'tests': ['tp5n']}}, 04:13:56 INFO - 'talos.zip': {'path': '', 04:13:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:56 INFO - Running post-action listener: _resource_record_post_action 04:13:56 INFO - ##### 04:13:56 INFO - ##### Running create-virtualenv step. 04:13:56 INFO - ##### 04:13:56 INFO - Running pre-action listener: _resource_record_pre_action 04:13:56 INFO - Running main action method: create_virtualenv 04:13:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:56 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 04:13:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:56 INFO - Using real prefix '/usr' 04:13:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:59 INFO - Installing pip.................done. 04:13:59 INFO - Return code: 0 04:13:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:59 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')]} 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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')]} 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:13:59 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 04:13:59 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 04:13:59 INFO - Using env: {'DISPLAY': ':0', 04:13:59 INFO - 'HOME': '/home/cltbld', 04:13:59 INFO - 'LANG': 'en_US.UTF-8', 04:13:59 INFO - 'LANGUAGE': 'en_US:en', 04:13:59 INFO - 'LOGNAME': 'cltbld', 04:13:59 INFO - 'MAIL': '/var/mail/cltbld', 04:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:59 INFO - 'MOZ_NO_REMOTE': '1', 04:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:59 INFO - 'NO_EM_RESTART': '1', 04:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:59 INFO - 'PWD': '/builds/slave/test', 04:13:59 INFO - 'SHELL': '/bin/bash', 04:13:59 INFO - 'SHLVL': '1', 04:13:59 INFO - 'TERM': 'linux', 04:13:59 INFO - 'TMOUT': '86400', 04:13:59 INFO - 'USER': 'cltbld', 04:13:59 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:59 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 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 04:13:59 INFO - Cleaning up... 04:13:59 INFO - Return code: 0 04:13:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:59 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')]} 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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')]} 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:59 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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:13:59 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 04:13:59 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 04:13:59 INFO - Using env: {'DISPLAY': ':0', 04:13:59 INFO - 'HOME': '/home/cltbld', 04:13:59 INFO - 'LANG': 'en_US.UTF-8', 04:13:59 INFO - 'LANGUAGE': 'en_US:en', 04:13:59 INFO - 'LOGNAME': 'cltbld', 04:13:59 INFO - 'MAIL': '/var/mail/cltbld', 04:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:59 INFO - 'MOZ_NO_REMOTE': '1', 04:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:59 INFO - 'NO_EM_RESTART': '1', 04:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:59 INFO - 'PWD': '/builds/slave/test', 04:13:59 INFO - 'SHELL': '/bin/bash', 04:13:59 INFO - 'SHLVL': '1', 04:13:59 INFO - 'TERM': 'linux', 04:13:59 INFO - 'TMOUT': '86400', 04:13:59 INFO - 'USER': 'cltbld', 04:13:59 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:59 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Downloading/unpacking psutil>=0.7.1 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:14:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:01 INFO - Installing collected packages: psutil 04:14:01 INFO - Running setup.py install for psutil 04:14:01 INFO - building 'psutil._psutil_linux' extension 04:14:01 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 04:14:01 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 04:14:01 INFO - building 'psutil._psutil_posix' extension 04:14:01 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 04:14:02 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 04:14:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:02 INFO - Successfully installed psutil 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:14:02 INFO - Using env: {'DISPLAY': ':0', 04:14:02 INFO - 'HOME': '/home/cltbld', 04:14:02 INFO - 'LANG': 'en_US.UTF-8', 04:14:02 INFO - 'LANGUAGE': 'en_US:en', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MAIL': '/var/mail/cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SHLVL': '1', 04:14:02 INFO - 'TERM': 'linux', 04:14:02 INFO - 'TMOUT': '86400', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:04 INFO - Installing collected packages: mozsystemmonitor 04:14:04 INFO - Running setup.py install for mozsystemmonitor 04:14:04 INFO - Successfully installed mozsystemmonitor 04:14:04 INFO - Cleaning up... 04:14:05 INFO - Return code: 0 04:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:05 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')]} 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 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')]} 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:14:05 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 04:14:05 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 04:14:05 INFO - Using env: {'DISPLAY': ':0', 04:14:05 INFO - 'HOME': '/home/cltbld', 04:14:05 INFO - 'LANG': 'en_US.UTF-8', 04:14:05 INFO - 'LANGUAGE': 'en_US:en', 04:14:05 INFO - 'LOGNAME': 'cltbld', 04:14:05 INFO - 'MAIL': '/var/mail/cltbld', 04:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:05 INFO - 'MOZ_NO_REMOTE': '1', 04:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:05 INFO - 'NO_EM_RESTART': '1', 04:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:05 INFO - 'PWD': '/builds/slave/test', 04:14:05 INFO - 'SHELL': '/bin/bash', 04:14:05 INFO - 'SHLVL': '1', 04:14:05 INFO - 'TERM': 'linux', 04:14:05 INFO - 'TMOUT': '86400', 04:14:05 INFO - 'USER': 'cltbld', 04:14:05 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:05 INFO - '_': '/tools/buildbot/bin/python'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:09 INFO - Downloading docopt-0.6.1.tar.gz 04:14:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:09 INFO - Running setup.py install for blobuploader 04:14:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:09 INFO - Running setup.py install for requests 04:14:09 INFO - Running setup.py install for docopt 04:14:09 INFO - Successfully installed blobuploader requests docopt 04:14:09 INFO - Cleaning up... 04:14:09 INFO - Return code: 0 04:14:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:14: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 04:14: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 04:14:09 INFO - Using env: {'DISPLAY': ':0', 04:14:09 INFO - 'HOME': '/home/cltbld', 04:14:09 INFO - 'LANG': 'en_US.UTF-8', 04:14:09 INFO - 'LANGUAGE': 'en_US:en', 04:14:09 INFO - 'LOGNAME': 'cltbld', 04:14:09 INFO - 'MAIL': '/var/mail/cltbld', 04:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:09 INFO - 'MOZ_NO_REMOTE': '1', 04:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:09 INFO - 'NO_EM_RESTART': '1', 04:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:09 INFO - 'PWD': '/builds/slave/test', 04:14:09 INFO - 'SHELL': '/bin/bash', 04:14:09 INFO - 'SHLVL': '1', 04:14:09 INFO - 'TERM': 'linux', 04:14:09 INFO - 'TMOUT': '86400', 04:14:09 INFO - 'USER': 'cltbld', 04:14:09 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:09 INFO - '_': '/tools/buildbot/bin/python'} 04:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:09 INFO - Running setup.py (path:/tmp/pip-7sFaL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:10 INFO - Running setup.py (path:/tmp/pip-614y1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:10 INFO - Running setup.py (path:/tmp/pip-KwMOqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:10 INFO - Running setup.py (path:/tmp/pip-wzTi8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:10 INFO - Running setup.py (path:/tmp/pip-n2vxN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:10 INFO - Running setup.py (path:/tmp/pip-PozCU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:10 INFO - Running setup.py (path:/tmp/pip-ziJMl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:10 INFO - Running setup.py (path:/tmp/pip-P4YUgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:10 INFO - Running setup.py (path:/tmp/pip-BlZLZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:10 INFO - Running setup.py (path:/tmp/pip-QE5acM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:10 INFO - Running setup.py (path:/tmp/pip-wyxrOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:10 INFO - Running setup.py (path:/tmp/pip-KUnZHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:10 INFO - Running setup.py (path:/tmp/pip-rVNv9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:10 INFO - Running setup.py (path:/tmp/pip-3xk1Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:10 INFO - Running setup.py (path:/tmp/pip-Uaa3os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:11 INFO - Running setup.py (path:/tmp/pip-wdMXaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:11 INFO - Running setup.py (path:/tmp/pip-wJgF__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:11 INFO - Running setup.py install for manifestparser 04:14:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Running setup.py install for mozcrash 04:14:11 INFO - Running setup.py install for mozdebug 04:14:11 INFO - Running setup.py install for mozdevice 04:14:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Running setup.py install for mozfile 04:14:11 INFO - Running setup.py install for mozhttpd 04:14:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Running setup.py install for mozinfo 04:14:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Running setup.py install for mozInstall 04:14:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Running setup.py install for mozleak 04:14:12 INFO - Running setup.py install for mozlog 04:14:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Running setup.py install for moznetwork 04:14:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Running setup.py install for mozprocess 04:14:12 INFO - Running setup.py install for mozprofile 04:14:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Running setup.py install for mozrunner 04:14:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Running setup.py install for mozscreenshot 04:14:12 INFO - Running setup.py install for moztest 04:14:12 INFO - Running setup.py install for mozversion 04:14:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:12 INFO - Cleaning up... 04:14:12 INFO - Return code: 0 04:14:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:14: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 04:14: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 04:14:12 INFO - Using env: {'DISPLAY': ':0', 04:14:12 INFO - 'HOME': '/home/cltbld', 04:14:12 INFO - 'LANG': 'en_US.UTF-8', 04:14:12 INFO - 'LANGUAGE': 'en_US:en', 04:14:12 INFO - 'LOGNAME': 'cltbld', 04:14:12 INFO - 'MAIL': '/var/mail/cltbld', 04:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:12 INFO - 'MOZ_NO_REMOTE': '1', 04:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:12 INFO - 'NO_EM_RESTART': '1', 04:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:12 INFO - 'PWD': '/builds/slave/test', 04:14:12 INFO - 'SHELL': '/bin/bash', 04:14:12 INFO - 'SHLVL': '1', 04:14:12 INFO - 'TERM': 'linux', 04:14:12 INFO - 'TMOUT': '86400', 04:14:12 INFO - 'USER': 'cltbld', 04:14:12 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:12 INFO - '_': '/tools/buildbot/bin/python'} 04:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:13 INFO - Running setup.py (path:/tmp/pip-mRVZU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:13 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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:13 INFO - Running setup.py (path:/tmp/pip-iPIXuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:13 INFO - Running setup.py (path:/tmp/pip-Kujk97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:13 INFO - Running setup.py (path:/tmp/pip-hrVFFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:13 INFO - Running setup.py (path:/tmp/pip-Wb4CCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:13 INFO - Running setup.py (path:/tmp/pip-9USfJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:13 INFO - Running setup.py (path:/tmp/pip-r_fHYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:13 INFO - Running setup.py (path:/tmp/pip-tMG2G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:13 INFO - Running setup.py (path:/tmp/pip-nHSGcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:13 INFO - Running setup.py (path:/tmp/pip-TNqNUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:13 INFO - Running setup.py (path:/tmp/pip-jzq_pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:13 INFO - Running setup.py (path:/tmp/pip-CF7EmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14: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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:14 INFO - Running setup.py (path:/tmp/pip-nVH8ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:14 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)) 04:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:14 INFO - Running setup.py (path:/tmp/pip-foTBzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:14 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)) 04:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:14 INFO - Running setup.py (path:/tmp/pip-Oa_aaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:14 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)) 04:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:14 INFO - Running setup.py (path:/tmp/pip-uvKxxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14: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)) 04:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:14 INFO - Running setup.py (path:/tmp/pip-IlNDF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:16 INFO - Downloading blessings-1.5.1.tar.gz 04:14:16 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 04:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:16 INFO - Installing collected packages: blessings 04:14:16 INFO - Running setup.py install for blessings 04:14:16 INFO - Successfully installed blessings 04:14:16 INFO - Cleaning up... 04:14:16 INFO - Return code: 0 04:14:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:16 INFO - Reading from file tmpfile_stdout 04:14:16 INFO - Current package versions: 04:14:16 INFO - argparse == 1.2.1 04:14:16 INFO - blessings == 1.5.1 04:14:16 INFO - blobuploader == 1.2.4 04:14:16 INFO - docopt == 0.6.1 04:14:16 INFO - manifestparser == 1.1 04:14:16 INFO - mozInstall == 1.12 04:14:16 INFO - mozcrash == 0.16 04:14:16 INFO - mozdebug == 0.1 04:14:16 INFO - mozdevice == 0.47 04:14:16 INFO - mozfile == 1.2 04:14:16 INFO - mozhttpd == 0.7 04:14:16 INFO - mozinfo == 0.9 04:14:16 INFO - mozleak == 0.1 04:14:16 INFO - mozlog == 3.0 04:14:16 INFO - moznetwork == 0.27 04:14:16 INFO - mozprocess == 0.22 04:14:16 INFO - mozprofile == 0.27 04:14:16 INFO - mozrunner == 6.11 04:14:16 INFO - mozscreenshot == 0.1 04:14:16 INFO - mozsystemmonitor == 0.0 04:14:16 INFO - moztest == 0.7 04:14:16 INFO - mozversion == 1.4 04:14:16 INFO - psutil == 3.1.1 04:14:16 INFO - requests == 1.2.3 04:14:16 INFO - wsgiref == 0.1.2 04:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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 0x7f2d1d9a3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114a6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fb900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', '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 04:14: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 04:14: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 04:14:16 INFO - Using env: {'DISPLAY': ':0', 04:14:16 INFO - 'HOME': '/home/cltbld', 04:14:16 INFO - 'LANG': 'en_US.UTF-8', 04:14:16 INFO - 'LANGUAGE': 'en_US:en', 04:14:16 INFO - 'LOGNAME': 'cltbld', 04:14:16 INFO - 'MAIL': '/var/mail/cltbld', 04:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:16 INFO - 'MOZ_NO_REMOTE': '1', 04:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:16 INFO - 'NO_EM_RESTART': '1', 04:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:16 INFO - 'PWD': '/builds/slave/test', 04:14:16 INFO - 'SHELL': '/bin/bash', 04:14:16 INFO - 'SHLVL': '1', 04:14:16 INFO - 'TERM': 'linux', 04:14:16 INFO - 'TMOUT': '86400', 04:14:16 INFO - 'USER': 'cltbld', 04:14:16 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:16 INFO - '_': '/tools/buildbot/bin/python'} 04:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14:16 INFO - Cleaning up... 04:14:16 INFO - Return code: 0 04:14:16 INFO - Running post-action listener: _resource_record_post_action 04:14:16 INFO - Running post-action listener: _start_resource_monitoring 04:14:16 INFO - Starting resource monitoring. 04:14:16 INFO - ##### 04:14:16 INFO - ##### Running install step. 04:14:16 INFO - ##### 04:14:16 INFO - Running pre-action listener: _resource_record_pre_action 04:14:16 INFO - Running main action method: install 04:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:16 INFO - Reading from file tmpfile_stdout 04:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:17 INFO - Reading from file tmpfile_stdout 04:14:17 INFO - Output received: 04:14:17 INFO - Usage: mozinstall [options] installer 04:14:17 INFO - Options: 04:14:17 INFO - -h, --help show this help message and exit 04:14:17 INFO - -d DEST, --destination=DEST 04:14:17 INFO - Directory to install application into. [default: 04:14:17 INFO - "/builds/slave/test"] 04:14:17 INFO - --app=APP Application being installed. [default: firefox] 04:14:17 INFO - mkdir: /builds/slave/test/build/application 04:14:17 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'] 04:14:17 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 04:14:31 INFO - Reading from file tmpfile_stdout 04:14:31 INFO - Output received: 04:14:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:31 INFO - Running post-action listener: _resource_record_post_action 04:14:31 INFO - ##### 04:14:31 INFO - ##### Running run-tests step. 04:14:31 INFO - ##### 04:14:31 INFO - Running pre-action listener: _resource_record_pre_action 04:14:31 INFO - Running main action method: run_tests 04:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:31 INFO - Python 2.7.3 04:14:31 INFO - Return code: 0 04:14:31 INFO - grabbing minidump binary from tooltool 04:14:31 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')]} 04:14:31 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 0x1241b70>, '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 0x1292dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1293250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:31 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 04:14:31 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 04:14:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:31 INFO - Return code: 0 04:14:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 04:14:31 INFO - Using env: {'DISPLAY': ':0', 04:14:31 INFO - 'HOME': '/home/cltbld', 04:14:31 INFO - 'LANG': 'en_US.UTF-8', 04:14:31 INFO - 'LANGUAGE': 'en_US:en', 04:14:31 INFO - 'LOGNAME': 'cltbld', 04:14:31 INFO - 'MAIL': '/var/mail/cltbld', 04:14:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:31 INFO - 'MOZ_NO_REMOTE': '1', 04:14:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:31 INFO - 'NO_EM_RESTART': '1', 04:14:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:31 INFO - 'PWD': '/builds/slave/test', 04:14:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:31 INFO - 'SHELL': '/bin/bash', 04:14:31 INFO - 'SHLVL': '1', 04:14:31 INFO - 'TERM': 'linux', 04:14:31 INFO - 'TMOUT': '86400', 04:14:31 INFO - 'USER': 'cltbld', 04:14:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103', 04:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:31 INFO - '_': '/tools/buildbot/bin/python'} 04:14:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 04:14:31 INFO - mozversion INFO | application_buildid: 20151123025227 04:14:31 INFO - mozversion INFO | application_changeset: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 04:14:31 INFO - mozversion INFO | application_display_name: Nightly 04:14:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:31 INFO - mozversion INFO | application_name: Firefox 04:14:31 INFO - mozversion INFO | application_remotingname: firefox 04:14:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:14:31 INFO - mozversion INFO | application_vendor: Mozilla 04:14:31 INFO - mozversion INFO | application_version: 45.0a1 04:14:31 INFO - mozversion INFO | platform_buildid: 20151123025227 04:14:31 INFO - mozversion INFO | platform_changeset: db77a24c37698b4e71f8ba0fba170a0c157fc1f9 04:14:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:14:31 INFO - mozversion INFO | platform_version: 45.0a1 04:14:31 INFO - 2015-11-23 04:14:31,394 DEBUG : using testdate: 1448280871 04:14:31 INFO - 2015-11-23 04:14:31,394 DEBUG : actual date: 1448280871 04:14:31 INFO - 2015-11-23 04:14:31,403 INFO : starting webserver on 'localhost:53904' 04:14:31 INFO - 2015-11-23 04:14:31,404 INFO : Starting test suite talos-linux64-ix-011 04:14:31 INFO - 2015-11-23 04:14:31,404 INFO : Starting test dromaeo_css 04:14:31 INFO - 2015-11-23 04:14:31,404 DEBUG : operating with platform_type : linux_ 04:14:31 INFO - 2015-11-23 04:14:31,405 INFO : Initialising browser for dromaeo_css test... 04:14:31 INFO - 2015-11-23 04:14:31,421 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjpSTg/profile http://localhost:53904/getInfo.html 04:14:35 INFO - 2015-11-23 04:14:35,623 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:35 INFO - 2015-11-23 04:14:35,623 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:35 INFO - 2015-11-23 04:14:35,623 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:35 INFO - 2015-11-23 04:14:35,624 DEBUG : BROWSER_OUTPUT: __metrics 04:14:35 INFO - 2015-11-23 04:14:35,745 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:37 INFO - 2015-11-23 04:14:37,242 INFO : Browser initialized. 04:14:37 INFO - 2015-11-23 04:14:37,242 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:37 INFO - 2015-11-23 04:14:37,243 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjpSTg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:49 INFO - 2015-11-23 04:14:49,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 04:14:49 INFO - 2015-11-23 04:14:49,105 DEBUG : BROWSER_OUTPUT: 04:15:40 INFO - 2015-11-23 04:15:40,701 DEBUG : BROWSER_OUTPUT: 1448280940695 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] 04:17:53 INFO - 2015-11-23 04:17:53,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53904/tests/dromaeo/cssquery-ext.html) 04:17:54 INFO - 2015-11-23 04:17:54,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 252313600 04:17:54 INFO - 2015-11-23 04:17:54,454 DEBUG : BROWSER_OUTPUT: 04:20:56 INFO - 2015-11-23 04:20:56,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-ext.html (next: http://localhost:53904/tests/dromaeo/cssquery-jquery.html) 04:20:57 INFO - 2015-11-23 04:20:57,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 225353728 04:20:57 INFO - 2015-11-23 04:20:57,523 DEBUG : BROWSER_OUTPUT: 04:23:59 INFO - 2015-11-23 04:23:59,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53904/tests/dromaeo/cssquery-mootools.html) 04:24:00 INFO - 2015-11-23 04:24:00,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 214646784 04:24:00 INFO - 2015-11-23 04:24:00,176 DEBUG : BROWSER_OUTPUT: 04:27:02 INFO - 2015-11-23 04:27:02,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53904/tests/dromaeo/cssquery-prototype.html) 04:27:02 INFO - 2015-11-23 04:27:02,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 203218944 04:27:02 INFO - 2015-11-23 04:27:02,689 DEBUG : BROWSER_OUTPUT: 04:30:05 INFO - 2015-11-23 04:30:05,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53904/tests/dromaeo/cssquery-yui.html) 04:30:06 INFO - 2015-11-23 04:30:06,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 205336576 04:30:06 INFO - 2015-11-23 04:30:06,068 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-yui.html (next: http://localhost:53904/tests/dromaeo/cssquery-dojo.html) 04:33:08 INFO - 2015-11-23 04:33:08,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 248258560 04:33:08 INFO - 2015-11-23 04:33:08,785 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:08 INFO - 2015-11-23 04:33:08,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:08 INFO - 2015-11-23 04:33:08,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:08 INFO - 2015-11-23 04:33:08,787 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:08 INFO - 2015-11-23 04:33:08,790 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2644.352133727237;2741.6709994800626;2748.106865268788;2761.1716485054485;2761.420101778625;4426.136903303849;4542.931856022163;4724.220503616903;4752.572268495835;4766.189747742884;4629.976850115753;4661.790219440125;4666.556677115668;4765.666403351766;4768.856934291968;4340.544242854487;4361.323994780814;4376.387305777193;4436.068425630605;4457.041736026754;4116.608922152391;4418.97790511047;4424.225760491917;4470.441194850644;4484.372187893681;4185.518665353493;4240.173166232586;4312.37470566766;4332.4367832181615;4345.217860785057;4304.59106384896;4324.65402767781;4327.5239723630375;4347.174036933005;4384.298512238059;4057.6550993165615;4171.874843754692;4312.525622181557;4319.827206911751;4363.454568178978;4587.082583483317;4691.648126390534;4711.316859055418;4722.268048452495;4748.19280722278;5097.541221290065;5112.309838171836;5123.590112790967;5132.615053870974;5172.870678233036;4794.472608013116;4869.513048695102;5145.794168233266;5167.044096842059;5169.353830771153;4589.426321709786;4592.954070459253;4672.976635116803;4677.812887484531;4725.220338644154;5145.511176438233;5200.817971370984;5218.347706536683;5218.530332270114;5264.657797243167;4717.787699553528;4826.493218212107;5021.07110184617;5023.899522009539;5033.471485494044;4944.357233559686;4952.133376659071;5034.874128146826;5035.723035233097;5055.140626093573;5043.3191519145175;5090.49095090488;5099.796008159707;5110.131277682803;5146.408163061295;4694.483606803249;4820.807167713322;5063.3417655704525;5070.873228169326;5080.618953578496;4078.510578730512;4135.462389889295;4155.439015732898;4166.270902592034;4182.1008483176265;3755.061234691327;3756.718246131551;3757.8121093945742;3767.5478942526524;3793.393057110849;4437.290033594674;4439.533848945879;4441.422615060022;4447.466304043535;4476.686631935733;4754.833580824655;4912.189488734391;4915.926261106087;4966.776495057731;5025.623078269145;4291.313389857608;4320.524742278347;4328.978355108205;4348.847790327323;4375.387445757597;4440.49204109617;4444.555544445529;4450.532694067141;4466.754328511963;4487.820487180476;4537.705049171794;4687.203175460112;4688.460827004802;4737.857864264078;4822.903541929212;5107.744612769272;5112.565431938327;5115.411727651368;5115.769790359368;5126.7180305083575;4830.420349558076;4830.806767729251;4835.661503694708;4839.661223714306;4880.731559764247;4707.693999889996;4827.444843843003;4831.251156070814;4839.879003024953;5081.593472522263;5060.266261392004;5124.077666020152;5196.896062078662;5199.220116982332;5202.97398513005;4975.726335051607;5005.0740612985255;5005.899882002267;5010.098182327216;5049.520295571915;4651.488336282939;4716.29255611661;4771.23660214364;4772.570468657837;4955.6531042826655;4817.373741413594;4828.324034635084;4852.539008794159;4853.150698627655;4865.829695960624;4954.578860796729;4981.8007279709855;4983.103041452573;4986.052649996489;5022.874428139326;4632.305154226893;4708.764561771966;4752.667313288037;4753.738544380092;4850.490698476609 04:33:08 INFO - 2015-11-23 04:33:08,792 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.957853161013;565.6040771459977;567.6622409666252;571.5827445964446;590.0883135555569;29042.709572904292;29879.253018674517;37427.625723742756;37709.05727356818;37800.43299350505;41643.58356416435;42037.15925681485;42069.7896510517;42112.36831447531;42207.3668894966;7073.292670732912;8015.959920200391;8194.754157375288;8198.508089514618;8200.302974247166;7165.89251161233;7263.164736055369;7277.454190935675;7283.053203083592;7283.781486555412;10261.43562104084;10568.52441640128;10569.312994655362;10580.259381843274;10586.3648181109;10228;10317.277790554665;10332.173426125892;10345.32755370906;10351.948240258826;7228.710851565931;7435.330820226151;7435.888461673079;9890.060444257855;10064.949675251577;41284.58715412838;41868;42091;42168.57831421677;42209.577904220874;2916;2934.721201485877;2935.2955290730283;3426.640202778697;3434.9180008297308;27433.31416714578;28826.279343016384;29150.27124321888;29198;29894.252643683863;3188.3942051010235;3189.02989591498;3215.1319143831033;3240.951385729216;3245.2860370718404;227802;228994;229133;229237;229450;55821;56063.11337309605;56066.159007614915;56140.71929640407;56181.43818561844;58440;59103;59187.40812591819;59205.40794592085;59230;13392.129511581716;13875.791863122062;13967.511137110152;14039.78940315896;14048;10158.644447444303;10257.17942564593;10290.897091029143;10341.9482902585;10387.480625968672;18967.810321896606;19044.428667140008;19259.22963081489;19272.650914436137;19284.939328336797;7128.572285662877;7264.527805692613;7334.193238743734;7340.972263883061;7375.151857536452;852.8635418333037;860.7589874835056;867.197841996151;944.7024187380953;1033.5297439664935;24445.511089778105;25431;25458.49083018329;25470.962323014115;25510.362240944123;929.5166513412987;957.6025949230991;969.5249327829313;980.6175591519313;1006.1548299428515;14093;14505.274736263145;14569.271536423137;14755.262236888113;14931.552053438414;205792;209180;209459;209745;241824;38059.809700951875;44294.557054429046;45336.546634533894;45360;45426.772866135456;1202.8797120288077;1203.1277323940074;1220.1154163231586;1230.1143176912608;1312.1798875702686;22217.77782222157;23906.28281151568;24692.876535617208;25399.619005714558;27191.320216994733;38264.80867595644;38494.230115398095;38549.42175867308;38567;38619.80690096531;218325;218533;218603;219187;219500;28640;28858.42283154367;29141;29166.708332916398;29229;39658.40512392259;40520;40764.59235407608;40765.388519172826;40773.79613101915;33571;34363.48454773131;34981.47527787136;35293.82353088321;35351;32017.199570010936;34408.48387274143;34866;34919.47620785741;35108.82445587858;32946.67053329436;33365.66634333723;33510.16224594405;33948.81179158817;33960.15099622529;29785;30150.54774178345;30383.936562220217;30446.543301850048;30449.23876903095;23474.65667915106;23615.763842361357;23735.28794136179;23814.761852381947;23944.760552394255 04:33:08 INFO - 2015-11-23 04:33:08,792 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.58768009188765;336.92924485857986;341.97777144485605;343.6134348857535;344.5125147915699;12481.31352775597;12784.68038299043;15670.764938525917;15888.364465421384;16688.666226675476;15162.848371516282;15203.859710521727;15206.391744330214;15388.307526161321;15721;5000.52495012975;5004.574611158056;5109.718965456898;5114.258432527281;5119.948800511985;3626.4741612466178;3739.813009349535;3740.738148329618;3743.7005039596766;5055.317532133152;3713.795741234231;5729.197912292282;5878.588498805086;5932.466078052975;5940.821775346746;5692.430756924296;5847.327557330897;5889.087191485327;5891.970540147315;5938.6436813791315;5134.332536770196;5150.768215430277;5156.149235376159;5183.222516622499;5191.299174611417;19598.314059008007;19761.308354207533;20208.19167233309;20455.693164602544;20578.27976020832;1971.605678864233;2033.5119571302928;2044.4684382060623;2048.9180432782673;2084.9992003838242;12914.354282285942;13164.407601657853;13363.33183340829;13469.730605387836;13537.495563320817;1784.4289827255284;1793.2557988434785;1803.179553303244;1865.5895702945465;1948.65898467769;49153.75423122862;51189.232161517604;53261.73369133168;58138.41861581372;58704;15280.388784448498;15850.841491585166;15898.920505397398;15916.602084947968;15919.124448155462;23700.88149559241;23869.283921482383;23914.64128038081;23920.52158956811;23930.88034559816;8363.289120424832;8493.938257717786;8522.147785221428;8532;8568.22885940256;7041.260667629927;7060.0468936693915;7087.397571206402;7103.715851365888;7111.288871112951;7576.674082035622;7641.465097443125;7642.923570764332;7654.502457340366;7671.501352412075;1722.4746452331908;1735.6615459985435;1743.799463061764;2179.6294629912954;2966.9851650741607;386.1023121243065;787.775483987061;830.0205757206554;868.6525389843987;967.5355829202023;9837.360571562825;9943.701688949342;10124.240681948882;10255.58977640901;10287.742806429898;408.6608115264323;416.7312083705993;418.23880537422207;421.73220005296855;427.9828806847691;4982.6512144149565;5515.503604675599;5525.198846167284;5548.334199896039;5583.218349431083;423699;433791;477752;487461;490389;72631.63684181546;73035.26964730391;73379.26620733831;73387.63306183541;74259.57404259639;1035.6634093919506;1036.383351905615;1043.2644985285508;1062.2351906627216;1063.473580577619;14525.418983240552;14570.949854389914;14633.707325853211;14682.632934176303;14824.110553366832;32273;32774.836125819216;33507.66492335046;34619.48070778991;36029.63970360263;25165;25601;26338.604920926584;35152.945411637695;50759.746201268754;13642.113262637897;13657.044006919421;13990.300484975915;14032.508862189774;14294.356753945889;17489.737653934946;17518.73721894198;17519.562010949827;17826.37607683777;17858.821411785717;14403.927980360031;14429.134251944917;14489.855101448851;14903.478378257143;14933.850661493681;2230.4423894026495;10335.689929302132;14359.14342659297;14494.565163045125;15079.849201507845;9314.115159059878;9583.185429238592;9615.182709469773;9632.084951929555;15256.847431525986;13292.734145317232;13327.933360333136;13372.398242078934;13573.660658483617;13630.86369136296;11571.826422603835;12184.390780460764;14228.786568201693;14256;14260.932164836247 04:33:08 INFO - 2015-11-23 04:33:08,793 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1222.3460448659969;1614.6609212065468;1654.8427899349558;1670.5489517830185;1673.8577220936224;5872.354041055481;6612.3387661233855;6697.0289308050305;6746.6626668666495;6756.560823546472;6778.288279730631;6792.524523283372;6834.214065382483;6845.178578570566;6870.656467176634;2071.347525529461;2072.35756915356;2090.393785802123;2093.309207961369;2093.874367537945;1976.2786582897284;1994.840412766975;1999.3502111813646;2005.3983804858558;2005.6690646043457;2042.4077017664858;2051.148773259096;2060.3612880007245;2062.4225216939208;2064.2775028739898;1993.2326054468988;2003.168684995725;2006.1173083843134;2010.497375656086;2015.5968806238664;2015.5364266218705;2022.4236092713506;2075.242536474176;2077.4494758888904;2079.906404211799;5757.395473475309;6796.762113326059;6823.078884350599;6835.692393842289;6843.726250949956;3665.6151104133946;4058.939115913264;4165.541790403053;4169.708120431571;4179.26862799009;2694.892204311825;2768.3632764464087;2813.6482939632547;2839.2759846239283;2842.0763251942994;863.7149740585592;880.2210044111008;893.5800173918313;897.6409436225497;905.2395987370575;9111.863322050109;9160.35877488576;9165.908340916572;9175.128362805523;9190.035046320174;3917.196974620196;3918.7844668542934;3968.960310396859;3974.5429275633096;3982.1438390745548;8028.397870159762;8116.391270654606;8117.472364296302;8122.512649240946;8154.2253485918745;4252.340887162495;4254.914901702011;4258.5954334338185;4261.74429534229;4276.957230427656;3865.3042452358845;3891.105045839416;3891.9221615568094;3893.04620368006;3894.299026175259;3306.123877172551;3338.3490219407468;3352.949705754416;3355.681210285019;3370.241695618466;1087.260662749338;1088.1131877519797;1097.780443911221;1101.3832253937821;1117.017025017979;1037.6420135053395;1047.9318844275251;1056.1128651932413;1057.9153667706719;1092.426476100038;6515.315891831384;6558.737650493927;6578.473722102221;6591.736330546724;6602.636854973022;438.11938004610323;1083.707399002265;1100.1418893263267;1121.103117505992;1121.4560937945091;4846.733429661332;5152.690838549699;5186.273921650972;5266.947330526722;5274.657147285414;7299.635018249172;7899.170587088388;8120.75637730869;8126.512409255463;8128.105908350077;7922.881156782653;7970.561619111005;7990;8005.639746211435;8011.519308841488;6163.506919446433;6369.968150159312;6382.170317858741;6388.722255548909;6391.776287829996;6420.903686444613;6427.196600424947;6433;6444.065610486359;6445.677716114269;7020;7247.9637601811655;7249.927500725136;7266.818329541592;7271.818204544928;7175.569465832067;7357.337839594462;7359.37445317154;7365.8158546036775;7393.9260607393235;5805.3033635962265;5837.29952405714;5939.673317967553;5943.4948029416255;5950.7917222896995;6475.676216189266;6581.111549940888;6582.11141495911;6583.835404114935;6595.8021259362295;6240.095186198067;6250.093736408105;6251.937480625317;6276.215473065867;6405.743770249138;6209.379062093754;6230.875382492234;6262.279837818709;6317.5893566918;6330.746770129143;6180.227471566054;6226.3151053385;6258.311585725658;6267.561270711007;6287.842803929939;5861.677607731615;5898.970505147447;5906.645601263938;5908.822735317947;5916.023856063702;5877.265341832271;5881.088431293157;5941.31674857397;5948.732307046107;5969.313528944227 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.28656948726393;321.1169284467714;321.3717182907416;325.7345263610157;325.89408442256257;5340.118880384737;5393.757280922358;5395.082835917893;5397.055515284824;5415.025295446818;5047.26814611881;5137.17805151175;5235.973820130904;5281.735913204334;5321.946780532194;4193.329067349225;4212.9578704212945;4215.894602634928;4219.894502637428;4221.55673654265;4027.7986100694993;4216.936745948813;4218.0720241546815;4223.936640950388;4232.49210094789;4081.2449696806184;4095.7337773044806;4178.435911151986;4183.142455796569;4189.162167566499;4165.437665915123;4175.164967006595;4185.958140418587;4188.204241194163;4195.2029114468305;3697.3529632314508;3703.7222208334215;3703.7962912039825;3709.1098136447326;3717;5167.870803229949;5176.663516871391;5184.611154163415;5185.6888586684545;5186.896262074775;4650.674557751025;4787.569118779326;4789.473157952622;4802.639802014863;4844.055409195208;5642.915356269659;5656.462636049569;5658.377578466366;5660.801871934463;5669.971650141764;3955.3869150281753;3968.523777146761;3978.840846366171;3978.920421591581;3981.144054028398;5865.882682346371;5956.434138756855;5959.165716799652;5961.105834124916;5963.344032156459;3933.783641899666;4046.5953404659886;4051;4056.858009969637;4062.857799977046;4097.590240975878;4106.117184805281;4110.424540564323;4111.280525908014;4113.341865301538;4718.056388722201;4726.71639701619;4727.2436410174205;4729.810807567659;4732.52674732524;5637.436256374412;5642.181883626851;5668.773249070074;5686.459786320293;5687.544996400278;1435.9425622974964;1462.3711803924202;1520.9011414258039;1520.908745475275;1525.260248779341;1021.2544842265188;1049.1554298789547;1058.6559368205365;1069.5882085397022;1070.5343175718588;4887.144749668793;4895.192293271642;4897.8285759998225;4945.530174633404;4959.82640607577;5822;5824.912626310609;5825.912611310834;5827.504662103684;5833.125031245348;4793.856184314476;4894.070126675921;4902.656814022984;4940.258961155783;5025.195968644999;3155.353152603711;3167.6990685884803;3184.697453741891;3185.3629274145264;3190.4576222041846;5547.805826796042;5557.472040156179;5592.720363981784;5598.776048958078;5603.439656034364;5917.5857689961285;6067.666278354644;6082.665453400105;6088.056351265561;6090.116933044684;5617.101263797773;5625.521830644359;5627.155926611041;5628.030189433747;5628.6622802631155;5925.229720136354;5937.287525496968;5937.287525496968;5944.970275148597;5946.791862284799;5794.5364370851075;5805.129230615442;5809.2738407699035;5810.564207684356;5815.098659707752;5504.496050129371;5524.585656075891;5601.187827764869;5601.859953501195;5608.775648973995;4049.088954985105;4095.4675892133832;4100.446439730717;4101.1387608601335;4104.281750693676;5902.439268269508;5906.232189815297;5907.91138132937;5910.379410161871;5911;5562.972185139049;5667.093265077568;5669.858253543694;5677.5457963362005;5681.77272909079;5671;5675.8864822704145;5684.9431505684415;5685.658860468385;5686.886262274648;5542.972285138549;5564.219449776033;5565;5571.303587051619;5581.302337207849;5729.1119876419225;5731.140328950524;5735.569832262514;5735.713214339183;5736.139579063174;5443.918341224806;5579.191017302387;5613.550915926798;5615.2700148980375;5617.073182924772 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: |5;yui.html;676.3000294694991;791.7347688524344;803.3171803966627;813.7640084375528;825.5954582254693;12325;12511.249325040493;12511.937440312808;12518.937405312983;12529;12113.788621137905;12214.389280535983;12222.755544889096;13524.93237533811;13877.097988630758;633.0188208277175;806.9394795390355;821.2936874288107;822.0382152881114;822.1942496353577;632.5319263744842;808.4825711544617;818.153211426174;819.1194465949098;819.8811172380001;836.0385556609917;849.5454931611589;849.617672047578;849.8725191221305;849.9107593702665;656.3305428462988;662.1888186970922;832.9458585191943;844.907060223375;846.9195426434479;625.3621306267627;627.3914303125961;629.2291942370605;629.6190804563219;629.937006299371;12765.297908615023;12979.221246725132;12983.35083245834;12986.935065324707;13006.479740810357;11002.724931876766;11412.087033037336;11412.771744565145;11802.990237489385;11892.940535297355;9122.179003889616;9465.858012129824;9914.40513569181;9970.90029099707;10209.795804083951;3207.631122420928;3242.383947050053;3261.7879837810465;3263.689949454798;3291.2759192977505;43001.56998430038;43067;43717.562824371664;43723.34414983778;44491.555084449064;9397.530123493798;9419.387739796892;9516.666916657883;9567.899691535562;9632.47021413829;16813.32746690143;16827.41104061352;16855;16856.410025649042;16862.747058793884;6356.110144579762;6541.607503549707;6550.672466376757;6566.277709451956;6638.535302528873;3591.892243232707;3679.3745063339297;3692.9706866710635;3781.7352785304765;3858.2476417098396;2707.878145483458;2720.945581088407;2722.986385068062;2726.700062993069;2736.466389054155;502.7762645622736;503.03668474870943;509.4905094905095;512.5182328611094;514.0951924612634;533.9534512355749;554.6699713670359;610.3225419784036;625.2278436131375;637.4040272345372;7822.335101516434;8059.661260613694;8184.6316915738935;8255;8312.625931833081;506.364512536764;542.2327406719527;581.3808294166699;620.9348018458087;636.2587585462884;3611.331903597843;3766.9434958475645;3958.2083583283456;4002.819873105659;4095.7952102395357;52782.736086319324;53268;53359.932801343755;53372.73313633407;53443.465565344624;43389.34915976263;43455.782721086194;43469;43867;43944.78027609841;41133;42857.78571107124;43115.7844210777;44232.557674422846;44251.557484425386;8101.918980810116;8508.787280318042;8572.785680358042;8620.913790862262;8918.643254270017;32309.35381292408;33023.50464742983;33571.160720982174;33609.327813444084;33830.49254261139;42356.36465452959;42927;42936;43135.13729725451;43193.568064318955;10321.277510574188;10542.26204165701;10567.524461399102;10574.629887953884;10657.626983055556;12032.879671203526;12040.618472209742;12046.457909394274;12139.635810925687;12327.75344493123;10866.945665271624;10906.2365634408;10992.945035275092;11106.555737770399;11159.72100697489;10976.451177441255;10990.615328463466;11042.558297668325;11214.15893807984;11362.715932101764;8529.275011623833;9583.802024746907;10587.841182382117;10705.785884282115;10884.07485363753;9469.195118414736;9473.621055157717;9547.570359333986;10024.548895299584;10058.8491172631;7212.639368031682;9006.54967251648;9069.319801014819;9076.319276054455;9183.403078799856 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: __startTimestamp1448281988786__endTimestamp 04:33:08 INFO - 2015-11-23 04:33:08,795 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,796 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:08 INFO - 2015-11-23 04:33:08,796 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:08 INFO - 2015-11-23 04:33:08,796 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,796 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4650.99 Median:4752.57 stddev:485.55 (10.2%) stddev-sans-first:460.82 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: Values: 2644.4 2741.7 2748.1 2761.2 2761.4 4426.1 4542.9 4724.2 4752.6 4766.2 4630.0 4661.8 4666.6 4765.7 4768.9 4340.5 4361.3 4376.4 4436.1 4457.0 4116.6 4419.0 4424.2 4470.4 4484.4 4185.5 4240.2 4312.4 4332.4 4345.2 4304.6 4324.7 4327.5 4347.2 4384.3 4057.7 4171.9 4312.5 4319.8 4363.5 4587.1 4691.6 4711.3 4722.3 4748.2 5097.5 5112.3 5123.6 5132.6 5172.9 4794.5 4869.5 5145.8 5167.0 5169.4 4589.4 4593.0 4673.0 4677.8 4725.2 5145.5 5200.8 5218.3 5218.5 5264.7 4717.8 4826.5 5021.1 5023.9 5033.5 4944.4 4952.1 5034.9 5035.7 5055.1 5043.3 5090.5 5099.8 5110.1 5146.4 4694.5 4820.8 5063.3 5070.9 5080.6 4078.5 4135.5 4155.4 4166.3 4182.1 3755.1 3756.7 3757.8 3767.5 3793.4 4437.3 4439.5 4441.4 4447.5 4476.7 4754.8 4912.2 4915.9 4966.8 5025.6 4291.3 4320.5 4329.0 4348.8 4375.4 4440.5 4444.6 4450.5 4466.8 4487.8 4537.7 4687.2 4688.5 4737.9 4822.9 5107.7 5112.6 5115.4 5115.8 5126.7 4830.4 4830.8 4835.7 4839.7 4880.7 4707.7 4827.4 4831.3 4839.9 5081.6 5060.3 5124.1 5196.9 5199.2 5203.0 4975.7 5005.1 5005.9 5010.1 5049.5 4651.5 4716.3 4771.2 4772.6 4955.7 4817.4 4828.3 4852.5 4853.2 4865.8 4954.6 4981.8 4983.1 4986.1 5022.9 4632.3 4708.8 4752.7 4753.7 4850.5 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38972.64 Median:17616.17 stddev:57353.74 (325.6%) stddev-sans-first:57442.11 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: Values: 562.0 565.6 567.7 571.6 590.1 29042.7 29879.3 37427.6 37709.1 37800.4 41643.6 42037.2 42069.8 42112.4 42207.4 7073.3 8016.0 8194.8 8198.5 8200.3 7165.9 7263.2 7277.5 7283.1 7283.8 10261.4 10568.5 10569.3 10580.3 10586.4 10228.0 10317.3 10332.2 10345.3 10351.9 7228.7 7435.3 7435.9 9890.1 10064.9 41284.6 41868.0 42091.0 42168.6 42209.6 2916.0 2934.7 2935.3 3426.6 3434.9 27433.3 28826.3 29150.3 29198.0 29894.3 3188.4 3189.0 3215.1 3241.0 3245.3 227802.0 228994.0 229133.0 229237.0 229450.0 55821.0 56063.1 56066.2 56140.7 56181.4 58440.0 59103.0 59187.4 59205.4 59230.0 13392.1 13875.8 13967.5 14039.8 14048.0 10158.6 10257.2 10290.9 10341.9 10387.5 18967.8 19044.4 19259.2 19272.7 19284.9 7128.6 7264.5 7334.2 7341.0 7375.2 852.9 860.8 867.2 944.7 1033.5 24445.5 25431.0 25458.5 25471.0 25510.4 929.5 957.6 969.5 980.6 1006.2 14093.0 14505.3 14569.3 14755.3 14931.6 205792.0 209180.0 209459.0 209745.0 241824.0 38059.8 44294.6 45336.5 45360.0 45426.8 1202.9 1203.1 1220.1 1230.1 1312.2 22217.8 23906.3 24692.9 25399.6 27191.3 38264.8 38494.2 38549.4 38567.0 38619.8 218325.0 218533.0 218603.0 219187.0 219500.0 28640.0 28858.4 29141.0 29166.7 29229.0 39658.4 40520.0 40764.6 40765.4 40773.8 33571.0 34363.5 34981.5 35293.8 35351.0 32017.2 34408.5 34866.0 34919.5 35108.8 32946.7 33365.7 33510.2 33948.8 33960.2 29785.0 30150.5 30383.9 30446.5 30449.2 23474.7 23615.8 23735.3 23814.8 23944.8 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,797 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26164.09 Median:14652.80 stddev:75610.36 (516.0%) stddev-sans-first:75797.60 04:33:08 INFO - 2015-11-23 04:33:08,798 DEBUG : BROWSER_OUTPUT: Values: 336.6 336.9 342.0 343.6 344.5 12481.3 12784.7 15670.8 15888.4 16688.7 15162.8 15203.9 15206.4 15388.3 15721.0 5000.5 5004.6 5109.7 5114.3 5119.9 3626.5 3739.8 3740.7 3743.7 5055.3 3713.8 5729.2 5878.6 5932.5 5940.8 5692.4 5847.3 5889.1 5892.0 5938.6 5134.3 5150.8 5156.1 5183.2 5191.3 19598.3 19761.3 20208.2 20455.7 20578.3 1971.6 2033.5 2044.5 2048.9 2085.0 12914.4 13164.4 13363.3 13469.7 13537.5 1784.4 1793.3 1803.2 1865.6 1948.7 49153.8 51189.2 53261.7 58138.4 58704.0 15280.4 15850.8 15898.9 15916.6 15919.1 23700.9 23869.3 23914.6 23920.5 23930.9 8363.3 8493.9 8522.1 8532.0 8568.2 7041.3 7060.0 7087.4 7103.7 7111.3 7576.7 7641.5 7642.9 7654.5 7671.5 1722.5 1735.7 1743.8 2179.6 2967.0 386.1 787.8 830.0 868.7 967.5 9837.4 9943.7 10124.2 10255.6 10287.7 408.7 416.7 418.2 421.7 428.0 4982.7 5515.5 5525.2 5548.3 5583.2 423699.0 433791.0 477752.0 487461.0 490389.0 72631.6 73035.3 73379.3 73387.6 74259.6 1035.7 1036.4 1043.3 1062.2 1063.5 14525.4 14570.9 14633.7 14682.6 14824.1 32273.0 32774.8 33507.7 34619.5 36029.6 25165.0 25601.0 26338.6 35152.9 50759.7 13642.1 13657.0 13990.3 14032.5 14294.4 17489.7 17518.7 17519.6 17826.4 17858.8 14403.9 14429.1 14489.9 14903.5 14933.9 2230.4 10335.7 14359.1 14494.6 15079.8 9314.1 9583.2 9615.2 9632.1 15256.8 13292.7 13327.9 13372.4 13573.7 13630.9 11571.8 12184.4 14228.8 14256.0 14260.9 04:33:08 INFO - 2015-11-23 04:33:08,798 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,798 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4814.22 Median:5927.85 stddev:2417.84 (40.8%) stddev-sans-first:2409.55 04:33:08 INFO - 2015-11-23 04:33:08,798 DEBUG : BROWSER_OUTPUT: Values: 1222.3 1614.7 1654.8 1670.5 1673.9 5872.4 6612.3 6697.0 6746.7 6756.6 6778.3 6792.5 6834.2 6845.2 6870.7 2071.3 2072.4 2090.4 2093.3 2093.9 1976.3 1994.8 1999.4 2005.4 2005.7 2042.4 2051.1 2060.4 2062.4 2064.3 1993.2 2003.2 2006.1 2010.5 2015.6 2015.5 2022.4 2075.2 2077.4 2079.9 5757.4 6796.8 6823.1 6835.7 6843.7 3665.6 4058.9 4165.5 4169.7 4179.3 2694.9 2768.4 2813.6 2839.3 2842.1 863.7 880.2 893.6 897.6 905.2 9111.9 9160.4 9165.9 9175.1 9190.0 3917.2 3918.8 3969.0 3974.5 3982.1 8028.4 8116.4 8117.5 8122.5 8154.2 4252.3 4254.9 4258.6 4261.7 4277.0 3865.3 3891.1 3891.9 3893.0 3894.3 3306.1 3338.3 3352.9 3355.7 3370.2 1087.3 1088.1 1097.8 1101.4 1117.0 1037.6 1047.9 1056.1 1057.9 1092.4 6515.3 6558.7 6578.5 6591.7 6602.6 438.1 1083.7 1100.1 1121.1 1121.5 4846.7 5152.7 5186.3 5266.9 5274.7 7299.6 7899.2 8120.8 8126.5 8128.1 7922.9 7970.6 7990.0 8005.6 8011.5 6163.5 6370.0 6382.2 6388.7 6391.8 6420.9 6427.2 6433.0 6444.1 6445.7 7020.0 7248.0 7249.9 7266.8 7271.8 7175.6 7357.3 7359.4 7365.8 7393.9 5805.3 5837.3 5939.7 5943.5 5950.8 6475.7 6581.1 6582.1 6583.8 6595.8 6240.1 6250.1 6251.9 6276.2 6405.7 6209.4 6230.9 6262.3 6317.6 6330.7 6180.2 6226.3 6258.3 6267.6 6287.8 5861.7 5899.0 5906.6 5908.8 5916.0 5877.3 5881.1 5941.3 5948.7 5969.3 04:33:08 INFO - 2015-11-23 04:33:08,799 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,799 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4709.73 Median:5186.29 stddev:1372.80 (26.5%) stddev-sans-first:1336.42 04:33:08 INFO - 2015-11-23 04:33:08,799 DEBUG : BROWSER_OUTPUT: Values: 314.3 321.1 321.4 325.7 325.9 5340.1 5393.8 5395.1 5397.1 5415.0 5047.3 5137.2 5236.0 5281.7 5321.9 4193.3 4213.0 4215.9 4219.9 4221.6 4027.8 4216.9 4218.1 4223.9 4232.5 4081.2 4095.7 4178.4 4183.1 4189.2 4165.4 4175.2 4186.0 4188.2 4195.2 3697.4 3703.7 3703.8 3709.1 3717.0 5167.9 5176.7 5184.6 5185.7 5186.9 4650.7 4787.6 4789.5 4802.6 4844.1 5642.9 5656.5 5658.4 5660.8 5670.0 3955.4 3968.5 3978.8 3978.9 3981.1 5865.9 5956.4 5959.2 5961.1 5963.3 3933.8 4046.6 4051.0 4056.9 4062.9 4097.6 4106.1 4110.4 4111.3 4113.3 4718.1 4726.7 4727.2 4729.8 4732.5 5637.4 5642.2 5668.8 5686.5 5687.5 1435.9 1462.4 1520.9 1520.9 1525.3 1021.3 1049.2 1058.7 1069.6 1070.5 4887.1 4895.2 4897.8 4945.5 4959.8 5822.0 5824.9 5825.9 5827.5 5833.1 4793.9 4894.1 4902.7 4940.3 5025.2 3155.4 3167.7 3184.7 3185.4 3190.5 5547.8 5557.5 5592.7 5598.8 5603.4 5917.6 6067.7 6082.7 6088.1 6090.1 5617.1 5625.5 5627.2 5628.0 5628.7 5925.2 5937.3 5937.3 5945.0 5946.8 5794.5 5805.1 5809.3 5810.6 5815.1 5504.5 5524.6 5601.2 5601.9 5608.8 4049.1 4095.5 4100.4 4101.1 4104.3 5902.4 5906.2 5907.9 5910.4 5911.0 5563.0 5667.1 5669.9 5677.5 5681.8 5671.0 5675.9 5684.9 5685.7 5686.9 5543.0 5564.2 5565.0 5571.3 5581.3 5729.1 5731.1 5735.6 5735.7 5736.1 5443.9 5579.2 5613.6 5615.3 5617.1 04:33:08 INFO - 2015-11-23 04:33:08,799 DEBUG : BROWSER_OUTPUT: 04:33:08 INFO - 2015-11-23 04:33:08,799 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12830.01 Median:43795.17 stddev:14589.59 (33.3%) stddev-sans-first:14601.97 04:33:08 INFO - 2015-11-23 04:33:08,800 DEBUG : BROWSER_OUTPUT: Values: 676.3 791.7 803.3 813.8 825.6 12325.0 12511.2 12511.9 12518.9 12529.0 12113.8 12214.4 12222.8 13524.9 13877.1 633.0 806.9 821.3 822.0 822.2 632.5 808.5 818.2 819.1 819.9 836.0 849.5 849.6 849.9 849.9 656.3 662.2 832.9 844.9 846.9 625.4 627.4 629.2 629.6 629.9 12765.3 12979.2 12983.4 12986.9 13006.5 11002.7 11412.1 11412.8 11803.0 11892.9 9122.2 9465.9 9914.4 9970.9 10209.8 3207.6 3242.4 3261.8 3263.7 3291.3 43001.6 43067.0 43717.6 43723.3 44491.6 9397.5 9419.4 9516.7 9567.9 9632.5 16813.3 16827.4 16855.0 16856.4 16862.7 6356.1 6541.6 6550.7 6566.3 6638.5 3591.9 3679.4 3693.0 3781.7 3858.2 2707.9 2720.9 2723.0 2726.7 2736.5 502.8 503.0 509.5 512.5 514.1 534.0 554.7 610.3 625.2 637.4 7822.3 8059.7 8184.6 8255.0 8312.6 506.4 542.2 581.4 620.9 636.3 3611.3 3766.9 3958.2 4002.8 4095.8 52782.7 53268.0 53359.9 53372.7 53443.5 43389.3 43455.8 43469.0 43867.0 43944.8 41133.0 42857.8 43115.8 44232.6 44251.6 8101.9 8508.8 8572.8 8620.9 8918.6 32309.4 33023.5 33571.2 33609.3 33830.5 42356.4 42927.0 42936.0 43135.1 43193.6 10321.3 10542.3 10567.5 10574.6 10657.6 12032.9 12040.6 12046.5 12139.6 12327.8 10866.9 10906.2 10992.9 11106.6 11159.7 10976.5 10990.6 11042.6 11214.2 11362.7 8529.3 9583.8 10587.8 10705.8 10884.1 9469.2 9473.6 9547.6 10024.5 10058.8 7212.6 9006.5 9069.3 9076.3 9183.4 04:33:08 INFO - 2015-11-23 04:33:08,801 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:08 INFO - 2015-11-23 04:33:08,801 DEBUG : BROWSER_OUTPUT: 04:33:09 INFO - 2015-11-23 04:33:09,563 INFO : Browser exited with error code: 0 04:33:09 INFO - 2015-11-23 04:33:09,582 INFO : Completed test dromaeo_css (00:18:38) 04:33:09 INFO - 2015-11-23 04:33:09,582 INFO : Starting test kraken 04:33:09 INFO - 2015-11-23 04:33:09,582 DEBUG : operating with platform_type : linux_ 04:33:09 INFO - 2015-11-23 04:33:09,582 INFO : Initialising browser for kraken test... 04:33:09 INFO - 2015-11-23 04:33:09,588 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprY5pfT/profile http://localhost:53904/getInfo.html 04:33:14 INFO - 2015-11-23 04:33:14,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:14 INFO - 2015-11-23 04:33:14,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:14 INFO - 2015-11-23 04:33:14,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:14 INFO - 2015-11-23 04:33:14,113 DEBUG : BROWSER_OUTPUT: __metrics 04:33:14 INFO - 2015-11-23 04:33:14,262 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:15 INFO - 2015-11-23 04:33:15,757 INFO : Browser initialized. 04:33:15 INFO - 2015-11-23 04:33:15,758 INFO : Running cycle 1/1 for kraken test... 04:33:15 INFO - 2015-11-23 04:33:15,758 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprY5pfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:27 INFO - 2015-11-23 04:33:27,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 141733888 04:33:27 INFO - 2015-11-23 04:33:27,666 DEBUG : BROWSER_OUTPUT: 04:33:30 INFO - 2015-11-23 04:33:30,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:30 INFO - 2015-11-23 04:33:30,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 177893376 04:33:30 INFO - 2015-11-23 04:33:30,863 DEBUG : BROWSER_OUTPUT: 04:33:33 INFO - 2015-11-23 04:33:33,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-dft) 04:33:34 INFO - 2015-11-23 04:33:34,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 167260160 04:33:34 INFO - 2015-11-23 04:33:34,140 DEBUG : BROWSER_OUTPUT: 04:33:37 INFO - 2015-11-23 04:33:37,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-fft) 04:33:37 INFO - 2015-11-23 04:33:37,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 153153536 04:33:37 INFO - 2015-11-23 04:33:37,705 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2015-11-23 04:33:39,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-oscillator) 04:33:40 INFO - 2015-11-23 04:33:40,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 154230784 04:33:40 INFO - 2015-11-23 04:33:40,309 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-11-23 04:33:42,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:43 INFO - 2015-11-23 04:33:43,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 155803648 04:33:43 INFO - 2015-11-23 04:33:43,064 DEBUG : BROWSER_OUTPUT: 04:33:46 INFO - 2015-11-23 04:33:46,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:46 INFO - 2015-11-23 04:33:46,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 155303936 04:33:46 INFO - 2015-11-23 04:33:46,607 DEBUG : BROWSER_OUTPUT: 04:33:50 INFO - 2015-11-23 04:33:50,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:50 INFO - 2015-11-23 04:33:50,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 154939392 04:33:50 INFO - 2015-11-23 04:33:50,682 DEBUG : BROWSER_OUTPUT: 04:33:53 INFO - 2015-11-23 04:33:53,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53904/tests/kraken/driver.html?testName=json-parse-financial) 04:33:54 INFO - 2015-11-23 04:33:54,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 155893760 04:33:54 INFO - 2015-11-23 04:33:54,069 DEBUG : BROWSER_OUTPUT: 04:33:55 INFO - 2015-11-23 04:33:55,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:56 INFO - 2015-11-23 04:33:56,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 163483648 04:33:56 INFO - 2015-11-23 04:33:56,413 DEBUG : BROWSER_OUTPUT: 04:33:58 INFO - 2015-11-23 04:33:58,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:58 INFO - 2015-11-23 04:33:58,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 163815424 04:33:58 INFO - 2015-11-23 04:33:58,880 DEBUG : BROWSER_OUTPUT: 04:34:00 INFO - 2015-11-23 04:34:00,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:01 INFO - 2015-11-23 04:34:01,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 169050112 04:34:01 INFO - 2015-11-23 04:34:01,579 DEBUG : BROWSER_OUTPUT: 04:34:04 INFO - 2015-11-23 04:34:04,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:04 INFO - 2015-11-23 04:34:04,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 177676288 04:34:04 INFO - 2015-11-23 04:34:04,690 DEBUG : BROWSER_OUTPUT: 04:34:07 INFO - 2015-11-23 04:34:07,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:07 INFO - 2015-11-23 04:34:07,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 177156096 04:34:07 INFO - 2015-11-23 04:34:07,840 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53904/tests/kraken/driver.html?testName=ai-astar) 04:34:09 INFO - 2015-11-23 04:34:09,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 235819008 04:34:09 INFO - 2015-11-23 04:34:09,824 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;106;112;112;112;102;112;115;112 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;131;153;170;135;157;155;139;163;130 04:34:09 INFO - 2015-11-23 04:34:09,828 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;161;159;159;159;160;161 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;87;90;72;72;72;93;95;72 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;129;90;91;91;125;91;91;136 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;109;109 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;146;147;146;147;146;147 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;95;95;95;94 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;70;69;71;70;71;80;69;69 04:34:09 INFO - 2015-11-23 04:34:09,829 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;69;69;70;68;68;68 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;82;82;83;83;82;90;83;84 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;124;127;123;125;117;130;123;126;119 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;136;145;144;146;134;158;153;145;141 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;71;68;67;67;67;67;67;68 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 04:34:09 INFO - 2015-11-23 04:34:09,830 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:09 INFO - 2015-11-23 04:34:09,831 DEBUG : BROWSER_OUTPUT: __startTimestamp1448282049826__endTimestamp 04:34:09 INFO - 2015-11-23 04:34:09,831 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,838 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:09 INFO - 2015-11-23 04:34:09,838 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.72 (3.3%) stddev-sans-first:3.94 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 106.0 112.0 112.0 112.0 102.0 112.0 115.0 112.0 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.20 Median:156.00 stddev:14.27 (9.1%) stddev-sans-first:14.69 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: Values: 159.0 131.0 153.0 170.0 135.0 157.0 155.0 139.0 163.0 130.0 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,839 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 161.0 159.0 159.0 159.0 160.0 161.0 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:81.00 stddev:9.85 (12.2%) stddev-sans-first:10.27 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 87.0 90.0 72.0 72.0 72.0 93.0 95.0 72.0 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:91.00 stddev:19.16 (21.1%) stddev-sans-first:19.87 04:34:09 INFO - 2015-11-23 04:34:09,840 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 129.0 90.0 91.0 91.0 125.0 91.0 91.0 136.0 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,841 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:3.31 (4.7%) stddev-sans-first:3.46 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 70.0 69.0 71.0 70.0 71.0 80.0 69.0 69.0 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 04:34:09 INFO - 2015-11-23 04:34:09,842 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 69.0 69.0 70.0 68.0 68.0 68.0 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.50 (3.0%) stddev-sans-first:2.50 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 82.0 82.0 83.0 83.0 82.0 90.0 83.0 84.0 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.50 stddev:4.03 (3.2%) stddev-sans-first:3.96 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: Values: 119.0 124.0 127.0 123.0 125.0 117.0 130.0 123.0 126.0 119.0 04:34:09 INFO - 2015-11-23 04:34:09,843 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:145.50 stddev:7.10 (4.9%) stddev-sans-first:7.52 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: Values: 146.0 136.0 145.0 144.0 146.0 134.0 158.0 153.0 145.0 141.0 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.30 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 71.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:09 INFO - 2015-11-23 04:34:09,844 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-11-23 04:34:10,771 INFO : Browser exited with error code: 0 04:34:10 INFO - 2015-11-23 04:34:10,822 INFO : Completed test kraken (00:01:01) 04:34:10 INFO - 2015-11-23 04:34:10,822 INFO : Starting test v8_7 04:34:10 INFO - 2015-11-23 04:34:10,822 DEBUG : operating with platform_type : linux_ 04:34:10 INFO - 2015-11-23 04:34:10,822 INFO : Initialising browser for v8_7 test... 04:34:10 INFO - 2015-11-23 04:34:10,828 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkkrdc/profile http://localhost:53904/getInfo.html 04:34:15 INFO - 2015-11-23 04:34:15,206 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:15 INFO - 2015-11-23 04:34:15,206 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:15 INFO - 2015-11-23 04:34:15,206 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:15 INFO - 2015-11-23 04:34:15,206 DEBUG : BROWSER_OUTPUT: __metrics 04:34:15 INFO - 2015-11-23 04:34:15,355 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:16 INFO - 2015-11-23 04:34:16,897 INFO : Browser initialized. 04:34:16 INFO - 2015-11-23 04:34:16,897 INFO : Running cycle 1/1 for v8_7 test... 04:34:16 INFO - 2015-11-23 04:34:16,897 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvkkrdc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:28 INFO - 2015-11-23 04:34:28,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 142200832 04:34:28 INFO - 2015-11-23 04:34:28,820 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53904/tests/v8_7/run.html (next: http://localhost:53904/tests/v8_7/run.html) 04:34:50 INFO - 2015-11-23 04:34:50,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 440217600 04:34:50 INFO - 2015-11-23 04:34:50,463 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,463 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:50 INFO - 2015-11-23 04:34:50,463 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |0;Richards;163.61256544502618 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.46084625694044 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 04:34:50 INFO - 2015-11-23 04:34:50,464 DEBUG : BROWSER_OUTPUT: |5;Earley;798.8826815642458 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: |7;RegExp;26051.28205128205 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: |8;Splay;628.052598622417 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:50 INFO - 2015-11-23 04:34:50,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1448282090456__endTimestamp 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.61 Median:163.61 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: Values: 163.6 04:34:50 INFO - 2015-11-23 04:34:50,466 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: Values: 191.5 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: Values: 280.0 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,467 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: Values: 5035.2 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: Values: 2010.0 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.88 Median:798.88 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: Values: 798.9 04:34:50 INFO - 2015-11-23 04:34:50,468 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: Values: 12382.7 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: Values: 26051.3 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,469 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:628.05 Median:628.05 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: Values: 628.1 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:50 INFO - 2015-11-23 04:34:50,470 DEBUG : BROWSER_OUTPUT: 04:34:51 INFO - 2015-11-23 04:34:51,435 INFO : Browser exited with error code: 0 04:34:51 INFO - 2015-11-23 04:34:51,452 INFO : Completed test v8_7 (00:00:40) 04:34:51 INFO - 2015-11-23 04:34:51,518 INFO : Completed test suite (00:20:20) 04:34:51 INFO - 2015-11-23 04:34:51,518 DEBUG : Working with test: dromaeo_css 04:34:51 INFO - 2015-11-23 04:34:51,518 DEBUG : Generating results file: dromaeo_css 04:34:51 INFO - 2015-11-23 04:34:51,519 DEBUG : Working with test: kraken 04:34:51 INFO - 2015-11-23 04:34:51,520 DEBUG : Generating results file: kraken 04:34:51 INFO - 2015-11-23 04:34:51,520 INFO : javascript benchmark 04:34:51 INFO - 2015-11-23 04:34:51,520 DEBUG : Working with test: v8_7 04:34:51 INFO - 2015-11-23 04:34:51,520 DEBUG : Generating results file: v8_7 04:34:51 INFO - 2015-11-23 04:34:51,521 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-11-23 04:34:51,574 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:34:51 INFO - 2015-11-23 04:34:51,574 DEBUG : process_Request line: dromaeo_css 6392.58 graph.html#tests=[[72,94,35]] 04:34:51 INFO - 2015-11-23 04:34:51,574 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-11-23 04:34:51,603 DEBUG : process_Request line: kraken 1513.30 graph.html#tests=[[232,94,35]] 04:34:51 INFO - 2015-11-23 04:34:51,604 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-11-23 04:34:51,636 DEBUG : process_Request line: v8_7 19731.26 graph.html#tests=[[230,94,35]] 04:34:51 INFO - 2015-11-23 04:34:51,637 INFO : javascript benchmark 04:34:51 INFO - 2015-11-23 04:34:51,641 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2644.352133727237, 2741.6709994800626, 2748.106865268788, 2761.1716485054485, 2761.420101778625, 4426.136903303849, 4542.931856022163, 4724.220503616903, 4752.572268495835, 4766.189747742884, 4629.976850115753, 4661.790219440125, 4666.556677115668, 4765.666403351766, 4768.856934291968, 4340.544242854487, 4361.323994780814, 4376.387305777193, 4436.068425630605, 4457.041736026754, 4116.608922152391, 4418.97790511047, 4424.225760491917, 4470.441194850644, 4484.372187893681, 4185.518665353493, 4240.173166232586, 4312.37470566766, 4332.4367832181615, 4345.217860785057, 4304.59106384896, 4324.65402767781, 4327.5239723630375, 4347.174036933005, 4384.298512238059, 4057.6550993165615, 4171.874843754692, 4312.525622181557, 4319.827206911751, 4363.454568178978, 4587.082583483317, 4691.648126390534, 4711.316859055418, 4722.268048452495, 4748.19280722278, 5097.541221290065, 5112.309838171836, 5123.590112790967, 5132.615053870974, 5172.870678233036, 4794.472608013116, 4869.513048695102, 5145.794168233266, 5167.044096842059, 5169.353830771153, 4589.426321709786, 4592.954070459253, 4672.976635116803, 4677.812887484531, 4725.220338644154, 5145.511176438233, 5200.817971370984, 5218.347706536683, 5218.530332270114, 5264.657797243167, 4717.787699553528, 4826.493218212107, 5021.07110184617, 5023.899522009539, 5033.471485494044, 4944.357233559686, 4952.133376659071, 5034.874128146826, 5035.723035233097, 5055.140626093573, 5043.3191519145175, 5090.49095090488, 5099.796008159707, 5110.131277682803, 5146.408163061295, 4694.483606803249, 4820.807167713322, 5063.3417655704525, 5070.873228169326, 5080.618953578496, 4078.510578730512, 4135.462389889295, 4155.439015732898, 4166.270902592034, 4182.1008483176265, 3755.061234691327, 3756.718246131551, 3757.8121093945742, 3767.5478942526524, 3793.393057110849, 4437.290033594674, 4439.533848945879, 4441.422615060022, 4447.466304043535, 4476.686631935733, 4754.833580824655, 4912.189488734391, 4915.926261106087, 4966.776495057731, 5025.623078269145, 4291.313389857608, 4320.524742278347, 4328.978355108205, 4348.847790327323, 4375.387445757597, 4440.49204109617, 4444.555544445529, 4450.532694067141, 4466.754328511963, 4487.820487180476, 4537.705049171794, 4687.203175460112, 4688.460827004802, 4737.857864264078, 4822.903541929212, 5107.744612769272, 5112.565431938327, 5115.411727651368, 5115.769790359368, 5126.7180305083575, 4830.420349558076, 4830.806767729251, 4835.661503694708, 4839.661223714306, 4880.731559764247, 4707.693999889996, 4827.444843843003, 4831.251156070814, 4839.879003024953, 5081.593472522263, 5060.266261392004, 5124.077666020152, 5196.896062078662, 5199.220116982332, 5202.97398513005, 4975.726335051607, 5005.0740612985255, 5005.899882002267, 5010.098182327216, 5049.520295571915, 4651.488336282939, 4716.29255611661, 4771.23660214364, 4772.570468657837, 4955.6531042826655, 4817.373741413594, 4828.324034635084, 4852.539008794159, 4853.150698627655, 4865.829695960624, 4954.578860796729, 4981.8007279709855, 4983.103041452573, 4986.052649996489, 5022.874428139326, 4632.305154226893, 4708.764561771966, 4752.667313288037, 4753.738544380092, 4850.490698476609], "unit": "ms", "name": "dojo.html", "value": 4621.515480480601}, {"lowerIsBetter": false, "replicates": [561.957853161013, 565.6040771459977, 567.6622409666252, 571.5827445964446, 590.0883135555569, 29042.709572904292, 29879.253018674517, 37427.625723742756, 37709.05727356818, 37800.43299350505, 41643.58356416435, 42037.15925681485, 42069.7896510517, 42112.36831447531, 42207.3668894966, 7073.292670732912, 8015.959920200391, 8194.754157375288, 8198.508089514618, 8200.302974247166, 7165.89251161233, 7263.164736055369, 7277.454190935675, 7283.053203083592, 7283.781486555412, 10261.43562104084, 10568.52441640128, 10569.312994655362, 10580.259381843274, 10586.3648181109, 10228.0, 10317.277790554665, 10332.173426125892, 10345.32755370906, 10351.948240258826, 7228.710851565931, 7435.330820226151, 7435.888461673079, 9890.060444257855, 10064.949675251577, 41284.58715412838, 41868.0, 42091.0, 42168.57831421677, 42209.577904220874, 2916.0, 2934.721201485877, 2935.2955290730283, 3426.640202778697, 3434.9180008297308, 27433.31416714578, 28826.279343016384, 29150.27124321888, 29198.0, 29894.252643683863, 3188.3942051010235, 3189.02989591498, 3215.1319143831033, 3240.951385729216, 3245.2860370718404, 227802.0, 228994.0, 229133.0, 229237.0, 229450.0, 55821.0, 56063.11337309605, 56066.159007614915, 56140.71929640407, 56181.43818561844, 58440.0, 59103.0, 59187.40812591819, 59205.40794592085, 59230.0, 13392.129511581716, 13875.791863122062, 13967.511137110152, 14039.78940315896, 14048.0, 10158.644447444303, 10257.17942564593, 10290.897091029143, 10341.9482902585, 10387.480625968672, 18967.810321896606, 19044.428667140008, 19259.22963081489, 19272.650914436137, 19284.939328336797, 7128.572285662877, 7264.527805692613, 7334.193238743734, 7340.972263883061, 7375.151857536452, 852.8635418333037, 860.7589874835056, 867.197841996151, 944.7024187380953, 1033.5297439664935, 24445.511089778105, 25431.0, 25458.49083018329, 25470.962323014115, 25510.362240944123, 929.5166513412987, 957.6025949230991, 969.5249327829313, 980.6175591519313, 1006.1548299428515, 14093.0, 14505.274736263145, 14569.271536423137, 14755.262236888113, 14931.552053438414, 205792.0, 209180.0, 209459.0, 209745.0, 241824.0, 38059.809700951875, 44294.557054429046, 45336.546634533894, 45360.0, 45426.772866135456, 1202.8797120288077, 1203.1277323940074, 1220.1154163231586, 1230.1143176912608, 1312.1798875702686, 22217.77782222157, 23906.28281151568, 24692.876535617208, 25399.619005714558, 27191.320216994733, 38264.80867595644, 38494.230115398095, 38549.42175867308, 38567.0, 38619.80690096531, 218325.0, 218533.0, 218603.0, 219187.0, 219500.0, 28640.0, 28858.42283154367, 29141.0, 29166.708332916398, 29229.0, 39658.40512392259, 40520.0, 40764.59235407608, 40765.388519172826, 40773.79613101915, 33571.0, 34363.48454773131, 34981.47527787136, 35293.82353088321, 35351.0, 32017.199570010936, 34408.48387274143, 34866.0, 34919.47620785741, 35108.82445587858, 32946.67053329436, 33365.66634333723, 33510.16224594405, 33948.81179158817, 33960.15099622529, 29785.0, 30150.54774178345, 30383.936562220217, 30446.543301850048, 30449.23876903095, 23474.65667915106, 23615.763842361357, 23735.28794136179, 23814.761852381947, 23944.760552394255], "unit": "ms", "name": "ext.html", "value": 17031.19294755971}, {"lowerIsBetter": false, "replicates": [336.58768009188765, 336.92924485857986, 341.97777144485605, 343.6134348857535, 344.5125147915699, 12481.31352775597, 12784.68038299043, 15670.764938525917, 15888.364465421384, 16688.666226675476, 15162.848371516282, 15203.859710521727, 15206.391744330214, 15388.307526161321, 15721.0, 5000.52495012975, 5004.574611158056, 5109.718965456898, 5114.258432527281, 5119.948800511985, 3626.4741612466178, 3739.813009349535, 3740.738148329618, 3743.7005039596766, 5055.317532133152, 3713.795741234231, 5729.197912292282, 5878.588498805086, 5932.466078052975, 5940.821775346746, 5692.430756924296, 5847.327557330897, 5889.087191485327, 5891.970540147315, 5938.6436813791315, 5134.332536770196, 5150.768215430277, 5156.149235376159, 5183.222516622499, 5191.299174611417, 19598.314059008007, 19761.308354207533, 20208.19167233309, 20455.693164602544, 20578.27976020832, 1971.605678864233, 2033.5119571302928, 2044.4684382060623, 2048.9180432782673, 2084.9992003838242, 12914.354282285942, 13164.407601657853, 13363.33183340829, 13469.730605387836, 13537.495563320817, 1784.4289827255284, 1793.2557988434785, 1803.179553303244, 1865.5895702945465, 1948.65898467769, 49153.75423122862, 51189.232161517604, 53261.73369133168, 58138.41861581372, 58704.0, 15280.388784448498, 15850.841491585166, 15898.920505397398, 15916.602084947968, 15919.124448155462, 23700.88149559241, 23869.283921482383, 23914.64128038081, 23920.52158956811, 23930.88034559816, 8363.289120424832, 8493.938257717786, 8522.147785221428, 8532.0, 8568.22885940256, 7041.260667629927, 7060.0468936693915, 7087.397571206402, 7103.715851365888, 7111.288871112951, 7576.674082035622, 7641.465097443125, 7642.923570764332, 7654.502457340366, 7671.501352412075, 1722.4746452331908, 1735.6615459985435, 1743.799463061764, 2179.6294629912954, 2966.9851650741607, 386.1023121243065, 787.775483987061, 830.0205757206554, 868.6525389843987, 967.5355829202023, 9837.360571562825, 9943.701688949342, 10124.240681948882, 10255.58977640901, 10287.742806429898, 408.6608115264323, 416.7312083705993, 418.23880537422207, 421.73220005296855, 427.9828806847691, 4982.6512144149565, 5515.503604675599, 5525.198846167284, 5548.334199896039, 5583.218349431083, 423699.0, 433791.0, 477752.0, 487461.0, 490389.0, 72631.63684181546, 73035.26964730391, 73379.26620733831, 73387.63306183541, 74259.57404259639, 1035.6634093919506, 1036.383351905615, 1043.2644985285508, 1062.2351906627216, 1063.473580577619, 14525.418983240552, 14570.949854389914, 14633.707325853211, 14682.632934176303, 14824.110553366832, 32273.0, 32774.836125819216, 33507.66492335046, 34619.48070778991, 36029.63970360263, 25165.0, 25601.0, 26338.604920926584, 35152.945411637695, 50759.746201268754, 13642.113262637897, 13657.044006919421, 13990.300484975915, 14032.508862189774, 14294.356753945889, 17489.737653934946, 17518.73721894198, 17519.562010949827, 17826.37607683777, 17858.821411785717, 14403.927980360031, 14429.134251944917, 14489.855101448851, 14903.478378257143, 14933.850661493681, 2230.4423894026495, 10335.689929302132, 14359.14342659297, 14494.565163045125, 15079.849201507845, 9314.115159059878, 9583.185429238592, 9615.182709469773, 9632.084951929555, 15256.847431525986, 13292.734145317232, 13327.933360333136, 13372.398242078934, 13573.660658483617, 13630.86369136296, 11571.826422603835, 12184.390780460764, 14228.786568201693, 14256.0, 14260.932164836247], "unit": "ms", "name": "jquery.html", "value": 8572.681989588196}, {"lowerIsBetter": false, "replicates": [1222.3460448659969, 1614.6609212065468, 1654.8427899349558, 1670.5489517830185, 1673.8577220936224, 5872.354041055481, 6612.3387661233855, 6697.0289308050305, 6746.6626668666495, 6756.560823546472, 6778.288279730631, 6792.524523283372, 6834.214065382483, 6845.178578570566, 6870.656467176634, 2071.347525529461, 2072.35756915356, 2090.393785802123, 2093.309207961369, 2093.874367537945, 1976.2786582897284, 1994.840412766975, 1999.3502111813646, 2005.3983804858558, 2005.6690646043457, 2042.4077017664858, 2051.148773259096, 2060.3612880007245, 2062.4225216939208, 2064.2775028739898, 1993.2326054468988, 2003.168684995725, 2006.1173083843134, 2010.497375656086, 2015.5968806238664, 2015.5364266218705, 2022.4236092713506, 2075.242536474176, 2077.4494758888904, 2079.906404211799, 5757.395473475309, 6796.762113326059, 6823.078884350599, 6835.692393842289, 6843.726250949956, 3665.6151104133946, 4058.939115913264, 4165.541790403053, 4169.708120431571, 4179.26862799009, 2694.892204311825, 2768.3632764464087, 2813.6482939632547, 2839.2759846239283, 2842.0763251942994, 863.7149740585592, 880.2210044111008, 893.5800173918313, 897.6409436225497, 905.2395987370575, 9111.863322050109, 9160.35877488576, 9165.908340916572, 9175.128362805523, 9190.035046320174, 3917.196974620196, 3918.7844668542934, 3968.960310396859, 3974.5429275633096, 3982.1438390745548, 8028.397870159762, 8116.391270654606, 8117.472364296302, 8122.512649240946, 8154.2253485918745, 4252.340887162495, 4254.914901702011, 4258.5954334338185, 4261.74429534229, 4276.957230427656, 3865.3042452358845, 3891.105045839416, 3891.9221615568094, 3893.04620368006, 3894.299026175259, 3306.123877172551, 3338.3490219407468, 3352.949705754416, 3355.681210285019, 3370.241695618466, 1087.260662749338, 1088.1131877519797, 1097.780443911221, 1101.3832253937821, 1117.017025017979, 1037.6420135053395, 1047.9318844275251, 1056.1128651932413, 1057.9153667706719, 1092.426476100038, 6515.315891831384, 6558.737650493927, 6578.473722102221, 6591.736330546724, 6602.636854973022, 438.11938004610323, 1083.707399002265, 1100.1418893263267, 1121.103117505992, 1121.4560937945091, 4846.733429661332, 5152.690838549699, 5186.273921650972, 5266.947330526722, 5274.657147285414, 7299.635018249172, 7899.170587088388, 8120.75637730869, 8126.512409255463, 8128.105908350077, 7922.881156782653, 7970.561619111005, 7990.0, 8005.639746211435, 8011.519308841488, 6163.506919446433, 6369.968150159312, 6382.170317858741, 6388.722255548909, 6391.776287829996, 6420.903686444613, 6427.196600424947, 6433.0, 6444.065610486359, 6445.677716114269, 7020.0, 7247.9637601811655, 7249.927500725136, 7266.818329541592, 7271.818204544928, 7175.569465832067, 7357.337839594462, 7359.37445317154, 7365.8158546036775, 7393.9260607393235, 5805.3033635962265, 5837.29952405714, 5939.673317967553, 5943.4948029416255, 5950.7917222896995, 6475.676216189266, 6581.111549940888, 6582.11141495911, 6583.835404114935, 6595.8021259362295, 6240.095186198067, 6250.093736408105, 6251.937480625317, 6276.215473065867, 6405.743770249138, 6209.379062093754, 6230.875382492234, 6262.279837818709, 6317.5893566918, 6330.746770129143, 6180.227471566054, 6226.3151053385, 6258.311585725658, 6267.561270711007, 6287.842803929939, 5861.677607731615, 5898.970505147447, 5906.645601263938, 5908.822735317947, 5916.023856063702, 5877.265341832271, 5881.088431293157, 5941.31674857397, 5948.732307046107, 5969.313528944227], "unit": "ms", "name": "mootools.html", "value": 3997.5051132636722}, {"lowerIsBetter": false, "replicates": [314.28656948726393, 321.1169284467714, 321.3717182907416, 325.7345263610157, 325.89408442256257, 5340.118880384737, 5393.757280922358, 5395.082835917893, 5397.055515284824, 5415.025295446818, 5047.26814611881, 5137.17805151175, 5235.973820130904, 5281.735913204334, 5321.946780532194, 4193.329067349225, 4212.9578704212945, 4215.894602634928, 4219.894502637428, 4221.55673654265, 4027.7986100694993, 4216.936745948813, 4218.0720241546815, 4223.936640950388, 4232.49210094789, 4081.2449696806184, 4095.7337773044806, 4178.435911151986, 4183.142455796569, 4189.162167566499, 4165.437665915123, 4175.164967006595, 4185.958140418587, 4188.204241194163, 4195.2029114468305, 3697.3529632314508, 3703.7222208334215, 3703.7962912039825, 3709.1098136447326, 3717.0, 5167.870803229949, 5176.663516871391, 5184.611154163415, 5185.6888586684545, 5186.896262074775, 4650.674557751025, 4787.569118779326, 4789.473157952622, 4802.639802014863, 4844.055409195208, 5642.915356269659, 5656.462636049569, 5658.377578466366, 5660.801871934463, 5669.971650141764, 3955.3869150281753, 3968.523777146761, 3978.840846366171, 3978.920421591581, 3981.144054028398, 5865.882682346371, 5956.434138756855, 5959.165716799652, 5961.105834124916, 5963.344032156459, 3933.783641899666, 4046.5953404659886, 4051.0, 4056.858009969637, 4062.857799977046, 4097.590240975878, 4106.117184805281, 4110.424540564323, 4111.280525908014, 4113.341865301538, 4718.056388722201, 4726.71639701619, 4727.2436410174205, 4729.810807567659, 4732.52674732524, 5637.436256374412, 5642.181883626851, 5668.773249070074, 5686.459786320293, 5687.544996400278, 1435.9425622974964, 1462.3711803924202, 1520.9011414258039, 1520.908745475275, 1525.260248779341, 1021.2544842265188, 1049.1554298789547, 1058.6559368205365, 1069.5882085397022, 1070.5343175718588, 4887.144749668793, 4895.192293271642, 4897.8285759998225, 4945.530174633404, 4959.82640607577, 5822.0, 5824.912626310609, 5825.912611310834, 5827.504662103684, 5833.125031245348, 4793.856184314476, 4894.070126675921, 4902.656814022984, 4940.258961155783, 5025.195968644999, 3155.353152603711, 3167.6990685884803, 3184.697453741891, 3185.3629274145264, 3190.4576222041846, 5547.805826796042, 5557.472040156179, 5592.720363981784, 5598.776048958078, 5603.439656034364, 5917.5857689961285, 6067.666278354644, 6082.665453400105, 6088.056351265561, 6090.116933044684, 5617.101263797773, 5625.521830644359, 5627.155926611041, 5628.030189433747, 5628.6622802631155, 5925.229720136354, 5937.287525496968, 5937.287525496968, 5944.970275148597, 5946.791862284799, 5794.5364370851075, 5805.129230615442, 5809.2738407699035, 5810.564207684356, 5815.098659707752, 5504.496050129371, 5524.585656075891, 5601.187827764869, 5601.859953501195, 5608.775648973995, 4049.088954985105, 4095.4675892133832, 4100.446439730717, 4101.1387608601335, 4104.281750693676, 5902.439268269508, 5906.232189815297, 5907.91138132937, 5910.379410161871, 5911.0, 5562.972185139049, 5667.093265077568, 5669.858253543694, 5677.5457963362005, 5681.77272909079, 5671.0, 5675.8864822704145, 5684.9431505684415, 5685.658860468385, 5686.886262274648, 5542.972285138549, 5564.219449776033, 5565.0, 5571.303587051619, 5581.302337207849, 5729.1119876419225, 5731.140328950524, 5735.569832262514, 5735.713214339183, 5736.139579063174, 5443.918341224806, 5579.191017302387, 5613.550915926798, 5615.2700148980375, 5617.073182924772], "unit": "ms", "name": "prototype.html", "value": 4278.073517955072}, {"lowerIsBetter": false, "replicates": [676.3000294694991, 791.7347688524344, 803.3171803966627, 813.7640084375528, 825.5954582254693, 12325.0, 12511.249325040493, 12511.937440312808, 12518.937405312983, 12529.0, 12113.788621137905, 12214.389280535983, 12222.755544889096, 13524.93237533811, 13877.097988630758, 633.0188208277175, 806.9394795390355, 821.2936874288107, 822.0382152881114, 822.1942496353577, 632.5319263744842, 808.4825711544617, 818.153211426174, 819.1194465949098, 819.8811172380001, 836.0385556609917, 849.5454931611589, 849.617672047578, 849.8725191221305, 849.9107593702665, 656.3305428462988, 662.1888186970922, 832.9458585191943, 844.907060223375, 846.9195426434479, 625.3621306267627, 627.3914303125961, 629.2291942370605, 629.6190804563219, 629.937006299371, 12765.297908615023, 12979.221246725132, 12983.35083245834, 12986.935065324707, 13006.479740810357, 11002.724931876766, 11412.087033037336, 11412.771744565145, 11802.990237489385, 11892.940535297355, 9122.179003889616, 9465.858012129824, 9914.40513569181, 9970.90029099707, 10209.795804083951, 3207.631122420928, 3242.383947050053, 3261.7879837810465, 3263.689949454798, 3291.2759192977505, 43001.56998430038, 43067.0, 43717.562824371664, 43723.34414983778, 44491.555084449064, 9397.530123493798, 9419.387739796892, 9516.666916657883, 9567.899691535562, 9632.47021413829, 16813.32746690143, 16827.41104061352, 16855.0, 16856.410025649042, 16862.747058793884, 6356.110144579762, 6541.607503549707, 6550.672466376757, 6566.277709451956, 6638.535302528873, 3591.892243232707, 3679.3745063339297, 3692.9706866710635, 3781.7352785304765, 3858.2476417098396, 2707.878145483458, 2720.945581088407, 2722.986385068062, 2726.700062993069, 2736.466389054155, 502.7762645622736, 503.03668474870943, 509.4905094905095, 512.5182328611094, 514.0951924612634, 533.9534512355749, 554.6699713670359, 610.3225419784036, 625.2278436131375, 637.4040272345372, 7822.335101516434, 8059.661260613694, 8184.6316915738935, 8255.0, 8312.625931833081, 506.364512536764, 542.2327406719527, 581.3808294166699, 620.9348018458087, 636.2587585462884, 3611.331903597843, 3766.9434958475645, 3958.2083583283456, 4002.819873105659, 4095.7952102395357, 52782.736086319324, 53268.0, 53359.932801343755, 53372.73313633407, 53443.465565344624, 43389.34915976263, 43455.782721086194, 43469.0, 43867.0, 43944.78027609841, 41133.0, 42857.78571107124, 43115.7844210777, 44232.557674422846, 44251.557484425386, 8101.918980810116, 8508.787280318042, 8572.785680358042, 8620.913790862262, 8918.643254270017, 32309.35381292408, 33023.50464742983, 33571.160720982174, 33609.327813444084, 33830.49254261139, 42356.36465452959, 42927.0, 42936.0, 43135.13729725451, 43193.568064318955, 10321.277510574188, 10542.26204165701, 10567.524461399102, 10574.629887953884, 10657.626983055556, 12032.879671203526, 12040.618472209742, 12046.457909394274, 12139.635810925687, 12327.75344493123, 10866.945665271624, 10906.2365634408, 10992.945035275092, 11106.555737770399, 11159.72100697489, 10976.451177441255, 10990.615328463466, 11042.558297668325, 11214.15893807984, 11362.715932101764, 8529.275011623833, 9583.802024746907, 10587.841182382117, 10705.785884282115, 10884.07485363753, 9469.195118414736, 9473.621055157717, 9547.570359333986, 10024.548895299584, 10058.8491172631, 7212.639368031682, 9006.54967251648, 9069.319801014819, 9076.319276054455, 9183.403078799856], "unit": "ms", "name": "yui.html", "value": 5913.253643306745}], "name": "dromaeo_css", "value": 6392.577647578664}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 112.0, 112.0, 112.0, 102.0, 112.0, 115.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [159.0, 131.0, 153.0, 170.0, 135.0, 157.0, 155.0, 139.0, 163.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 159.0, 159.0, 159.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 87.0, 90.0, 72.0, 72.0, 72.0, 93.0, 95.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 129.0, 90.0, 91.0, 91.0, 125.0, 91.0, 91.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 102.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 70.0, 69.0, 71.0, 70.0, 71.0, 80.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 82.0, 82.0, 83.0, 83.0, 82.0, 90.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [119.0, 124.0, 127.0, 123.0, 125.0, 117.0, 130.0, 123.0, 126.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [146.0, 136.0, 145.0, 144.0, 146.0, 134.0, 158.0, 153.0, 145.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 71.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1513.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.61256544502618], "unit": "score", "name": "Richards", "value": 215.76582400000007}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [2010.0401606425703], "unit": "score", "name": "RayTrace", "value": 368.1463756243757}, {"lowerIsBetter": false, "replicates": [798.8826815642458], "unit": "score", "name": "Earley", "value": 834.2438951048953}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [628.052598622417], "unit": "score", "name": "Splay", "value": 129.75187138584246}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19731.26400833161}]} 04:34:51 INFO - RETURN: dromaeo_css: 6392.58 04:34:51 INFO - RETURN: kraken: 1513.30 04:34:51 INFO - RETURN: v8_7: 19731.26 04:34:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19731.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1513.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6392.58"}}} 04:34:51 INFO - Return code: 0 04:34:51 INFO - # TBPL SUCCESS # 04:34:51 INFO - Running post-action listener: _resource_record_post_action 04:34:51 INFO - Running post-run listener: _resource_record_post_run 04:34:52 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269975552; Read time: 8; Write time: 254108 04:34:52 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 192512; Read time: 0; Write time: 44 04:34:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 264966144; Read time: 0; Write time: 253652 04:34:52 INFO - Running post-run listener: _upload_blobber_files 04:34:52 INFO - Blob upload gear active. 04:34:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:52 INFO - Copying logs to upload dir... 04:34:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.885419 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-23 04:34:52.616001) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:34:52.619634) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009876 build_url: 'https://queue.taskcluster.net/v1/task/mn8lwr5cRgqCw4GzLK-Sng/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-23 04:34:52.671621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:34:52.671933) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=76a4ffbc7ba64825c1a171dc000001de-1448259963.125822-852139103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:34:52.721017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:34:52.721329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:34:52.721617) ========= ========= Total master_lag: 0.23 =========