builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1447946915.46 results: success (0) buildid: 20151118154839 builduid: 05e2be9280b341659856e5b8a58bc70d revision: 5326ac1a435a44d335752ed727fa157273b91244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.457322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.457658) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.457940) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006513 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.516623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.516899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.578955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.579219) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.640401) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.640679) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.641032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.641323) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 07:28:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2015-11-19 07:28:35 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105539 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.776048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.776321) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.831521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 07:28:35.831825) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5326ac1a435a44d335752ed727fa157273b91244 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5326ac1a435a44d335752ed727fa157273b91244 --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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 07:28:36,031 truncating revision to first 12 chars 2015-11-19 07:28:36,031 Setting DEBUG logging. 2015-11-19 07:28:36,032 attempt 1/10 2015-11-19 07:28:36,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5326ac1a435a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 07:28:37,176 unpacking tar archive at: mozilla-inbound-5326ac1a435a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 07:28:37.308266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:37.308566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:37.318872) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:37.319286) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:37.319774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2015-11-19 07:28:37.320085) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:37 INFO - MultiFileLogger online at 20151119 07:28:37 in /builds/slave/test 07:28:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 07:28:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:37 INFO - {'append_to_log': False, 07:28:37 INFO - 'base_work_dir': '/builds/slave/test', 07:28:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 07:28:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:37 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 07:28:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:37 INFO - 'config_files': ('talos/linux_config.py',), 07:28:37 INFO - 'default_actions': ('clobber', 07:28:37 INFO - 'read-buildbot-config', 07:28:37 INFO - 'download-and-extract', 07:28:37 INFO - 'populate-webroot', 07:28:37 INFO - 'create-virtualenv', 07:28:37 INFO - 'install', 07:28:37 INFO - 'run-tests'), 07:28:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:37 INFO - 'download_minidump_stackwalk': True, 07:28:37 INFO - 'download_symbols': 'ondemand', 07:28:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:37 INFO - 'installer_path': 'installer.exe', 07:28:37 INFO - 'log_level': 'info', 07:28:37 INFO - 'log_name': 'talos', 07:28:37 INFO - 'log_to_console': True, 07:28:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:37 INFO - 'opt_config_files': (), 07:28:37 INFO - 'pip_index': False, 07:28:37 INFO - 'sps_profile': False, 07:28:37 INFO - 'sps_profile_interval': 0, 07:28:37 INFO - 'suite': 'dromaeojs', 07:28:37 INFO - 'system_bits': '64', 07:28:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:37 INFO - 'title': 'talos-linux64-ix-011', 07:28:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:37 INFO - 'use_talos_json': True, 07:28:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:37 INFO - 'work_dir': 'build'} 07:28:37 INFO - ##### 07:28:37 INFO - ##### Running clobber step. 07:28:37 INFO - ##### 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: clobber 07:28:37 INFO - rmtree: /builds/slave/test/build 07:28:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:38 INFO - Running post-action listener: _resource_record_post_action 07:28:38 INFO - ##### 07:28:38 INFO - ##### Running read-buildbot-config step. 07:28:38 INFO - ##### 07:28:38 INFO - Running pre-action listener: _resource_record_pre_action 07:28:38 INFO - Running main action method: read_buildbot_config 07:28:38 INFO - Using buildbot properties: 07:28:38 INFO - { 07:28:38 INFO - "properties": { 07:28:38 INFO - "buildnumber": 5936, 07:28:38 INFO - "product": "firefox", 07:28:38 INFO - "script_repo_revision": "production", 07:28:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:28:38 INFO - "repository": "", 07:28:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 07:28:38 INFO - "buildid": "20151118154839", 07:28:38 INFO - "slavename": "talos-linux64-ix-011", 07:28:38 INFO - "pgo_build": "False", 07:28:38 INFO - "basedir": "/builds/slave/test", 07:28:38 INFO - "project": "", 07:28:38 INFO - "platform": "ubuntu64_hw", 07:28:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:28:38 INFO - "slavebuilddir": "test", 07:28:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 07:28:38 INFO - "branch": "mozilla-inbound", 07:28:38 INFO - "repo_path": "integration/mozilla-inbound", 07:28:38 INFO - "stage_platform": "linux64", 07:28:38 INFO - "builduid": "05e2be9280b341659856e5b8a58bc70d", 07:28:38 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:38 INFO - }, 07:28:38 INFO - "sourcestamp": { 07:28:38 INFO - "repository": "", 07:28:38 INFO - "hasPatch": false, 07:28:38 INFO - "project": "", 07:28:38 INFO - "branch": "mozilla-inbound-linux64-talos", 07:28:38 INFO - "changes": [ 07:28:38 INFO - { 07:28:38 INFO - "category": null, 07:28:38 INFO - "files": [ 07:28:38 INFO - { 07:28:38 INFO - "url": null, 07:28:38 INFO - "name": "https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:28:38 INFO - } 07:28:38 INFO - ], 07:28:38 INFO - "repository": "", 07:28:38 INFO - "rev": "5326ac1a435a44d335752ed727fa157273b91244", 07:28:38 INFO - "who": "mchang@mozilla.com", 07:28:38 INFO - "when": 1447893334, 07:28:38 INFO - "number": 6679828, 07:28:38 INFO - "comments": "Bug 1208636 - Adjust displayport size based on available system memory. r=kats", 07:28:38 INFO - "project": "", 07:28:38 INFO - "at": "Wed 18 Nov 2015 16:35:34", 07:28:38 INFO - "branch": "mozilla-inbound-linux64-talos", 07:28:38 INFO - "revlink": "", 07:28:38 INFO - "properties": [ 07:28:38 INFO - [ 07:28:38 INFO - "buildid", 07:28:38 INFO - "20151118154839", 07:28:38 INFO - "Change" 07:28:38 INFO - ], 07:28:38 INFO - [ 07:28:38 INFO - "builduid", 07:28:38 INFO - "05e2be9280b341659856e5b8a58bc70d", 07:28:38 INFO - "Change" 07:28:38 INFO - ], 07:28:38 INFO - [ 07:28:38 INFO - "pgo_build", 07:28:38 INFO - "False", 07:28:38 INFO - "Change" 07:28:38 INFO - ] 07:28:38 INFO - ], 07:28:38 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:38 INFO - } 07:28:38 INFO - ], 07:28:38 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:38 INFO - } 07:28:38 INFO - } 07:28:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:28:38 INFO - Running post-action listener: _resource_record_post_action 07:28:38 INFO - ##### 07:28:38 INFO - ##### Running download-and-extract step. 07:28:38 INFO - ##### 07:28:38 INFO - Running pre-action listener: _resource_record_pre_action 07:28:38 INFO - Running main action method: download_and_extract 07:28:38 INFO - mkdir: /builds/slave/test/build/tests 07:28:38 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')]} 07:28:38 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:28:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json 07:28:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json 07:28:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:28:54 INFO - Downloaded 1302 bytes. 07:28:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:28:54 INFO - Using the following test package requirements: 07:28:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'jsshell-linux-x86_64.zip'], 07:28:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28: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')]} 07:28:54 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:08 INFO - Downloaded 21331175 bytes. 07:29:08 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 07:29:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:29:08 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 07:29:09 INFO - Return code: 0 07:29:09 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 07:29: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')]} 07:29:09 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:29:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:29:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:29:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:17 INFO - Downloaded 21331175 bytes. 07:29:17 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 07:29:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:29:17 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 07:29:18 INFO - Return code: 0 07:29:18 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')]} 07:29:18 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:19 INFO - Downloaded 11130997 bytes. 07:29:19 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 07:29:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:19 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 07:29:19 INFO - Return code: 0 07:29:19 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')]} 07:29:19 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:29:28 INFO - Downloaded 55770415 bytes. 07:29:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:28 INFO - mkdir: /builds/slave/test/properties 07:29:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:28 INFO - Contents: 07:29:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:29:28 INFO - Running post-action listener: _resource_record_post_action 07:29:28 INFO - Running post-action listener: set_extra_try_arguments 07:29:28 INFO - ##### 07:29:28 INFO - ##### Running populate-webroot step. 07:29:28 INFO - ##### 07:29:28 INFO - Running pre-action listener: _resource_record_pre_action 07:29:28 INFO - Running main action method: populate_webroot 07:29:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:28 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:29:28 INFO - '../fennec_ids.txt'], 07:29:28 INFO - 'tests': ['tcheck2']}, 07:29:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:28 INFO - '--tppagecycles', 07:29:28 INFO - '7'], 07:29:28 INFO - 'tests': ['tsvgm']}}, 07:29:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:29:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'tests': ['damp', 'tps']}, 07:29:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['damp', 'tps']}, 07:29:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:29:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:28 INFO - 'other': {'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'other_l64': {'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'other_nol64': {'tests': ['a11yr', 07:29:28 INFO - 'ts_paint', 07:29:28 INFO - 'tpaint', 07:29:28 INFO - 'sessionrestore', 07:29:28 INFO - 'sessionrestore_no_auto_restore']}, 07:29:28 INFO - 'svgr': {'tests': ['tsvgx', 07:29:28 INFO - 'tsvgr_opacity', 07:29:28 INFO - 'tart', 07:29:28 INFO - 'tscrollx', 07:29:28 INFO - 'cart']}, 07:29:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['tsvgx', 07:29:28 INFO - 'tsvgr_opacity', 07:29:28 INFO - 'tart', 07:29:28 INFO - 'tscrollx', 07:29:28 INFO - 'cart']}, 07:29:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'tests': ['tp5o']}, 07:29:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'talos_options': ['--e10s'], 07:29:28 INFO - 'tests': ['tp5o']}, 07:29:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'talos_options': ['--xperf_path', 07:29:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:28 INFO - 'tests': ['tp5n']}, 07:29:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:28 INFO - 'talos_options': ['--e10s', 07:29:28 INFO - '--xperf_path', 07:29:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:28 INFO - 'tests': ['tp5n']}}, 07:29:28 INFO - 'talos.zip': {'path': '', 07:29:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:28 INFO - Running post-action listener: _resource_record_post_action 07:29:28 INFO - ##### 07:29:28 INFO - ##### Running create-virtualenv step. 07:29:28 INFO - ##### 07:29:28 INFO - Running pre-action listener: _resource_record_pre_action 07:29:28 INFO - Running main action method: create_virtualenv 07:29:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:28 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 07:29:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:28 INFO - Using real prefix '/usr' 07:29:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:31 INFO - Installing pip.................done. 07:29:31 INFO - Return code: 0 07:29:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:31 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:31 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 07:29:31 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 07:29:31 INFO - Using env: {'DISPLAY': ':0', 07:29:31 INFO - 'HOME': '/home/cltbld', 07:29:31 INFO - 'LANG': 'en_US.UTF-8', 07:29:31 INFO - 'LANGUAGE': 'en_US:en', 07:29:31 INFO - 'LOGNAME': 'cltbld', 07:29:31 INFO - 'MAIL': '/var/mail/cltbld', 07:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:31 INFO - 'MOZ_NO_REMOTE': '1', 07:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:31 INFO - 'NO_EM_RESTART': '1', 07:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:31 INFO - 'PWD': '/builds/slave/test', 07:29:31 INFO - 'SHELL': '/bin/bash', 07:29:31 INFO - 'SHLVL': '1', 07:29:31 INFO - 'TERM': 'linux', 07:29:31 INFO - 'TMOUT': '86400', 07:29:31 INFO - 'USER': 'cltbld', 07:29:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:31 INFO - '_': '/tools/buildbot/bin/python'} 07:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:31 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 07:29:31 INFO - Cleaning up... 07:29:31 INFO - Return code: 0 07:29:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:31 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:31 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 07:29:31 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 07:29:31 INFO - Using env: {'DISPLAY': ':0', 07:29:31 INFO - 'HOME': '/home/cltbld', 07:29:31 INFO - 'LANG': 'en_US.UTF-8', 07:29:31 INFO - 'LANGUAGE': 'en_US:en', 07:29:31 INFO - 'LOGNAME': 'cltbld', 07:29:31 INFO - 'MAIL': '/var/mail/cltbld', 07:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:31 INFO - 'MOZ_NO_REMOTE': '1', 07:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:31 INFO - 'NO_EM_RESTART': '1', 07:29:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:31 INFO - 'PWD': '/builds/slave/test', 07:29:31 INFO - 'SHELL': '/bin/bash', 07:29:31 INFO - 'SHLVL': '1', 07:29:31 INFO - 'TERM': 'linux', 07:29:31 INFO - 'TMOUT': '86400', 07:29:31 INFO - 'USER': 'cltbld', 07:29:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:31 INFO - '_': '/tools/buildbot/bin/python'} 07:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:31 INFO - Downloading/unpacking psutil>=0.7.1 07:29:31 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 07:29:31 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 07:29:31 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 07:29:31 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 07:29:31 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 07:29:31 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 07:29:33 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:29:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:33 INFO - Installing collected packages: psutil 07:29:33 INFO - Running setup.py install for psutil 07:29:33 INFO - building 'psutil._psutil_linux' extension 07:29:33 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 07:29:33 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 07:29:33 INFO - building 'psutil._psutil_posix' extension 07:29:33 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 07:29:34 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 07:29:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:34 INFO - Successfully installed psutil 07:29:34 INFO - Cleaning up... 07:29:34 INFO - Return code: 0 07:29:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:34 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:34 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 07:29:34 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 07:29:34 INFO - Using env: {'DISPLAY': ':0', 07:29:34 INFO - 'HOME': '/home/cltbld', 07:29:34 INFO - 'LANG': 'en_US.UTF-8', 07:29:34 INFO - 'LANGUAGE': 'en_US:en', 07:29:34 INFO - 'LOGNAME': 'cltbld', 07:29:34 INFO - 'MAIL': '/var/mail/cltbld', 07:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:34 INFO - 'MOZ_NO_REMOTE': '1', 07:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:34 INFO - 'NO_EM_RESTART': '1', 07:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:34 INFO - 'PWD': '/builds/slave/test', 07:29:34 INFO - 'SHELL': '/bin/bash', 07:29:34 INFO - 'SHLVL': '1', 07:29:34 INFO - 'TERM': 'linux', 07:29:34 INFO - 'TMOUT': '86400', 07:29:34 INFO - 'USER': 'cltbld', 07:29:34 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:34 INFO - '_': '/tools/buildbot/bin/python'} 07:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:29:34 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 07:29:34 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 07:29:34 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 07:29:34 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 07:29:34 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 07:29:34 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 07:29:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:29:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:29:36 INFO - Installing collected packages: mozsystemmonitor 07:29:36 INFO - Running setup.py install for mozsystemmonitor 07:29:36 INFO - Successfully installed mozsystemmonitor 07:29:36 INFO - Cleaning up... 07:29:36 INFO - Return code: 0 07:29:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:36 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:36 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 07:29:36 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 07:29:36 INFO - Using env: {'DISPLAY': ':0', 07:29:36 INFO - 'HOME': '/home/cltbld', 07:29:36 INFO - 'LANG': 'en_US.UTF-8', 07:29:36 INFO - 'LANGUAGE': 'en_US:en', 07:29:36 INFO - 'LOGNAME': 'cltbld', 07:29:36 INFO - 'MAIL': '/var/mail/cltbld', 07:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:36 INFO - 'MOZ_NO_REMOTE': '1', 07:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:36 INFO - 'NO_EM_RESTART': '1', 07:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:36 INFO - 'PWD': '/builds/slave/test', 07:29:36 INFO - 'SHELL': '/bin/bash', 07:29:36 INFO - 'SHLVL': '1', 07:29:36 INFO - 'TERM': 'linux', 07:29:36 INFO - 'TMOUT': '86400', 07:29:36 INFO - 'USER': 'cltbld', 07:29:36 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:36 INFO - '_': '/tools/buildbot/bin/python'} 07:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:36 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 07:29:36 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 07:29:36 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 07:29:36 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 07:29:36 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 07:29:36 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 07:29:38 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 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 07:29:38 INFO - Downloading docopt-0.6.1.tar.gz 07:29:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:38 INFO - Running setup.py install for blobuploader 07:29:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:38 INFO - Running setup.py install for requests 07:29:39 INFO - Running setup.py install for docopt 07:29:39 INFO - Successfully installed blobuploader requests docopt 07:29:39 INFO - Cleaning up... 07:29:39 INFO - Return code: 0 07:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:39 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:39 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 07:29:39 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 07:29:39 INFO - Using env: {'DISPLAY': ':0', 07:29:39 INFO - 'HOME': '/home/cltbld', 07:29:39 INFO - 'LANG': 'en_US.UTF-8', 07:29:39 INFO - 'LANGUAGE': 'en_US:en', 07:29:39 INFO - 'LOGNAME': 'cltbld', 07:29:39 INFO - 'MAIL': '/var/mail/cltbld', 07:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:39 INFO - 'MOZ_NO_REMOTE': '1', 07:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:39 INFO - 'NO_EM_RESTART': '1', 07:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:39 INFO - 'PWD': '/builds/slave/test', 07:29:39 INFO - 'SHELL': '/bin/bash', 07:29:39 INFO - 'SHLVL': '1', 07:29:39 INFO - 'TERM': 'linux', 07:29:39 INFO - 'TMOUT': '86400', 07:29:39 INFO - 'USER': 'cltbld', 07:29:39 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:39 INFO - '_': '/tools/buildbot/bin/python'} 07:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:39 INFO - Running setup.py (path:/tmp/pip-qsPo1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:39 INFO - Running setup.py (path:/tmp/pip-btAqC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:39 INFO - Running setup.py (path:/tmp/pip-f1j2xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:39 INFO - Running setup.py (path:/tmp/pip-anjJT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:39 INFO - Running setup.py (path:/tmp/pip-wdYiLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:39 INFO - Running setup.py (path:/tmp/pip-yj20v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:40 INFO - Running setup.py (path:/tmp/pip-5MWTtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:40 INFO - Running setup.py (path:/tmp/pip-j91eY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:40 INFO - Running setup.py (path:/tmp/pip-IrJixN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:40 INFO - Running setup.py (path:/tmp/pip-p2rtYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:40 INFO - Running setup.py (path:/tmp/pip-kV6zyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:40 INFO - Running setup.py (path:/tmp/pip-W2KfrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:40 INFO - Running setup.py (path:/tmp/pip-dJs6WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:40 INFO - Running setup.py (path:/tmp/pip-h7orjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:40 INFO - Running setup.py (path:/tmp/pip-kqPYKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:40 INFO - Running setup.py (path:/tmp/pip-REV2ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:40 INFO - Running setup.py (path:/tmp/pip-alXnYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:40 INFO - Running setup.py install for manifestparser 07:29:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Running setup.py install for mozcrash 07:29:41 INFO - Running setup.py install for mozdebug 07:29:41 INFO - Running setup.py install for mozdevice 07:29:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Running setup.py install for mozfile 07:29:41 INFO - Running setup.py install for mozhttpd 07:29:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Running setup.py install for mozinfo 07:29:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Running setup.py install for mozInstall 07:29:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Running setup.py install for mozleak 07:29:41 INFO - Running setup.py install for mozlog 07:29:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:41 INFO - Running setup.py install for moznetwork 07:29:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Running setup.py install for mozprocess 07:29:42 INFO - Running setup.py install for mozprofile 07:29:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Running setup.py install for mozrunner 07:29:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Running setup.py install for mozscreenshot 07:29:42 INFO - Running setup.py install for moztest 07:29:42 INFO - Running setup.py install for mozversion 07:29:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:42 INFO - Cleaning up... 07:29:42 INFO - Return code: 0 07:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:42 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:42 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 07:29:42 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 07:29:42 INFO - Using env: {'DISPLAY': ':0', 07:29:42 INFO - 'HOME': '/home/cltbld', 07:29:42 INFO - 'LANG': 'en_US.UTF-8', 07:29:42 INFO - 'LANGUAGE': 'en_US:en', 07:29:42 INFO - 'LOGNAME': 'cltbld', 07:29:42 INFO - 'MAIL': '/var/mail/cltbld', 07:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:42 INFO - 'MOZ_NO_REMOTE': '1', 07:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:42 INFO - 'NO_EM_RESTART': '1', 07:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:42 INFO - 'PWD': '/builds/slave/test', 07:29:42 INFO - 'SHELL': '/bin/bash', 07:29:42 INFO - 'SHLVL': '1', 07:29:42 INFO - 'TERM': 'linux', 07:29:42 INFO - 'TMOUT': '86400', 07:29:42 INFO - 'USER': 'cltbld', 07:29:42 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:42 INFO - '_': '/tools/buildbot/bin/python'} 07:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:42 INFO - Running setup.py (path:/tmp/pip-upqKfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:42 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)) 07:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:42 INFO - Running setup.py (path:/tmp/pip-B_n8oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:43 INFO - Running setup.py (path:/tmp/pip-b_0VWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:43 INFO - Running setup.py (path:/tmp/pip-z6M8rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:43 INFO - Running setup.py (path:/tmp/pip-UsfUwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:43 INFO - Running setup.py (path:/tmp/pip-eWl1eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:43 INFO - Running setup.py (path:/tmp/pip-etEQST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:43 INFO - Running setup.py (path:/tmp/pip-mDO4gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:43 INFO - Running setup.py (path:/tmp/pip-KxA0IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:43 INFO - Running setup.py (path:/tmp/pip-p653Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:43 INFO - Running setup.py (path:/tmp/pip-PT71KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:43 INFO - Running setup.py (path:/tmp/pip-Lm3DDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:43 INFO - Running setup.py (path:/tmp/pip-ZW3gz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:43 INFO - Running setup.py (path:/tmp/pip-qKQZtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:43 INFO - Running setup.py (path:/tmp/pip-cDbTus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:43 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)) 07:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:43 INFO - Running setup.py (path:/tmp/pip-JDcl0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:44 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)) 07:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:44 INFO - Running setup.py (path:/tmp/pip-Lfl86d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 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)) 07:29:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:44 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 07:29:44 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 07:29:44 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 07:29:44 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 07:29:44 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 07:29:44 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 07:29:45 INFO - Downloading blessings-1.5.1.tar.gz 07:29:45 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 07:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:45 INFO - Installing collected packages: blessings 07:29:45 INFO - Running setup.py install for blessings 07:29:45 INFO - Successfully installed blessings 07:29:45 INFO - Cleaning up... 07:29:45 INFO - Return code: 0 07:29:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:46 INFO - Reading from file tmpfile_stdout 07:29:46 INFO - Current package versions: 07:29:46 INFO - argparse == 1.2.1 07:29:46 INFO - blessings == 1.5.1 07:29:46 INFO - blobuploader == 1.2.4 07:29:46 INFO - docopt == 0.6.1 07:29:46 INFO - manifestparser == 1.1 07:29:46 INFO - mozInstall == 1.12 07:29:46 INFO - mozcrash == 0.16 07:29:46 INFO - mozdebug == 0.1 07:29:46 INFO - mozdevice == 0.47 07:29:46 INFO - mozfile == 1.2 07:29:46 INFO - mozhttpd == 0.7 07:29:46 INFO - mozinfo == 0.9 07:29:46 INFO - mozleak == 0.1 07:29:46 INFO - mozlog == 3.0 07:29:46 INFO - moznetwork == 0.27 07:29:46 INFO - mozprocess == 0.22 07:29:46 INFO - mozprofile == 0.27 07:29:46 INFO - mozrunner == 6.11 07:29:46 INFO - mozscreenshot == 0.1 07:29:46 INFO - mozsystemmonitor == 0.0 07:29:46 INFO - moztest == 0.7 07:29:46 INFO - mozversion == 1.4 07:29:46 INFO - psutil == 3.1.1 07:29:46 INFO - requests == 1.2.3 07:29:46 INFO - wsgiref == 0.1.2 07:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:46 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 0x7fad379ebc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25286c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d9900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, '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-1447946285.804850-1359038299', '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 07:29:46 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 07:29:46 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 07:29:46 INFO - Using env: {'DISPLAY': ':0', 07:29:46 INFO - 'HOME': '/home/cltbld', 07:29:46 INFO - 'LANG': 'en_US.UTF-8', 07:29:46 INFO - 'LANGUAGE': 'en_US:en', 07:29:46 INFO - 'LOGNAME': 'cltbld', 07:29:46 INFO - 'MAIL': '/var/mail/cltbld', 07:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:46 INFO - 'MOZ_NO_REMOTE': '1', 07:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:46 INFO - 'NO_EM_RESTART': '1', 07:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:46 INFO - 'PWD': '/builds/slave/test', 07:29:46 INFO - 'SHELL': '/bin/bash', 07:29:46 INFO - 'SHLVL': '1', 07:29:46 INFO - 'TERM': 'linux', 07:29:46 INFO - 'TMOUT': '86400', 07:29:46 INFO - 'USER': 'cltbld', 07:29:46 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:46 INFO - '_': '/tools/buildbot/bin/python'} 07:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 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)) 07:29:46 INFO - Cleaning up... 07:29:46 INFO - Return code: 0 07:29:46 INFO - Running post-action listener: _resource_record_post_action 07:29:46 INFO - Running post-action listener: _start_resource_monitoring 07:29:46 INFO - Starting resource monitoring. 07:29:46 INFO - ##### 07:29:46 INFO - ##### Running install step. 07:29:46 INFO - ##### 07:29:46 INFO - Running pre-action listener: _resource_record_pre_action 07:29:46 INFO - Running main action method: install 07:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:46 INFO - Reading from file tmpfile_stdout 07:29:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:46 INFO - Reading from file tmpfile_stdout 07:29:46 INFO - Output received: 07:29:46 INFO - Usage: mozinstall [options] installer 07:29:46 INFO - Options: 07:29:46 INFO - -h, --help show this help message and exit 07:29:46 INFO - -d DEST, --destination=DEST 07:29:46 INFO - Directory to install application into. [default: 07:29:46 INFO - "/builds/slave/test"] 07:29:46 INFO - --app=APP Application being installed. [default: firefox] 07:29:46 INFO - mkdir: /builds/slave/test/build/application 07:29:46 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'] 07:29:46 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 07:30:02 INFO - Reading from file tmpfile_stdout 07:30:02 INFO - Output received: 07:30:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:02 INFO - Running post-action listener: _resource_record_post_action 07:30:02 INFO - ##### 07:30:02 INFO - ##### Running run-tests step. 07:30:02 INFO - ##### 07:30:02 INFO - Running pre-action listener: _resource_record_pre_action 07:30:02 INFO - Running main action method: run_tests 07:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:02 INFO - Python 2.7.3 07:30:02 INFO - Return code: 0 07:30:02 INFO - grabbing minidump binary from tooltool 07:30: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')]} 07:30:02 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 0x261fb70>, '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 0x2670dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2671250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:02 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 07:30:02 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 07:30:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:02 INFO - Return code: 0 07:30:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 07:30:02 INFO - Using env: {'DISPLAY': ':0', 07:30:02 INFO - 'HOME': '/home/cltbld', 07:30:02 INFO - 'LANG': 'en_US.UTF-8', 07:30:02 INFO - 'LANGUAGE': 'en_US:en', 07:30:02 INFO - 'LOGNAME': 'cltbld', 07:30:02 INFO - 'MAIL': '/var/mail/cltbld', 07:30:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:02 INFO - 'MOZ_NO_REMOTE': '1', 07:30:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:02 INFO - 'NO_EM_RESTART': '1', 07:30:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:02 INFO - 'PWD': '/builds/slave/test', 07:30:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:02 INFO - 'SHELL': '/bin/bash', 07:30:02 INFO - 'SHLVL': '1', 07:30:02 INFO - 'TERM': 'linux', 07:30:02 INFO - 'TMOUT': '86400', 07:30:02 INFO - 'USER': 'cltbld', 07:30:02 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447946285.804850-1359038299', 07:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:02 INFO - '_': '/tools/buildbot/bin/python'} 07:30:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/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 07:30:02 INFO - mozversion INFO | application_buildid: 20151118154839 07:30:02 INFO - mozversion INFO | application_changeset: 5326ac1a435a44d335752ed727fa157273b91244 07:30:02 INFO - mozversion INFO | application_display_name: Nightly 07:30:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:02 INFO - mozversion INFO | application_name: Firefox 07:30:02 INFO - mozversion INFO | application_remotingname: firefox 07:30:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:30:02 INFO - mozversion INFO | application_vendor: Mozilla 07:30:02 INFO - mozversion INFO | application_version: 45.0a1 07:30:02 INFO - mozversion INFO | platform_buildid: 20151118154839 07:30:02 INFO - mozversion INFO | platform_changeset: 5326ac1a435a44d335752ed727fa157273b91244 07:30:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:30:02 INFO - mozversion INFO | platform_version: 45.0a1 07:30:02 INFO - 2015-11-19 07:30:02,342 DEBUG : using testdate: 1447947002 07:30:02 INFO - 2015-11-19 07:30:02,342 DEBUG : actual date: 1447947002 07:30:05 INFO - 2015-11-19 07:30:05,662 INFO : starting webserver on 'localhost:42573' 07:30:05 INFO - 2015-11-19 07:30:05,663 INFO : Starting test suite talos-linux64-ix-011 07:30:05 INFO - 2015-11-19 07:30:05,663 INFO : Starting test dromaeo_css 07:30:05 INFO - 2015-11-19 07:30:05,664 DEBUG : operating with platform_type : linux_ 07:30:05 INFO - 2015-11-19 07:30:05,664 INFO : Initialising browser for dromaeo_css test... 07:30:05 INFO - 2015-11-19 07:30:05,676 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKS8R1/profile http://localhost:42573/getInfo.html 07:30:10 INFO - 2015-11-19 07:30:10,236 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:30:10 INFO - 2015-11-19 07:30:10,236 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:30:10 INFO - 2015-11-19 07:30:10,236 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:30:10 INFO - 2015-11-19 07:30:10,236 DEBUG : BROWSER_OUTPUT: __metrics 07:30:10 INFO - 2015-11-19 07:30:10,364 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:30:11 INFO - 2015-11-19 07:30:11,697 INFO : Browser initialized. 07:30:11 INFO - 2015-11-19 07:30:11,698 INFO : Running cycle 1/1 for dromaeo_css test... 07:30:11 INFO - 2015-11-19 07:30:11,698 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKS8R1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:30:23 INFO - 2015-11-19 07:30:23,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 141729792 07:30:23 INFO - 2015-11-19 07:30:23,609 DEBUG : BROWSER_OUTPUT: 07:31:15 INFO - 2015-11-19 07:31:15,051 DEBUG : BROWSER_OUTPUT: 1447947075049 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] 07:33:27 INFO - 2015-11-19 07:33:27,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42573/tests/dromaeo/cssquery-ext.html) 07:33:28 INFO - 2015-11-19 07:33:28,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 253464576 07:33:28 INFO - 2015-11-19 07:33:28,435 DEBUG : BROWSER_OUTPUT: 07:36:31 INFO - 2015-11-19 07:36:31,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-ext.html (next: http://localhost:42573/tests/dromaeo/cssquery-jquery.html) 07:36:31 INFO - 2015-11-19 07:36:31,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 225173504 07:36:31 INFO - 2015-11-19 07:36:31,629 DEBUG : BROWSER_OUTPUT: 07:39:33 INFO - 2015-11-19 07:39:33,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42573/tests/dromaeo/cssquery-mootools.html) 07:39:34 INFO - 2015-11-19 07:39:34,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 211148800 07:39:34 INFO - 2015-11-19 07:39:34,319 DEBUG : BROWSER_OUTPUT: 07:42:36 INFO - 2015-11-19 07:42:36,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42573/tests/dromaeo/cssquery-prototype.html) 07:42:36 INFO - 2015-11-19 07:42:36,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 199880704 07:42:36 INFO - 2015-11-19 07:42:36,827 DEBUG : BROWSER_OUTPUT: 07:45:39 INFO - 2015-11-19 07:45:39,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42573/tests/dromaeo/cssquery-yui.html) 07:45:40 INFO - 2015-11-19 07:45:40,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 203517952 07:45:40 INFO - 2015-11-19 07:45:40,144 DEBUG : BROWSER_OUTPUT: 07:48:42 INFO - 2015-11-19 07:48:42,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/dromaeo/cssquery-yui.html (next: http://localhost:42573/tests/dromaeo/cssquery-dojo.html) 07:48:42 INFO - 2015-11-19 07:48:42,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 227577856 07:48:42 INFO - 2015-11-19 07:48:42,997 DEBUG : BROWSER_OUTPUT: 07:48:42 INFO - 2015-11-19 07:48:42,998 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:48:42 INFO - 2015-11-19 07:48:42,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:48:42 INFO - 2015-11-19 07:48:42,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:48:43 INFO - 2015-11-19 07:48:42,998 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:48:43 INFO - 2015-11-19 07:48:43,002 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2664.6136310235015;2756.3109222694325;2772.584112383141;2778.263760103573;2785.526460501715;4566.063956888838;4703.412073490814;4742.834000809972;4788.592969597584;4797.280407938811;4651.697639653428;4693.202155633542;4754.191787396142;4767.690100143488;4786.71279723216;4181.414601955728;4347.304431290994;4365.148795984785;4395.626371758404;4446.911061778763;4429.224885645015;4460.79926403311;4479.238529449985;4482.058767658796;4538.795754191053;4130.731502452331;4264.87205383839;4302.913941721148;4397.890052748707;4421.9336709949375;4402.845900393503;4403.581659742319;4409.581089796497;4414.823407063714;4440.2895536714295;4400.7579583122915;4403.757793321366;4420.381146639473;4435.467743870756;4450.710703804275;4499.370088187657;4636.768161591907;4638.884027899296;4643.489216186217;4647.326137710047;5030.57240134589;5061.848144555669;5063.569596584258;5065.620078494091;5066.847994560169;5023.673461225008;5073.39119305682;5076.132005366416;5097.031564002865;5112.923306150411;4694.953050469486;4764.857054288343;4803.735794531334;4838.080764654705;4842.273658951185;4944.678595891256;5249.317588713443;5262.1317482615705;5270.7628156733035;5283.656562323514;4851.199552073868;4911.950880491149;4936;4972.229304457815;5008.248762685554;5160.819371321985;5202.531772140525;5204.895902082013;5205.245239440335;5251.133562962144;4818.903621927542;5108.795648174106;5149.562287205555;5151.07280689472;5157.896842063138;4935.21036634144;4946.134426475424;4971.353724015927;5021.046001259749;5060.51925067118;4200.7059505834295;4211.073563815956;4213.852515161954;4217.40956266123;4230.49234091911;3521.1725244567506;3719.776813391205;3726.795026273581;3735.3089678409583;3751;4282.978585107055;4297.269464191095;4311.805968731414;4377.496587892433;4417.668674849399;5135.512126347991;5152.76812543429;5160.303359046481;5178.3785945686;5207.843764687065;4425.402570652985;4426.291793313055;4426.84506042287;4430.003249268889;4459.353393757887;4291.442112525352;4398.054418300081;4402.3176407656865;4456.955430445654;4600.7929643166135;4867.3915760529935;4905.8037678492465;4907.656464047483;4921.188003979447;4964.751762411937;5148.794048238028;5172.793088276578;5178.352705911761;5181.689098654093;5224.425313215619;4551.226291530514;4654.650901182493;4661.347411362344;4740.146773580788;4851.636127290397;5041.269015992734;5064.696118232918;5064.96168285508;5068.087744206078;5071.695698258116;5145;5151.768170432414;5155.407128180307;5159.922601160911;5179.585633149414;4656.8602941911795;4788.640851936049;4793.688410253322;4798.2082956311815;4978.975105124596;4993.126202914403;5030.320906677552;5030.4466508684745;5041.193409054534;5043.798248070183;4922.261660750916;4931.3589233399425;4937.5556199942175;4944.110060189057;4961.206207006861;4691.601213896857;4789.137955168103;4804.711717296974;4877.268409738567;5059.924101138559;4831.0820944020525;4878.121938051185;4909.214525676018;4910.803567857246;4949.331840201527 07:48:43 INFO - 2015-11-19 07:48:43,003 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.0112661571184;565.361141909642;574.9827505174846;579.4090028171265;583.6643929740399;26246.475070498578;26769.19692409226;26797.866010669943;32491.67508324916;33131.66868331316;36138;36474.08814779632;36515.817420912856;36578.63421365785;36638;7743.070831500214;7908.841823163562;7913.129555748863;7922.009748781403;7927.8414431711335;7238.529495582797;7417.369523590474;10223.897761022406;10511.421871797049;10514.369137851716;10086.445245511493;10167.135793457564;10167.4916254187;10172.89827101727;10191.08280254777;7267.999999999947;7478.2895624915545;10081.09270165685;10224.693259202237;10225.590976360974;10142.847857282146;10502.422366769824;10502.579896804118;10505.527251273634;10514.264001519896;37400.62599374026;37745.43381849275;37904.431433528516;37966.43050354247;37979.240415191816;2738;2744.2590500564934;2778.9444211115665;2796.499145707854;2811.9578206326923;27627.309317267027;27728.861355693294;27910;28041;28474.145775626555;2878.294817769639;2897.3336132689387;2951.2031751427207;2962.3630919352445;3058.5870907427657;217432;218796;219580;219630;219781.9999999984;50629.240561391605;51945.220821687704;52056.47943520516;54701.45298547043;55208.72395638077;54471.72764136154;56745.71627141838;57048.14427783587;57130.714346428;57144.999700042026;14081.08472949255;14299.07056041354;14368.281585920662;14391;14396;10002.699919002442;10026.949865250774;10032.64885728996;10045.547950342252;10060.446675432922;18212.63574728498;18219.180136893872;18236.270549177883;18329;18329.90835045843;7425.517341372793;7674.424418168548;7762.146163921964;7855.921440785633;7864.331531819745;773.9535627862347;819.9180081991753;943.7970836270235;989.099919073654;1003.4130033930232;25955.351116222246;26038.86980565085;26097.347566310993;26315.73684263171;26327.605085923726;930.688219446493;1014.4674046125843;1077.4666540062562;1084.4794498640697;1090.5038207615517;13811.51659691926;14226.573202803933;14363.856361436252;14427;14445.422183112769;260727;266225;267280;267561;267710;45534.772326138154;45579.08841823145;45805.31292030622;45867.77066114648;45934.08131837344;1135.994320028411;1139.1968662093204;1149.2989276541302;1149.7757937202166;1150.5282834038005;21617.891910540347;24381.26856194246;25922.22233333003;26802.463950721267;28213.576796348483;39276.2144757109;39475.40786888142;39615.40576891291;39621;39641.60358396495;189412;190777.04611476854;191175;191500;238225;22363.329100127023;28316.43367132687;28719.71280287254;28992;29044.56433153462;31252.218694532818;34119.4882076774;34736.478952815225;34912.65087349094;35361;30332.938347157742;30506.237344066576;30821.537676935313;31102.68897310998;31149.844250778602;30527.389452211275;30873.228169295948;30990.69009309968;31944.36111277715;33704.494432583044;29746.256343590718;29831;30005.049671771267;30032.549511756904;31830;27777.166684999484;28771.28071798222;28817.56773648355;28853.56719649165;29440.263993400335;24058.51882962296;25119.54127894314;25287.620685689362;25308.493830122927;25686.871565642054 07:48:43 INFO - 2015-11-19 07:48:43,005 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.8035637548345;313.3263483510452;320.9951850722238;323.43399051659594;327.1526745728561;13103.606891793237;13539.864601353984;15756.369745210191;16158.43445479407;16399.918000409994;15052.548423547283;15255.160966146857;15727.213639318017;15738.291776870039;15738.84261157388;4935.087008903346;4942.308076869242;5024.698518088908;5044.19292913134;5059.620528460362;3554.92890142197;3656.287024030315;5031.496850314976;5556.527695145917;5800.9129863052085;5747.080467125261;5833.037548804442;5847.181394604759;5860.560457965648;5891.322497912752;5545.805896793613;5614.326280846284;5625.6905870177125;5627.268455100811;5628.099504079348;4864.537868902448;4874.025194961022;4877.926831097537;4894.657373983787;4904.754762261909;19789.505262368413;19967;20179.89910050455;20206.89896550508;20802.063907124215;1625.5042212125297;1693.2634304077765;1803.2027033088682;1808.9366872159412;1861.5346163459135;13533.864661353358;13762.587122386345;13880.167189968633;13907;14226.644333891632;1767.3902503636225;1812.4562631210583;1870.7474490943684;1876.1557299215272;1901.9239230430767;59500.40499594992;63113;63218.367816321705;63568;63681.363186368006;15166.924165379103;15573.610659733597;15586;15593.376264949275;15605.68788624221;22652.773472265395;22793.088276468756;22964.65553016706;23006;23029.654555181685;8410.369222308229;8607.956960215159;8635.13648635144;8654.6538138475;8699.478031318142;7146.606936618432;7254.5647261164495;7267.709291628382;7275.199728029913;7292.124945006633;7519.8120046998165;7668.194839541768;7676.884846727304;7682.654280557388;7701.768946931601;2483.6771219741318;2969.8218106913223;2974.9553756693667;3009.3680327131547;3018.5321275202377;387.64143167569887;389.795357437342;406.8067667857803;409.5433591545465;432.34931428200355;8683.175098365646;10219.182465402899;10402.011808878144;10748.677539673823;10897.400642964554;409.6886366361527;414.34740284052134;421.67320326747017;434.07541935676807;454.62493442909073;5048.419431765321;5756.856078598069;5861.70691465425;6115.571909966259;6288.025356069817;326572;328606;328987;330669;331913;57942;59387;62586.374136258964;67327.66336168288;68883.31116688868;474.3761953031752;487.1110223841503;487.16451286044605;490.0590865538175;490.0859896293458;9777.768933420479;10306.48467576633;10331.638392656221;10410.739731506774;10714.19643526723;29859.70140298569;30237.848810755804;30840.537391939586;32802.50796238011;33923.15192120217;39653.60346396499;40650.79674601608;40887;40975.1804963905;41090.58909410987;6064.696765161812;6272.372762723874;6281.434670879643;6288.5598008138995;6289.842753931189;10997.450127493434;11161.665150045512;11383.317000979967;11426;11460.369679667698;9615.663451779154;9932.056454636799;10063.849042264519;10283.897161028293;10289.639862604772;9764.365316254421;9874.901250987397;10010.599576016877;10010.849837252592;10246.436445995541;9717.514124293899;9750.073742994688;9761.951190244003;10028.197744180303;10206.591736330463;5627.099664053731;5762.4525670061275;6157.415045570664;6244.188255526752;6250.187475628321;9553.331266811534;9712.902870971482;9791.118799307811;10056.949715251378;10063 07:48:43 INFO - 2015-11-19 07:48:43,006 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1386.5909556680779;1507.2463768115942;1575.9842401575984;1617.4662361420726;1677.5135210788865;6160.291566469858;6709.66451677416;6868.244493105754;6873.759418420356;6898.3101689831055;6972.8256793580185;7080.787576372704;7081.433485321175;7088.610126443044;7091.89362159568;2048.9999999999964;2062.1545166481746;2067.069818581637;2068.121048554366;2068.1727309076414;2086.5305306306036;2089.9895500522475;2094.287942099686;2096.695979083032;2110.577884423114;1977.5253939054667;2010.7888671689482;2022.1709099269303;2025.5138766695961;2027.5032617008853;1996.870203436772;1997.1811557261526;2003.2988454041115;2003.378952524722;2009.5378063045434;1994.8603597748163;2019.182231196353;2019.7576290845193;2020.0808632072371;2028.381343690174;5874.265716785402;6024.186734790791;6947.7220911163495;6977.95330700394;6981.965090174567;4056.7971601420104;4177.436046133764;4178.26880295947;4185.351270553069;4190.832366705328;2708.79684023699;2738.3838636306873;2773.0571605654172;2774.3618967637353;2795.3850152966315;820.4707963363657;831.1231650608605;834.4659417972442;840.2060053249681;855.5935930433056;9452.385594936308;9521.666741664008;9537.952310238474;9543.04569543047;9561.665341713007;3868.63247991446;3885.825137868803;3914.2171565686976;3916.667083297895;3936.15372694872;8286.875696864552;8292.2951549119;8300.543470109082;8305.916940830635;8311.002679678477;4118.094019315746;4149.647279981175;4149.792510374469;4151.066010147753;4154.397612346193;3730.850765969331;3751.5685696144747;3755.8122093895195;3757.342465068602;3757.962420375816;3261.3151238240234;3270.427675156838;3281.1961069538115;3309.420851351004;3311.966880331214;1020.6631811502186;1036.3471013261596;1039.6725031615017;1055.5724931402794;1056.587930707025;869.143893265146;881.6429346114834;1152.7463957929242;1170.0990237517065;1170.987096161814;6593.86812263752;6598.7030583623855;6629.204495460479;6666.699998500079;6667.899981500282;1019.3527110284874;1028.9125424338865;1061.7557961668706;1065.9840102398316;1066.6906597086913;4914.385701787277;5323.574114070865;5372.758225879845;5391.056565101092;5391.460853914656;7127.429805615642;8075.83848323042;8177.591120443954;8277.62750676221;8301.6679332826;8089.110197878229;8131.349492040741;8149;8185.976752905886;8198.590070496452;6404.071409645575;6565.080888675685;6628.304028077079;6630.834229144213;6642.136522252173;6676.465882729467;6726.8990965136545;6732.225794033749;6737.461003119641;6740.797776066725;7126.251743566851;7307.3058059484265;7438.590877501573;7448.73929412468;7453.40372770188;7647.38820894316;7863;7881.448298619041;7983.920160798318;7988.760337189894;5565.693886836263;5735.655860648374;5744.425557444222;5817.621854579439;5868.061110222344;6653.5009874260595;6706.5640733352175;6706.798796036127;6711.63086030273;6718.395344419026;6122.693865306628;6149.354317796567;6275.435210830865;6329.461995730415;6339.461145802658;6191.349908259748;6192.164057852132;6217.253929528486;6325.525585581007;6348.174737284124;6105.236845394325;6144.201253836973;6163.476104531165;6174.598651087665;6176.876462470816;5781.161731548986;5810.186573879576;5824.068149096124;5824.854378640568;5832.475077242899;5941.643501389931;6014.6391216527145;6021.126936594082;6026.548008899438;6029.125776762257 07:48:43 INFO - 2015-11-19 07:48:43,007 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.62543943751996;295.75304620641765;297.52247642533735;303.1678043769851;304.788172220307;5283.735813209339;5333.146696528556;5354.866128346794;5403.135498320269;5453.045716999519;5308.469153084689;5365.919511207335;5369.62412631116;5374.48942350476;5388.811391601294;3903.8243279052367;4123.36087906375;4129.6076872697195;4131.4629098217265;4137.855175068873;4017.3973903914352;4028.154087641599;4108.322126849066;4110.1163249901265;4145.854895078673;4060.817263223147;4065.6340929316357;4093.22228776533;4096.631303182713;4104.692148088905;3844.5386553613744;3926.5484469285825;3967.940480892789;4099.692523060768;4108.301588729938;3561.5904171020406;3566.5363502744735;3571.714262858965;3572.214112895185;3579.1231148368556;5130.127878260705;5144.0740666679985;5144.742762861842;5145.073886700392;5152.871178220575;4698.976505117453;4699.060187962421;4702.27114797207;4708.0819240248165;4711.528847115295;5503.514041296154;5569.498745112919;5605.047141985831;5609.719514024323;5612.915806262909;3880.825362858678;3884.0484081400236;3889.8833035008997;3892.443022790878;3895.045713800109;5833.270841144857;5904.439078287556;5905.055191169392;5908.586398952075;5913.231279933581;3986.1031267965054;3990.3016972029777;3991.1219531702977;3992.540857801332;3996.360582306817;3902.707296952683;4045.3122969095325;4048.514178298623;4050.716449848482;4056.087380339459;4656.208444564432;4659.976700116477;4661.976690116596;4665.113628410591;4665.370175026328;5601.7759289628775;5616.326040875121;5617;5623.550115990793;5628.493435590734;1413.738458385202;1428.6714055767231;1430.0990376063014;1430.2205298112553;1432.3769160415045;945.6926498887751;948.6537413844035;949.1457688080644;972.4845831709206;975.1759763000254;4938.2839488274;4942.283368911488;4950.18321976877;4950.331705219821;4951.10880041596;5827.3298570664065;5832.504237139806;5834.737436815353;5837;5838.065909454467;4923.532264434873;4928.088303663833;4929.75351232437;4942.456329803791;4944.381952255968;3066.8466576671076;3119.422906762211;3154.2587491939375;3155.4162479941283;3157;5540.2243685884005;5564.387917329091;5606.21512988182;5608.411116832755;5609.943900560942;6075.908861367083;6081.6351018939;6088.086786981989;6089.238845144357;6092;5582.860428489239;5602.355729091207;5605.159226116034;5605.24329215567;5607.271054762855;5681.261436013292;5887.264091988502;5896.086106653475;5897.469227769521;5898.734556944862;5749.425057494217;5753.5109515689965;5755.482006619424;5757.0788673811985;5758.769649213985;5567.47109024642;5574.275344205227;5580.414056524169;5583.916241256303;5593.300837395325;3923.450716899579;3955.149642826806;3976.900577485586;4013.257547353749;4014.9598504015753;5834.7082645866685;5863.413658634103;5867.589268751147;5867.589268751147;5868.149118377897;5620.831375058755;5626.156076588544;5633.521150702236;5643.068893632505;5660.20757093999;5528.9723551383595;5644.209810626434;5653.925754106706;5655.293088363955;5666.150077488245;5514.420985796433;5514.503694667499;5515.448455154453;5529.612927095065;5542.61201715876;5354.705491198021;5489.862753431196;5692.601517893708;5694.4590263924865;5697;5403.675779453245;5414.052540805422;5446.564274857923;5461.590380721541;5462.3445186577865 07:48:43 INFO - 2015-11-19 07:48:43,008 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.4002907281692;694.0491526608547;716.8924661300804;768.8193274580474;793.8967934168559;11380.487878045487;11584.942075289611;11596.884031159685;11600.3039817611;11617;11794.40775495308;11900.880991190086;11922.880771192285;11948.940255298712;11950.64148075557;496.74417674897364;506.7415618034792;776.3013288040752;782.4249176855006;784.1491981200376;773.4663082473104;774.8798936164903;775.2518819339336;776.2935728487078;795.7732046366787;607.4623957797359;608.9299730531002;807.2129673568282;812.1513018895239;823.5100115431309;805.7582725182481;806.0609390060572;807.7011505742854;812.2649002652608;812.7399232245684;598.512212546773;598.9011813050842;599.241958921964;610.8014895159091;617.8826023055605;11036.172287078422;11155.38645374504;11172.273802202912;11178;11196.608118715887;10596;11250.887491125066;11356.772864542745;11581.536738530449;11588.13089018327;8871.112888711143;8908.198262156437;8929.24101451371;8951.373403861733;8967;3112.501999680063;3126.906192814219;3156.1478400831875;3164.7942883712717;3171;38433.23133537341;38580.22839543221;38823.8058809707;38998.80500597479;39021.219575608615;8208.46644968075;8295.294899933573;8311.542865142475;8332.250097491255;8355.331573474108;15562.688746225012;15689.764653530206;15704.764428533581;15707.68584628301;15716.68566628684;5865.472107510344;5919.260092488439;5953.672548009815;6112.541559383064;6222.62664240138;3284.819334936554;3438.6045604755273;3467.8612855486003;3520.0495866116007;3556.48430977512;2607.58278675411;2664.014314703572;2671.385581316308;2675.5986602009853;2687.314734742628;415.8918681142864;416.1905094591052;416.8811888611731;418.2930846868782;419.6999145610903;528.5612941258746;532.8454748123;541.3638974205293;541.7589172818058;550.1610044681812;7183.856322873513;7241.927580724126;7272.709091636381;7331.486795924341;7827.921720782833;357.9069441945061;446.11891514259725;491.5477760460385;517.9715115668674;566.8526183192399;3325.1687078230443;3365.2932884094125;3401.6428275031262;3421.8289085545625;3523.6300188480354;47789.52210477851;47915;48198.5180148201;48312.7584362083;48386.27420588694;36809;37538.43692344617;38017.42973855395;39030.6096939027;39191.21617567632;35306.82346588302;38445.807770961525;38605.806970965525;38615.2276954465;38868.416973745414;7231.746888858865;7834;7874.803129921569;7955.323797477279;8112.959435202786;29330.120096397142;29499;30012.549811753277;30448.543271851384;30603;37086.44370334501;37175.81412092922;37839.05402364963;37925.24149517049;37980;6717.294684058299;6758.167984484481;6848.212455567674;6902.654867256718;7022.157341118894;10521.421321827373;10542.051215390651;10702.411367374869;10937.234393592373;11044.282121662067;9050.321225908216;9091.818163636823;9443.055694430777;9637.469939153414;9640;9696.127348538665;9703.854442183232;10250.743731406475;10320.896791031993;10592.311499752492;9311.953440232755;9472.289578281794;9663.855042174233;9687.225021998363;9728.708138755848;7888.2506161914525;8063.153368896416;8345.54099524532;8458.957705211435;8554.144585541397;8744.825103497767;8882.245009174034;8887.822243554963;8948.821023579361;9022.958350246048 07:48:43 INFO - 2015-11-19 07:48:43,008 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:48:43 INFO - 2015-11-19 07:48:43,008 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:48:43 INFO - 2015-11-19 07:48:43,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1008 07:48:43 INFO - 2015-11-19 07:48:43,009 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:48:43 INFO - 2015-11-19 07:48:43,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948122997__endTimestamp 07:48:43 INFO - 2015-11-19 07:48:43,009 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4693.98 Median:4803.74 stddev:496.91 (10.3%) stddev-sans-first:472.25 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: Values: 2664.6 2756.3 2772.6 2778.3 2785.5 4566.1 4703.4 4742.8 4788.6 4797.3 4651.7 4693.2 4754.2 4767.7 4786.7 4181.4 4347.3 4365.1 4395.6 4446.9 4429.2 4460.8 4479.2 4482.1 4538.8 4130.7 4264.9 4302.9 4397.9 4421.9 4402.8 4403.6 4409.6 4414.8 4440.3 4400.8 4403.8 4420.4 4435.5 4450.7 4499.4 4636.8 4638.9 4643.5 4647.3 5030.6 5061.8 5063.6 5065.6 5066.8 5023.7 5073.4 5076.1 5097.0 5112.9 4695.0 4764.9 4803.7 4838.1 4842.3 4944.7 5249.3 5262.1 5270.8 5283.7 4851.2 4912.0 4936.0 4972.2 5008.2 5160.8 5202.5 5204.9 5205.2 5251.1 4818.9 5108.8 5149.6 5151.1 5157.9 4935.2 4946.1 4971.4 5021.0 5060.5 4200.7 4211.1 4213.9 4217.4 4230.5 3521.2 3719.8 3726.8 3735.3 3751.0 4283.0 4297.3 4311.8 4377.5 4417.7 5135.5 5152.8 5160.3 5178.4 5207.8 4425.4 4426.3 4426.8 4430.0 4459.4 4291.4 4398.1 4402.3 4457.0 4600.8 4867.4 4905.8 4907.7 4921.2 4964.8 5148.8 5172.8 5178.4 5181.7 5224.4 4551.2 4654.7 4661.3 4740.1 4851.6 5041.3 5064.7 5065.0 5068.1 5071.7 5145.0 5151.8 5155.4 5159.9 5179.6 4656.9 4788.6 4793.7 4798.2 4979.0 4993.1 5030.3 5030.4 5041.2 5043.8 4922.3 4931.4 4937.6 4944.1 4961.2 4691.6 4789.1 4804.7 4877.3 5059.9 4831.1 4878.1 4909.2 4910.8 4949.3 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38650.95 Median:28395.29 stddev:59877.48 (210.9%) stddev-sans-first:59977.09 07:48:43 INFO - 2015-11-19 07:48:43,010 DEBUG : BROWSER_OUTPUT: Values: 546.0 565.4 575.0 579.4 583.7 26246.5 26769.2 26797.9 32491.7 33131.7 36138.0 36474.1 36515.8 36578.6 36638.0 7743.1 7908.8 7913.1 7922.0 7927.8 7238.5 7417.4 10223.9 10511.4 10514.4 10086.4 10167.1 10167.5 10172.9 10191.1 7268.0 7478.3 10081.1 10224.7 10225.6 10142.8 10502.4 10502.6 10505.5 10514.3 37400.6 37745.4 37904.4 37966.4 37979.2 2738.0 2744.3 2778.9 2796.5 2812.0 27627.3 27728.9 27910.0 28041.0 28474.1 2878.3 2897.3 2951.2 2962.4 3058.6 217432.0 218796.0 219580.0 219630.0 219782.0 50629.2 51945.2 52056.5 54701.5 55208.7 54471.7 56745.7 57048.1 57130.7 57145.0 14081.1 14299.1 14368.3 14391.0 14396.0 10002.7 10026.9 10032.6 10045.5 10060.4 18212.6 18219.2 18236.3 18329.0 18329.9 7425.5 7674.4 7762.1 7855.9 7864.3 774.0 819.9 943.8 989.1 1003.4 25955.4 26038.9 26097.3 26315.7 26327.6 930.7 1014.5 1077.5 1084.5 1090.5 13811.5 14226.6 14363.9 14427.0 14445.4 260727.0 266225.0 267280.0 267561.0 267710.0 45534.8 45579.1 45805.3 45867.8 45934.1 1136.0 1139.2 1149.3 1149.8 1150.5 21617.9 24381.3 25922.2 26802.5 28213.6 39276.2 39475.4 39615.4 39621.0 39641.6 189412.0 190777.0 191175.0 191500.0 238225.0 22363.3 28316.4 28719.7 28992.0 29044.6 31252.2 34119.5 34736.5 34912.7 35361.0 30332.9 30506.2 30821.5 31102.7 31149.8 30527.4 30873.2 30990.7 31944.4 33704.5 29746.3 29831.0 30005.0 30032.5 31830.0 27777.2 28771.3 28817.6 28853.6 29440.3 24058.5 25119.5 25287.6 25308.5 25686.9 07:48:43 INFO - 2015-11-19 07:48:43,011 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,011 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21599.64 Median:20648.27 stddev:54228.83 (262.6%) stddev-sans-first:54357.40 07:48:43 INFO - 2015-11-19 07:48:43,011 DEBUG : BROWSER_OUTPUT: Values: 311.8 313.3 321.0 323.4 327.2 13103.6 13539.9 15756.4 16158.4 16399.9 15052.5 15255.2 15727.2 15738.3 15738.8 4935.1 4942.3 5024.7 5044.2 5059.6 3554.9 3656.3 5031.5 5556.5 5800.9 5747.1 5833.0 5847.2 5860.6 5891.3 5545.8 5614.3 5625.7 5627.3 5628.1 4864.5 4874.0 4877.9 4894.7 4904.8 19789.5 19967.0 20179.9 20206.9 20802.1 1625.5 1693.3 1803.2 1808.9 1861.5 13533.9 13762.6 13880.2 13907.0 14226.6 1767.4 1812.5 1870.7 1876.2 1901.9 59500.4 63113.0 63218.4 63568.0 63681.4 15166.9 15573.6 15586.0 15593.4 15605.7 22652.8 22793.1 22964.7 23006.0 23029.7 8410.4 8608.0 8635.1 8654.7 8699.5 7146.6 7254.6 7267.7 7275.2 7292.1 7519.8 7668.2 7676.9 7682.7 7701.8 2483.7 2969.8 2975.0 3009.4 3018.5 387.6 389.8 406.8 409.5 432.3 8683.2 10219.2 10402.0 10748.7 10897.4 409.7 414.3 421.7 434.1 454.6 5048.4 5756.9 5861.7 6115.6 6288.0 326572.0 328606.0 328987.0 330669.0 331913.0 57942.0 59387.0 62586.4 67327.7 68883.3 474.4 487.1 487.2 490.1 490.1 9777.8 10306.5 10331.6 10410.7 10714.2 29859.7 30237.8 30840.5 32802.5 33923.2 39653.6 40650.8 40887.0 40975.2 41090.6 6064.7 6272.4 6281.4 6288.6 6289.8 10997.5 11161.7 11383.3 11426.0 11460.4 9615.7 9932.1 10063.8 10283.9 10289.6 9764.4 9874.9 10010.6 10010.8 10246.4 9717.5 9750.1 9762.0 10028.2 10206.6 5627.1 5762.5 6157.4 6244.2 6250.2 9553.3 9712.9 9791.1 10056.9 10063.0 07:48:43 INFO - 2015-11-19 07:48:43,011 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4871.24 Median:6017.88 stddev:2499.10 (41.5%) stddev-sans-first:2492.39 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: Values: 1386.6 1507.2 1576.0 1617.5 1677.5 6160.3 6709.7 6868.2 6873.8 6898.3 6972.8 7080.8 7081.4 7088.6 7091.9 2049.0 2062.2 2067.1 2068.1 2068.2 2086.5 2090.0 2094.3 2096.7 2110.6 1977.5 2010.8 2022.2 2025.5 2027.5 1996.9 1997.2 2003.3 2003.4 2009.5 1994.9 2019.2 2019.8 2020.1 2028.4 5874.3 6024.2 6947.7 6978.0 6982.0 4056.8 4177.4 4178.3 4185.4 4190.8 2708.8 2738.4 2773.1 2774.4 2795.4 820.5 831.1 834.5 840.2 855.6 9452.4 9521.7 9538.0 9543.0 9561.7 3868.6 3885.8 3914.2 3916.7 3936.2 8286.9 8292.3 8300.5 8305.9 8311.0 4118.1 4149.6 4149.8 4151.1 4154.4 3730.9 3751.6 3755.8 3757.3 3758.0 3261.3 3270.4 3281.2 3309.4 3312.0 1020.7 1036.3 1039.7 1055.6 1056.6 869.1 881.6 1152.7 1170.1 1171.0 6593.9 6598.7 6629.2 6666.7 6667.9 1019.4 1028.9 1061.8 1066.0 1066.7 4914.4 5323.6 5372.8 5391.1 5391.5 7127.4 8075.8 8177.6 8277.6 8301.7 8089.1 8131.3 8149.0 8186.0 8198.6 6404.1 6565.1 6628.3 6630.8 6642.1 6676.5 6726.9 6732.2 6737.5 6740.8 7126.3 7307.3 7438.6 7448.7 7453.4 7647.4 7863.0 7881.4 7983.9 7988.8 5565.7 5735.7 5744.4 5817.6 5868.1 6653.5 6706.6 6706.8 6711.6 6718.4 6122.7 6149.4 6275.4 6329.5 6339.5 6191.3 6192.2 6217.3 6325.5 6348.2 6105.2 6144.2 6163.5 6174.6 6176.9 5781.2 5810.2 5824.1 5824.9 5832.5 5941.6 6014.6 6021.1 6026.5 6029.1 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4657.65 Median:5367.77 stddev:1387.88 (25.9%) stddev-sans-first:1352.55 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: Values: 292.6 295.8 297.5 303.2 304.8 5283.7 5333.1 5354.9 5403.1 5453.0 5308.5 5365.9 5369.6 5374.5 5388.8 3903.8 4123.4 4129.6 4131.5 4137.9 4017.4 4028.2 4108.3 4110.1 4145.9 4060.8 4065.6 4093.2 4096.6 4104.7 3844.5 3926.5 3967.9 4099.7 4108.3 3561.6 3566.5 3571.7 3572.2 3579.1 5130.1 5144.1 5144.7 5145.1 5152.9 4699.0 4699.1 4702.3 4708.1 4711.5 5503.5 5569.5 5605.0 5609.7 5612.9 3880.8 3884.0 3889.9 3892.4 3895.0 5833.3 5904.4 5905.1 5908.6 5913.2 3986.1 3990.3 3991.1 3992.5 3996.4 3902.7 4045.3 4048.5 4050.7 4056.1 4656.2 4660.0 4662.0 4665.1 4665.4 5601.8 5616.3 5617.0 5623.6 5628.5 1413.7 1428.7 1430.1 1430.2 1432.4 945.7 948.7 949.1 972.5 975.2 4938.3 4942.3 4950.2 4950.3 4951.1 5827.3 5832.5 5834.7 5837.0 5838.1 4923.5 4928.1 4929.8 4942.5 4944.4 3066.8 3119.4 3154.3 3155.4 3157.0 5540.2 5564.4 5606.2 5608.4 5609.9 6075.9 6081.6 6088.1 6089.2 6092.0 5582.9 5602.4 5605.2 5605.2 5607.3 5681.3 5887.3 5896.1 5897.5 5898.7 5749.4 5753.5 5755.5 5757.1 5758.8 5567.5 5574.3 5580.4 5583.9 5593.3 3923.5 3955.1 3976.9 4013.3 4015.0 5834.7 5863.4 5867.6 5867.6 5868.1 5620.8 5626.2 5633.5 5643.1 5660.2 5529.0 5644.2 5653.9 5655.3 5666.2 5514.4 5514.5 5515.4 5529.6 5542.6 5354.7 5489.9 5692.6 5694.5 5697.0 5403.7 5414.1 5446.6 5461.6 5462.3 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,012 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11465.68 Median:494.15 stddev:12951.79 (2621.0%) stddev-sans-first:12962.61 07:48:43 INFO - 2015-11-19 07:48:43,013 DEBUG : BROWSER_OUTPUT: Values: 641.4 694.0 716.9 768.8 793.9 11380.5 11584.9 11596.9 11600.3 11617.0 11794.4 11900.9 11922.9 11948.9 11950.6 496.7 506.7 776.3 782.4 784.1 773.5 774.9 775.3 776.3 795.8 607.5 608.9 807.2 812.2 823.5 805.8 806.1 807.7 812.3 812.7 598.5 598.9 599.2 610.8 617.9 11036.2 11155.4 11172.3 11178.0 11196.6 10596.0 11250.9 11356.8 11581.5 11588.1 8871.1 8908.2 8929.2 8951.4 8967.0 3112.5 3126.9 3156.1 3164.8 3171.0 38433.2 38580.2 38823.8 38998.8 39021.2 8208.5 8295.3 8311.5 8332.3 8355.3 15562.7 15689.8 15704.8 15707.7 15716.7 5865.5 5919.3 5953.7 6112.5 6222.6 3284.8 3438.6 3467.9 3520.0 3556.5 2607.6 2664.0 2671.4 2675.6 2687.3 415.9 416.2 416.9 418.3 419.7 528.6 532.8 541.4 541.8 550.2 7183.9 7241.9 7272.7 7331.5 7827.9 357.9 446.1 491.5 518.0 566.9 3325.2 3365.3 3401.6 3421.8 3523.6 47789.5 47915.0 48198.5 48312.8 48386.3 36809.0 37538.4 38017.4 39030.6 39191.2 35306.8 38445.8 38605.8 38615.2 38868.4 7231.7 7834.0 7874.8 7955.3 8113.0 29330.1 29499.0 30012.5 30448.5 30603.0 37086.4 37175.8 37839.1 37925.2 37980.0 6717.3 6758.2 6848.2 6902.7 7022.2 10521.4 10542.1 10702.4 10937.2 11044.3 9050.3 9091.8 9443.1 9637.5 9640.0 9696.1 9703.9 10250.7 10320.9 10592.3 9312.0 9472.3 9663.9 9687.2 9728.7 7888.3 8063.2 8345.5 8459.0 8554.1 8744.8 8882.2 8887.8 8948.8 9023.0 07:48:43 INFO - 2015-11-19 07:48:43,013 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:48:43 INFO - 2015-11-19 07:48:43,013 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,777 INFO : Browser exited with error code: 0 07:48:43 INFO - 2015-11-19 07:48:43,801 INFO : Completed test dromaeo_css (00:18:38) 07:48:43 INFO - 2015-11-19 07:48:43,801 INFO : Starting test kraken 07:48:43 INFO - 2015-11-19 07:48:43,801 DEBUG : operating with platform_type : linux_ 07:48:43 INFO - 2015-11-19 07:48:43,801 INFO : Initialising browser for kraken test... 07:48:43 INFO - 2015-11-19 07:48:43,807 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSu7LN/profile http://localhost:42573/getInfo.html 07:48:48 INFO - 2015-11-19 07:48:48,313 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:48:48 INFO - 2015-11-19 07:48:48,313 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:48:48 INFO - 2015-11-19 07:48:48,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:48:48 INFO - 2015-11-19 07:48:48,314 DEBUG : BROWSER_OUTPUT: __metrics 07:48:48 INFO - 2015-11-19 07:48:48,470 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:49 INFO - 2015-11-19 07:48:49,728 INFO : Browser initialized. 07:48:49 INFO - 2015-11-19 07:48:49,728 INFO : Running cycle 1/1 for kraken test... 07:48:49 INFO - 2015-11-19 07:48:49,728 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSu7LN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:01 INFO - 2015-11-19 07:49:01,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 07:49:01 INFO - 2015-11-19 07:49:01,597 DEBUG : BROWSER_OUTPUT: 07:49:04 INFO - 2015-11-19 07:49:04,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42573/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:04 INFO - 2015-11-19 07:49:04,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 175779840 07:49:04 INFO - 2015-11-19 07:49:04,780 DEBUG : BROWSER_OUTPUT: 07:49:07 INFO - 2015-11-19 07:49:07,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42573/tests/kraken/driver.html?testName=audio-dft) 07:49:08 INFO - 2015-11-19 07:49:08,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 167538688 07:49:08 INFO - 2015-11-19 07:49:08,092 DEBUG : BROWSER_OUTPUT: 07:49:11 INFO - 2015-11-19 07:49:11,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42573/tests/kraken/driver.html?testName=audio-fft) 07:49:11 INFO - 2015-11-19 07:49:11,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 152682496 07:49:11 INFO - 2015-11-19 07:49:11,632 DEBUG : BROWSER_OUTPUT: 07:49:13 INFO - 2015-11-19 07:49:13,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42573/tests/kraken/driver.html?testName=audio-oscillator) 07:49:14 INFO - 2015-11-19 07:49:14,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 155168768 07:49:14 INFO - 2015-11-19 07:49:14,237 DEBUG : BROWSER_OUTPUT: 07:49:16 INFO - 2015-11-19 07:49:16,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42573/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:17 INFO - 2015-11-19 07:49:17,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 156643328 07:49:17 INFO - 2015-11-19 07:49:17,015 DEBUG : BROWSER_OUTPUT: 07:49:20 INFO - 2015-11-19 07:49:20,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42573/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:20 INFO - 2015-11-19 07:49:20,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 157085696 07:49:20 INFO - 2015-11-19 07:49:20,585 DEBUG : BROWSER_OUTPUT: 07:49:24 INFO - 2015-11-19 07:49:24,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42573/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:24 INFO - 2015-11-19 07:49:24,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 154488832 07:49:24 INFO - 2015-11-19 07:49:24,672 DEBUG : BROWSER_OUTPUT: 07:49:27 INFO - 2015-11-19 07:49:27,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42573/tests/kraken/driver.html?testName=json-parse-financial) 07:49:28 INFO - 2015-11-19 07:49:28,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 154238976 07:49:28 INFO - 2015-11-19 07:49:28,083 DEBUG : BROWSER_OUTPUT: 07:49:29 INFO - 2015-11-19 07:49:29,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42573/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:30 INFO - 2015-11-19 07:49:30,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 163819520 07:49:30 INFO - 2015-11-19 07:49:30,369 DEBUG : BROWSER_OUTPUT: 07:49:32 INFO - 2015-11-19 07:49:32,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:32 INFO - 2015-11-19 07:49:32,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 164438016 07:49:32 INFO - 2015-11-19 07:49:32,878 DEBUG : BROWSER_OUTPUT: 07:49:34 INFO - 2015-11-19 07:49:34,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:35 INFO - 2015-11-19 07:49:35,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 171913216 07:49:35 INFO - 2015-11-19 07:49:35,577 DEBUG : BROWSER_OUTPUT: 07:49:38 INFO - 2015-11-19 07:49:38,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:38 INFO - 2015-11-19 07:49:38,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 178151424 07:49:38 INFO - 2015-11-19 07:49:38,678 DEBUG : BROWSER_OUTPUT: 07:49:41 INFO - 2015-11-19 07:49:41,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:41 INFO - 2015-11-19 07:49:41,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 177532928 07:49:41 INFO - 2015-11-19 07:49:41,886 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42573/tests/kraken/driver.html?testName=ai-astar) 07:49:43 INFO - 2015-11-19 07:49:43,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 235724800 07:49:43 INFO - 2015-11-19 07:49:43,898 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,902 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:49:43 INFO - 2015-11-19 07:49:43,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:49:43 INFO - 2015-11-19 07:49:43,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:49:43 INFO - 2015-11-19 07:49:43,902 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:49:43 INFO - 2015-11-19 07:49:43,902 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;115;108;114;113;114;103;112;104;112 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;153;169;131;164;155;133;172;141 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;164;163;162;161;164;163;161 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;85;97;73;73;74;118;88;73 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;134;92;93;92;127;92;93;133 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;110;109;109 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;147;148;147;151;147;148;148;147;148 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;94;95;96;95;96;95;95;96;95 07:49:43 INFO - 2015-11-19 07:49:43,903 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;67;68;69;68;67;76;66;64 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;68;69;69;69;70;69;69;69;69 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;83;85;82;83;83;84;85;82 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;123;134;121;133;121;132;122;119;123 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;139;151;150;152;140;149;148;150;139 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;71;72;69;70;68;69;69 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:49:43 INFO - 2015-11-19 07:49:43,904 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:49:43 INFO - 2015-11-19 07:49:43,905 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,969 07:49:43 INFO - 2015-11-19 07:49:43,905 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:49:43 INFO - 2015-11-19 07:49:43,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948183899__endTimestamp 07:49:43 INFO - 2015-11-19 07:49:43,905 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,908 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:49:43 INFO - 2015-11-19 07:49:43,908 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.22 (3.8%) stddev-sans-first:4.48 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 108.0 114.0 113.0 114.0 103.0 112.0 104.0 112.0 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.50 stddev:15.73 (10.0%) stddev-sans-first:16.46 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 153.0 169.0 131.0 164.0 155.0 133.0 172.0 141.0 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.45 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 164.0 163.0 162.0 161.0 164.0 163.0 161.0 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,909 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.70 Median:73.50 stddev:15.02 (20.4%) stddev-sans-first:15.51 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 85.0 97.0 73.0 73.0 74.0 118.0 88.0 73.0 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:18.96 (20.6%) stddev-sans-first:19.68 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 134.0 92.0 93.0 92.0 127.0 92.0 93.0 133.0 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,910 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.37 (0.9%) stddev-sans-first:1.27 07:49:43 INFO - 2015-11-19 07:49:43,911 DEBUG : BROWSER_OUTPUT: Values: 150.0 147.0 148.0 147.0 151.0 147.0 148.0 148.0 147.0 148.0 07:49:43 INFO - 2015-11-19 07:49:43,911 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,911 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:49:43 INFO - 2015-11-19 07:49:43,911 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 07:49:43 INFO - 2015-11-19 07:49:43,911 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.00 stddev:3.11 (4.6%) stddev-sans-first:3.30 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 69.0 68.0 67.0 76.0 66.0 64.0 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.32 (1.6%) stddev-sans-first:1.13 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 83.0 85.0 82.0 83.0 83.0 84.0 85.0 82.0 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,912 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:5.75 (4.5%) stddev-sans-first:5.89 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: Values: 130.0 123.0 134.0 121.0 133.0 121.0 132.0 122.0 119.0 123.0 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:5.27 (3.5%) stddev-sans-first:5.46 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: Values: 150.0 139.0 151.0 150.0 152.0 140.0 149.0 148.0 150.0 139.0 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.17 (1.7%) stddev-sans-first:1.24 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 71.0 72.0 69.0 70.0 68.0 69.0 69.0 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:49:43 INFO - 2015-11-19 07:49:43,913 DEBUG : BROWSER_OUTPUT: 07:49:44 INFO - 2015-11-19 07:49:44,905 INFO : Browser exited with error code: 0 07:49:44 INFO - 2015-11-19 07:49:44,954 INFO : Completed test kraken (00:01:01) 07:49:44 INFO - 2015-11-19 07:49:44,954 INFO : Starting test v8_7 07:49:44 INFO - 2015-11-19 07:49:44,954 DEBUG : operating with platform_type : linux_ 07:49:44 INFO - 2015-11-19 07:49:44,954 INFO : Initialising browser for v8_7 test... 07:49:44 INFO - 2015-11-19 07:49:44,960 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IlUOd/profile http://localhost:42573/getInfo.html 07:49:49 INFO - 2015-11-19 07:49:49,427 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:49:49 INFO - 2015-11-19 07:49:49,427 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:49:49 INFO - 2015-11-19 07:49:49,428 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:49:49 INFO - 2015-11-19 07:49:49,428 DEBUG : BROWSER_OUTPUT: __metrics 07:49:49 INFO - 2015-11-19 07:49:49,593 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:51 INFO - 2015-11-19 07:49:51,229 INFO : Browser initialized. 07:49:51 INFO - 2015-11-19 07:49:51,230 INFO : Running cycle 1/1 for v8_7 test... 07:49:51 INFO - 2015-11-19 07:49:51,230 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2IlUOd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:50:03 INFO - 2015-11-19 07:50:03,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 141713408 07:50:03 INFO - 2015-11-19 07:50:03,153 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42573/tests/v8_7/run.html (next: http://localhost:42573/tests/v8_7/run.html) 07:50:24 INFO - 2015-11-19 07:50:24,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 442728448 07:50:24 INFO - 2015-11-19 07:50:24,815 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,816 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:50:24 INFO - 2015-11-19 07:50:24,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:50:24 INFO - 2015-11-19 07:50:24,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:50:24 INFO - 2015-11-19 07:50:24,816 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |0;Richards;165.23463317911435 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.59762435040832 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.7695125387433 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2004.0080160320642 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 07:50:24 INFO - 2015-11-19 07:50:24,817 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: |8;Splay;622.360248447205 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948224814__endTimestamp 07:50:24 INFO - 2015-11-19 07:50:24,818 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,819 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:50:24 INFO - 2015-11-19 07:50:24,819 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:50:24 INFO - 2015-11-19 07:50:24,819 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,819 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.23 Median:165.23 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,819 DEBUG : BROWSER_OUTPUT: Values: 165.2 07:50:24 INFO - 2015-11-19 07:50:24,821 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,821 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.60 Median:185.60 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,821 DEBUG : BROWSER_OUTPUT: Values: 185.6 07:50:24 INFO - 2015-11-19 07:50:24,821 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,821 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.77 Median:281.77 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: Values: 281.8 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: Values: 5030.2 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: Values: 2004.0 07:50:24 INFO - 2015-11-19 07:50:24,822 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: Values: 777.6 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: Values: 12132.5 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,823 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: Values: 26657.9 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.36 Median:622.36 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: Values: 622.4 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:50:24 INFO - 2015-11-19 07:50:24,824 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:50:24 INFO - 2015-11-19 07:50:24,825 DEBUG : BROWSER_OUTPUT: 07:50:25 INFO - 2015-11-19 07:50:25,817 INFO : Browser exited with error code: 0 07:50:25 INFO - 2015-11-19 07:50:25,834 INFO : Completed test v8_7 (00:00:40) 07:50:25 INFO - 2015-11-19 07:50:25,857 INFO : Completed test suite (00:20:20) 07:50:25 INFO - 2015-11-19 07:50:25,857 DEBUG : Working with test: dromaeo_css 07:50:25 INFO - 2015-11-19 07:50:25,857 DEBUG : Generating results file: dromaeo_css 07:50:25 INFO - 2015-11-19 07:50:25,859 DEBUG : Working with test: kraken 07:50:25 INFO - 2015-11-19 07:50:25,859 DEBUG : Generating results file: kraken 07:50:25 INFO - 2015-11-19 07:50:25,859 INFO : javascript benchmark 07:50:25 INFO - 2015-11-19 07:50:25,859 DEBUG : Working with test: v8_7 07:50:25 INFO - 2015-11-19 07:50:25,860 DEBUG : Generating results file: v8_7 07:50:25 INFO - 2015-11-19 07:50:25,860 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:25 INFO - 2015-11-19 07:50:25,928 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 07:50:25 INFO - 2015-11-19 07:50:25,928 DEBUG : process_Request line: dromaeo_css 6129.59 graph.html#tests=[[72,131,35]] 07:50:25 INFO - 2015-11-19 07:50:25,928 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:25 INFO - 2015-11-19 07:50:25,971 DEBUG : process_Request line: kraken 1525.00 graph.html#tests=[[232,131,35]] 07:50:25 INFO - 2015-11-19 07:50:25,971 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:26 INFO - 2015-11-19 07:50:26,010 DEBUG : process_Request line: v8_7 19837.97 graph.html#tests=[[230,131,35]] 07:50:26 INFO - 2015-11-19 07:50:26,012 INFO : javascript benchmark 07:50:26 INFO - 2015-11-19 07:50:26,016 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2664.6136310235015, 2756.3109222694325, 2772.584112383141, 2778.263760103573, 2785.526460501715, 4566.063956888838, 4703.412073490814, 4742.834000809972, 4788.592969597584, 4797.280407938811, 4651.697639653428, 4693.202155633542, 4754.191787396142, 4767.690100143488, 4786.71279723216, 4181.414601955728, 4347.304431290994, 4365.148795984785, 4395.626371758404, 4446.911061778763, 4429.224885645015, 4460.79926403311, 4479.238529449985, 4482.058767658796, 4538.795754191053, 4130.731502452331, 4264.87205383839, 4302.913941721148, 4397.890052748707, 4421.9336709949375, 4402.845900393503, 4403.581659742319, 4409.581089796497, 4414.823407063714, 4440.2895536714295, 4400.7579583122915, 4403.757793321366, 4420.381146639473, 4435.467743870756, 4450.710703804275, 4499.370088187657, 4636.768161591907, 4638.884027899296, 4643.489216186217, 4647.326137710047, 5030.57240134589, 5061.848144555669, 5063.569596584258, 5065.620078494091, 5066.847994560169, 5023.673461225008, 5073.39119305682, 5076.132005366416, 5097.031564002865, 5112.923306150411, 4694.953050469486, 4764.857054288343, 4803.735794531334, 4838.080764654705, 4842.273658951185, 4944.678595891256, 5249.317588713443, 5262.1317482615705, 5270.7628156733035, 5283.656562323514, 4851.199552073868, 4911.950880491149, 4936.0, 4972.229304457815, 5008.248762685554, 5160.819371321985, 5202.531772140525, 5204.895902082013, 5205.245239440335, 5251.133562962144, 4818.903621927542, 5108.795648174106, 5149.562287205555, 5151.07280689472, 5157.896842063138, 4935.21036634144, 4946.134426475424, 4971.353724015927, 5021.046001259749, 5060.51925067118, 4200.7059505834295, 4211.073563815956, 4213.852515161954, 4217.40956266123, 4230.49234091911, 3521.1725244567506, 3719.776813391205, 3726.795026273581, 3735.3089678409583, 3751.0, 4282.978585107055, 4297.269464191095, 4311.805968731414, 4377.496587892433, 4417.668674849399, 5135.512126347991, 5152.76812543429, 5160.303359046481, 5178.3785945686, 5207.843764687065, 4425.402570652985, 4426.291793313055, 4426.84506042287, 4430.003249268889, 4459.353393757887, 4291.442112525352, 4398.054418300081, 4402.3176407656865, 4456.955430445654, 4600.7929643166135, 4867.3915760529935, 4905.8037678492465, 4907.656464047483, 4921.188003979447, 4964.751762411937, 5148.794048238028, 5172.793088276578, 5178.352705911761, 5181.689098654093, 5224.425313215619, 4551.226291530514, 4654.650901182493, 4661.347411362344, 4740.146773580788, 4851.636127290397, 5041.269015992734, 5064.696118232918, 5064.96168285508, 5068.087744206078, 5071.695698258116, 5145.0, 5151.768170432414, 5155.407128180307, 5159.922601160911, 5179.585633149414, 4656.8602941911795, 4788.640851936049, 4793.688410253322, 4798.2082956311815, 4978.975105124596, 4993.126202914403, 5030.320906677552, 5030.4466508684745, 5041.193409054534, 5043.798248070183, 4922.261660750916, 4931.3589233399425, 4937.5556199942175, 4944.110060189057, 4961.206207006861, 4691.601213896857, 4789.137955168103, 4804.711717296974, 4877.268409738567, 5059.924101138559, 4831.0820944020525, 4878.121938051185, 4909.214525676018, 4910.803567857246, 4949.331840201527], "unit": "ms", "name": "dojo.html", "value": 4663.135716849145}, {"lowerIsBetter": false, "replicates": [546.0112661571184, 565.361141909642, 574.9827505174846, 579.4090028171265, 583.6643929740399, 26246.475070498578, 26769.19692409226, 26797.866010669943, 32491.67508324916, 33131.66868331316, 36138.0, 36474.08814779632, 36515.817420912856, 36578.63421365785, 36638.0, 7743.070831500214, 7908.841823163562, 7913.129555748863, 7922.009748781403, 7927.8414431711335, 7238.529495582797, 7417.369523590474, 10223.897761022406, 10511.421871797049, 10514.369137851716, 10086.445245511493, 10167.135793457564, 10167.4916254187, 10172.89827101727, 10191.08280254777, 7267.999999999947, 7478.2895624915545, 10081.09270165685, 10224.693259202237, 10225.590976360974, 10142.847857282146, 10502.422366769824, 10502.579896804118, 10505.527251273634, 10514.264001519896, 37400.62599374026, 37745.43381849275, 37904.431433528516, 37966.43050354247, 37979.240415191816, 2738.0, 2744.2590500564934, 2778.9444211115665, 2796.499145707854, 2811.9578206326923, 27627.309317267027, 27728.861355693294, 27910.0, 28041.0, 28474.145775626555, 2878.294817769639, 2897.3336132689387, 2951.2031751427207, 2962.3630919352445, 3058.5870907427657, 217432.0, 218796.0, 219580.0, 219630.0, 219781.9999999984, 50629.240561391605, 51945.220821687704, 52056.47943520516, 54701.45298547043, 55208.72395638077, 54471.72764136154, 56745.71627141838, 57048.14427783587, 57130.714346428, 57144.999700042026, 14081.08472949255, 14299.07056041354, 14368.281585920662, 14391.0, 14396.0, 10002.699919002442, 10026.949865250774, 10032.64885728996, 10045.547950342252, 10060.446675432922, 18212.63574728498, 18219.180136893872, 18236.270549177883, 18329.0, 18329.90835045843, 7425.517341372793, 7674.424418168548, 7762.146163921964, 7855.921440785633, 7864.331531819745, 773.9535627862347, 819.9180081991753, 943.7970836270235, 989.099919073654, 1003.4130033930232, 25955.351116222246, 26038.86980565085, 26097.347566310993, 26315.73684263171, 26327.605085923726, 930.688219446493, 1014.4674046125843, 1077.4666540062562, 1084.4794498640697, 1090.5038207615517, 13811.51659691926, 14226.573202803933, 14363.856361436252, 14427.0, 14445.422183112769, 260727.0, 266225.0, 267280.0, 267561.0, 267710.0, 45534.772326138154, 45579.08841823145, 45805.31292030622, 45867.77066114648, 45934.08131837344, 1135.994320028411, 1139.1968662093204, 1149.2989276541302, 1149.7757937202166, 1150.5282834038005, 21617.891910540347, 24381.26856194246, 25922.22233333003, 26802.463950721267, 28213.576796348483, 39276.2144757109, 39475.40786888142, 39615.40576891291, 39621.0, 39641.60358396495, 189412.0, 190777.04611476854, 191175.0, 191500.0, 238225.0, 22363.329100127023, 28316.43367132687, 28719.71280287254, 28992.0, 29044.56433153462, 31252.218694532818, 34119.4882076774, 34736.478952815225, 34912.65087349094, 35361.0, 30332.938347157742, 30506.237344066576, 30821.537676935313, 31102.68897310998, 31149.844250778602, 30527.389452211275, 30873.228169295948, 30990.69009309968, 31944.36111277715, 33704.494432583044, 29746.256343590718, 29831.0, 30005.049671771267, 30032.549511756904, 31830.0, 27777.166684999484, 28771.28071798222, 28817.56773648355, 28853.56719649165, 29440.263993400335, 24058.51882962296, 25119.54127894314, 25287.620685689362, 25308.493830122927, 25686.871565642054], "unit": "ms", "name": "ext.html", "value": 16654.668006502197}, {"lowerIsBetter": false, "replicates": [311.8035637548345, 313.3263483510452, 320.9951850722238, 323.43399051659594, 327.1526745728561, 13103.606891793237, 13539.864601353984, 15756.369745210191, 16158.43445479407, 16399.918000409994, 15052.548423547283, 15255.160966146857, 15727.213639318017, 15738.291776870039, 15738.84261157388, 4935.087008903346, 4942.308076869242, 5024.698518088908, 5044.19292913134, 5059.620528460362, 3554.92890142197, 3656.287024030315, 5031.496850314976, 5556.527695145917, 5800.9129863052085, 5747.080467125261, 5833.037548804442, 5847.181394604759, 5860.560457965648, 5891.322497912752, 5545.805896793613, 5614.326280846284, 5625.6905870177125, 5627.268455100811, 5628.099504079348, 4864.537868902448, 4874.025194961022, 4877.926831097537, 4894.657373983787, 4904.754762261909, 19789.505262368413, 19967.0, 20179.89910050455, 20206.89896550508, 20802.063907124215, 1625.5042212125297, 1693.2634304077765, 1803.2027033088682, 1808.9366872159412, 1861.5346163459135, 13533.864661353358, 13762.587122386345, 13880.167189968633, 13907.0, 14226.644333891632, 1767.3902503636225, 1812.4562631210583, 1870.7474490943684, 1876.1557299215272, 1901.9239230430767, 59500.40499594992, 63113.0, 63218.367816321705, 63568.0, 63681.363186368006, 15166.924165379103, 15573.610659733597, 15586.0, 15593.376264949275, 15605.68788624221, 22652.773472265395, 22793.088276468756, 22964.65553016706, 23006.0, 23029.654555181685, 8410.369222308229, 8607.956960215159, 8635.13648635144, 8654.6538138475, 8699.478031318142, 7146.606936618432, 7254.5647261164495, 7267.709291628382, 7275.199728029913, 7292.124945006633, 7519.8120046998165, 7668.194839541768, 7676.884846727304, 7682.654280557388, 7701.768946931601, 2483.6771219741318, 2969.8218106913223, 2974.9553756693667, 3009.3680327131547, 3018.5321275202377, 387.64143167569887, 389.795357437342, 406.8067667857803, 409.5433591545465, 432.34931428200355, 8683.175098365646, 10219.182465402899, 10402.011808878144, 10748.677539673823, 10897.400642964554, 409.6886366361527, 414.34740284052134, 421.67320326747017, 434.07541935676807, 454.62493442909073, 5048.419431765321, 5756.856078598069, 5861.70691465425, 6115.571909966259, 6288.025356069817, 326572.0, 328606.0, 328987.0, 330669.0, 331913.0, 57942.0, 59387.0, 62586.374136258964, 67327.66336168288, 68883.31116688868, 474.3761953031752, 487.1110223841503, 487.16451286044605, 490.0590865538175, 490.0859896293458, 9777.768933420479, 10306.48467576633, 10331.638392656221, 10410.739731506774, 10714.19643526723, 29859.70140298569, 30237.848810755804, 30840.537391939586, 32802.50796238011, 33923.15192120217, 39653.60346396499, 40650.79674601608, 40887.0, 40975.1804963905, 41090.58909410987, 6064.696765161812, 6272.372762723874, 6281.434670879643, 6288.5598008138995, 6289.842753931189, 10997.450127493434, 11161.665150045512, 11383.317000979967, 11426.0, 11460.369679667698, 9615.663451779154, 9932.056454636799, 10063.849042264519, 10283.897161028293, 10289.639862604772, 9764.365316254421, 9874.901250987397, 10010.599576016877, 10010.849837252592, 10246.436445995541, 9717.514124293899, 9750.073742994688, 9761.951190244003, 10028.197744180303, 10206.591736330463, 5627.099664053731, 5762.4525670061275, 6157.415045570664, 6244.188255526752, 6250.187475628321, 9553.331266811534, 9712.902870971482, 9791.118799307811, 10056.949715251378, 10063.0], "unit": "ms", "name": "jquery.html", "value": 7570.210071457062}, {"lowerIsBetter": false, "replicates": [1386.5909556680779, 1507.2463768115942, 1575.9842401575984, 1617.4662361420726, 1677.5135210788865, 6160.291566469858, 6709.66451677416, 6868.244493105754, 6873.759418420356, 6898.3101689831055, 6972.8256793580185, 7080.787576372704, 7081.433485321175, 7088.610126443044, 7091.89362159568, 2048.9999999999964, 2062.1545166481746, 2067.069818581637, 2068.121048554366, 2068.1727309076414, 2086.5305306306036, 2089.9895500522475, 2094.287942099686, 2096.695979083032, 2110.577884423114, 1977.5253939054667, 2010.7888671689482, 2022.1709099269303, 2025.5138766695961, 2027.5032617008853, 1996.870203436772, 1997.1811557261526, 2003.2988454041115, 2003.378952524722, 2009.5378063045434, 1994.8603597748163, 2019.182231196353, 2019.7576290845193, 2020.0808632072371, 2028.381343690174, 5874.265716785402, 6024.186734790791, 6947.7220911163495, 6977.95330700394, 6981.965090174567, 4056.7971601420104, 4177.436046133764, 4178.26880295947, 4185.351270553069, 4190.832366705328, 2708.79684023699, 2738.3838636306873, 2773.0571605654172, 2774.3618967637353, 2795.3850152966315, 820.4707963363657, 831.1231650608605, 834.4659417972442, 840.2060053249681, 855.5935930433056, 9452.385594936308, 9521.666741664008, 9537.952310238474, 9543.04569543047, 9561.665341713007, 3868.63247991446, 3885.825137868803, 3914.2171565686976, 3916.667083297895, 3936.15372694872, 8286.875696864552, 8292.2951549119, 8300.543470109082, 8305.916940830635, 8311.002679678477, 4118.094019315746, 4149.647279981175, 4149.792510374469, 4151.066010147753, 4154.397612346193, 3730.850765969331, 3751.5685696144747, 3755.8122093895195, 3757.342465068602, 3757.962420375816, 3261.3151238240234, 3270.427675156838, 3281.1961069538115, 3309.420851351004, 3311.966880331214, 1020.6631811502186, 1036.3471013261596, 1039.6725031615017, 1055.5724931402794, 1056.587930707025, 869.143893265146, 881.6429346114834, 1152.7463957929242, 1170.0990237517065, 1170.987096161814, 6593.86812263752, 6598.7030583623855, 6629.204495460479, 6666.699998500079, 6667.899981500282, 1019.3527110284874, 1028.9125424338865, 1061.7557961668706, 1065.9840102398316, 1066.6906597086913, 4914.385701787277, 5323.574114070865, 5372.758225879845, 5391.056565101092, 5391.460853914656, 7127.429805615642, 8075.83848323042, 8177.591120443954, 8277.62750676221, 8301.6679332826, 8089.110197878229, 8131.349492040741, 8149.0, 8185.976752905886, 8198.590070496452, 6404.071409645575, 6565.080888675685, 6628.304028077079, 6630.834229144213, 6642.136522252173, 6676.465882729467, 6726.8990965136545, 6732.225794033749, 6737.461003119641, 6740.797776066725, 7126.251743566851, 7307.3058059484265, 7438.590877501573, 7448.73929412468, 7453.40372770188, 7647.38820894316, 7863.0, 7881.448298619041, 7983.920160798318, 7988.760337189894, 5565.693886836263, 5735.655860648374, 5744.425557444222, 5817.621854579439, 5868.061110222344, 6653.5009874260595, 6706.5640733352175, 6706.798796036127, 6711.63086030273, 6718.395344419026, 6122.693865306628, 6149.354317796567, 6275.435210830865, 6329.461995730415, 6339.461145802658, 6191.349908259748, 6192.164057852132, 6217.253929528486, 6325.525585581007, 6348.174737284124, 6105.236845394325, 6144.201253836973, 6163.476104531165, 6174.598651087665, 6176.876462470816, 5781.161731548986, 5810.186573879576, 5824.068149096124, 5824.854378640568, 5832.475077242899, 5941.643501389931, 6014.6391216527145, 6021.126936594082, 6026.548008899438, 6029.125776762257], "unit": "ms", "name": "mootools.html", "value": 4017.976494260844}, {"lowerIsBetter": false, "replicates": [292.62543943751996, 295.75304620641765, 297.52247642533735, 303.1678043769851, 304.788172220307, 5283.735813209339, 5333.146696528556, 5354.866128346794, 5403.135498320269, 5453.045716999519, 5308.469153084689, 5365.919511207335, 5369.62412631116, 5374.48942350476, 5388.811391601294, 3903.8243279052367, 4123.36087906375, 4129.6076872697195, 4131.4629098217265, 4137.855175068873, 4017.3973903914352, 4028.154087641599, 4108.322126849066, 4110.1163249901265, 4145.854895078673, 4060.817263223147, 4065.6340929316357, 4093.22228776533, 4096.631303182713, 4104.692148088905, 3844.5386553613744, 3926.5484469285825, 3967.940480892789, 4099.692523060768, 4108.301588729938, 3561.5904171020406, 3566.5363502744735, 3571.714262858965, 3572.214112895185, 3579.1231148368556, 5130.127878260705, 5144.0740666679985, 5144.742762861842, 5145.073886700392, 5152.871178220575, 4698.976505117453, 4699.060187962421, 4702.27114797207, 4708.0819240248165, 4711.528847115295, 5503.514041296154, 5569.498745112919, 5605.047141985831, 5609.719514024323, 5612.915806262909, 3880.825362858678, 3884.0484081400236, 3889.8833035008997, 3892.443022790878, 3895.045713800109, 5833.270841144857, 5904.439078287556, 5905.055191169392, 5908.586398952075, 5913.231279933581, 3986.1031267965054, 3990.3016972029777, 3991.1219531702977, 3992.540857801332, 3996.360582306817, 3902.707296952683, 4045.3122969095325, 4048.514178298623, 4050.716449848482, 4056.087380339459, 4656.208444564432, 4659.976700116477, 4661.976690116596, 4665.113628410591, 4665.370175026328, 5601.7759289628775, 5616.326040875121, 5617.0, 5623.550115990793, 5628.493435590734, 1413.738458385202, 1428.6714055767231, 1430.0990376063014, 1430.2205298112553, 1432.3769160415045, 945.6926498887751, 948.6537413844035, 949.1457688080644, 972.4845831709206, 975.1759763000254, 4938.2839488274, 4942.283368911488, 4950.18321976877, 4950.331705219821, 4951.10880041596, 5827.3298570664065, 5832.504237139806, 5834.737436815353, 5837.0, 5838.065909454467, 4923.532264434873, 4928.088303663833, 4929.75351232437, 4942.456329803791, 4944.381952255968, 3066.8466576671076, 3119.422906762211, 3154.2587491939375, 3155.4162479941283, 3157.0, 5540.2243685884005, 5564.387917329091, 5606.21512988182, 5608.411116832755, 5609.943900560942, 6075.908861367083, 6081.6351018939, 6088.086786981989, 6089.238845144357, 6092.0, 5582.860428489239, 5602.355729091207, 5605.159226116034, 5605.24329215567, 5607.271054762855, 5681.261436013292, 5887.264091988502, 5896.086106653475, 5897.469227769521, 5898.734556944862, 5749.425057494217, 5753.5109515689965, 5755.482006619424, 5757.0788673811985, 5758.769649213985, 5567.47109024642, 5574.275344205227, 5580.414056524169, 5583.916241256303, 5593.300837395325, 3923.450716899579, 3955.149642826806, 3976.900577485586, 4013.257547353749, 4014.9598504015753, 5834.7082645866685, 5863.413658634103, 5867.589268751147, 5867.589268751147, 5868.149118377897, 5620.831375058755, 5626.156076588544, 5633.521150702236, 5643.068893632505, 5660.20757093999, 5528.9723551383595, 5644.209810626434, 5653.925754106706, 5655.293088363955, 5666.150077488245, 5514.420985796433, 5514.503694667499, 5515.448455154453, 5529.612927095065, 5542.61201715876, 5354.705491198021, 5489.862753431196, 5692.601517893708, 5694.4590263924865, 5697.0, 5403.675779453245, 5414.052540805422, 5446.564274857923, 5461.590380721541, 5462.3445186577865], "unit": "ms", "name": "prototype.html", "value": 4208.512817732408}, {"lowerIsBetter": false, "replicates": [641.4002907281692, 694.0491526608547, 716.8924661300804, 768.8193274580474, 793.8967934168559, 11380.487878045487, 11584.942075289611, 11596.884031159685, 11600.3039817611, 11617.0, 11794.40775495308, 11900.880991190086, 11922.880771192285, 11948.940255298712, 11950.64148075557, 496.74417674897364, 506.7415618034792, 776.3013288040752, 782.4249176855006, 784.1491981200376, 773.4663082473104, 774.8798936164903, 775.2518819339336, 776.2935728487078, 795.7732046366787, 607.4623957797359, 608.9299730531002, 807.2129673568282, 812.1513018895239, 823.5100115431309, 805.7582725182481, 806.0609390060572, 807.7011505742854, 812.2649002652608, 812.7399232245684, 598.512212546773, 598.9011813050842, 599.241958921964, 610.8014895159091, 617.8826023055605, 11036.172287078422, 11155.38645374504, 11172.273802202912, 11178.0, 11196.608118715887, 10596.0, 11250.887491125066, 11356.772864542745, 11581.536738530449, 11588.13089018327, 8871.112888711143, 8908.198262156437, 8929.24101451371, 8951.373403861733, 8967.0, 3112.501999680063, 3126.906192814219, 3156.1478400831875, 3164.7942883712717, 3171.0, 38433.23133537341, 38580.22839543221, 38823.8058809707, 38998.80500597479, 39021.219575608615, 8208.46644968075, 8295.294899933573, 8311.542865142475, 8332.250097491255, 8355.331573474108, 15562.688746225012, 15689.764653530206, 15704.764428533581, 15707.68584628301, 15716.68566628684, 5865.472107510344, 5919.260092488439, 5953.672548009815, 6112.541559383064, 6222.62664240138, 3284.819334936554, 3438.6045604755273, 3467.8612855486003, 3520.0495866116007, 3556.48430977512, 2607.58278675411, 2664.014314703572, 2671.385581316308, 2675.5986602009853, 2687.314734742628, 415.8918681142864, 416.1905094591052, 416.8811888611731, 418.2930846868782, 419.6999145610903, 528.5612941258746, 532.8454748123, 541.3638974205293, 541.7589172818058, 550.1610044681812, 7183.856322873513, 7241.927580724126, 7272.709091636381, 7331.486795924341, 7827.921720782833, 357.9069441945061, 446.11891514259725, 491.5477760460385, 517.9715115668674, 566.8526183192399, 3325.1687078230443, 3365.2932884094125, 3401.6428275031262, 3421.8289085545625, 3523.6300188480354, 47789.52210477851, 47915.0, 48198.5180148201, 48312.7584362083, 48386.27420588694, 36809.0, 37538.43692344617, 38017.42973855395, 39030.6096939027, 39191.21617567632, 35306.82346588302, 38445.807770961525, 38605.806970965525, 38615.2276954465, 38868.416973745414, 7231.746888858865, 7834.0, 7874.803129921569, 7955.323797477279, 8112.959435202786, 29330.120096397142, 29499.0, 30012.549811753277, 30448.543271851384, 30603.0, 37086.44370334501, 37175.81412092922, 37839.05402364963, 37925.24149517049, 37980.0, 6717.294684058299, 6758.167984484481, 6848.212455567674, 6902.654867256718, 7022.157341118894, 10521.421321827373, 10542.051215390651, 10702.411367374869, 10937.234393592373, 11044.282121662067, 9050.321225908216, 9091.818163636823, 9443.055694430777, 9637.469939153414, 9640.0, 9696.127348538665, 9703.854442183232, 10250.743731406475, 10320.896791031993, 10592.311499752492, 9311.953440232755, 9472.289578281794, 9663.855042174233, 9687.225021998363, 9728.708138755848, 7888.2506161914525, 8063.153368896416, 8345.54099524532, 8458.957705211435, 8554.144585541397, 8744.825103497767, 8882.245009174034, 8887.822243554963, 8948.821023579361, 9022.958350246048], "unit": "ms", "name": "yui.html", "value": 5334.379446274637}], "name": "dromaeo_css", "value": 6129.58414159744}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 108.0, 114.0, 113.0, 114.0, 103.0, 112.0, 104.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 153.0, 169.0, 131.0, 164.0, 155.0, 133.0, 172.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 164.0, 163.0, 162.0, 161.0, 164.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 85.0, 97.0, 73.0, 73.0, 74.0, 118.0, 88.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 134.0, 92.0, 93.0, 92.0, 127.0, 92.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 104.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 148.0, 147.0, 151.0, 147.0, 148.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 67.0, 76.0, 66.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 68.1}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 83.0, 85.0, 82.0, 83.0, 83.0, 84.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [130.0, 123.0, 134.0, 121.0, 133.0, 121.0, 132.0, 122.0, 119.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [150.0, 139.0, 151.0, 150.0, 152.0, 140.0, 149.0, 148.0, 150.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 71.0, 72.0, 69.0, 70.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1524.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.23463317911435], "unit": "score", "name": "Richards", "value": 213.64770399999995}, {"lowerIsBetter": false, "replicates": [185.59762435040832], "unit": "score", "name": "DeltaBlue", "value": 356.2437839999999}, {"lowerIsBetter": false, "replicates": [281.7695125387433], "unit": "score", "name": "Encrypt", "value": 944.6763689999997}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [622.360248447205], "unit": "score", "name": "Splay", "value": 130.9386327345309}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19837.973158784338}]} 07:50:26 INFO - RETURN: dromaeo_css: 6129.59 07:50:26 INFO - RETURN: kraken: 1525.00 07:50:26 INFO - RETURN: v8_7: 19837.97 07:50:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19837.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1525.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6129.59"}}} 07:50:26 INFO - Return code: 0 07:50:26 INFO - # TBPL SUCCESS # 07:50:26 INFO - Running post-action listener: _resource_record_post_action 07:50:26 INFO - Running post-run listener: _resource_record_post_run 07:50:27 INFO - Total resource usage - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504131584; Read time: 12; Write time: 1004828 07:50:27 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 230608896; Read time: 0; Write time: 661860 07:50:27 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273522688; Read time: 12; Write time: 342968 07:50:27 INFO - Running post-run listener: _upload_blobber_files 07:50:27 INFO - Blob upload gear active. 07:50:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:50:27 INFO - Copying logs to upload dir... 07:50:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1309.731997 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2015-11-19 07:50:27.077452) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:50:27.081544) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/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-19 07:50:27.132486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:50:27.132804) ========= 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-1447946285.804850-1359038299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:50:27.181948) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:50:27.182282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:50:27.182602) ========= ========= Total master_lag: 0.30 =========