builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1448411973.33 results: success (0) buildid: 20151124161231 builduid: 439540b90c354e98b669fc05c2cb9f0b revision: e84368c1f7b7c61f28f60365b64a70fdf3465c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.325535) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.325954) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.326477) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006535 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.351786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.352172) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.410705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.410982) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.470031) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.470522) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.470874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.471174) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 16:39:33-- 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% 40.9M=0s 2015-11-24 16:39:33 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177279 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.674289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.674596) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014800 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:33.728709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 16:39:33.729019) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e84368c1f7b7c61f28f60365b64a70fdf3465c08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e84368c1f7b7c61f28f60365b64a70fdf3465c08 --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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 16:39:33,930 truncating revision to first 12 chars 2015-11-24 16:39:33,930 Setting DEBUG logging. 2015-11-24 16:39:33,930 attempt 1/10 2015-11-24 16:39:33,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e84368c1f7b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 16:39:34,383 unpacking tar archive at: fx-team-e84368c1f7b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 16:39:34.840507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:34.840819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:34.850787) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:34.851121) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 16:39:34.851681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-24 16:39:34.851994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:39:35 INFO - MultiFileLogger online at 20151124 16:39:35 in /builds/slave/test 16:39:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:39:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:35 INFO - {'append_to_log': False, 16:39:35 INFO - 'base_work_dir': '/builds/slave/test', 16:39:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:39:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:35 INFO - 'branch': 'Fx-Team-Non-PGO', 16:39:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:35 INFO - 'config_files': ('talos/linux_config.py',), 16:39:35 INFO - 'default_actions': ('clobber', 16:39:35 INFO - 'read-buildbot-config', 16:39:35 INFO - 'download-and-extract', 16:39:35 INFO - 'populate-webroot', 16:39:35 INFO - 'create-virtualenv', 16:39:35 INFO - 'install', 16:39:35 INFO - 'run-tests'), 16:39:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:35 INFO - 'download_minidump_stackwalk': True, 16:39:35 INFO - 'download_symbols': 'ondemand', 16:39:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:35 INFO - 'installer_path': 'installer.exe', 16:39:35 INFO - 'log_level': 'info', 16:39:35 INFO - 'log_name': 'talos', 16:39:35 INFO - 'log_to_console': True, 16:39:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:39:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:39:35 INFO - 'opt_config_files': (), 16:39:35 INFO - 'pip_index': False, 16:39:35 INFO - 'sps_profile': False, 16:39:35 INFO - 'sps_profile_interval': 0, 16:39:35 INFO - 'suite': 'dromaeojs', 16:39:35 INFO - 'system_bits': '64', 16:39:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:35 INFO - 'title': 'talos-linux64-ix-055', 16:39:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:35 INFO - 'use_talos_json': True, 16:39:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:35 INFO - 'work_dir': 'build'} 16:39:35 INFO - ##### 16:39:35 INFO - ##### Running clobber step. 16:39:35 INFO - ##### 16:39:35 INFO - Running pre-action listener: _resource_record_pre_action 16:39:35 INFO - Running main action method: clobber 16:39:35 INFO - rmtree: /builds/slave/test/build 16:39:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:35 INFO - Running post-action listener: _resource_record_post_action 16:39:35 INFO - ##### 16:39:35 INFO - ##### Running read-buildbot-config step. 16:39:35 INFO - ##### 16:39:35 INFO - Running pre-action listener: _resource_record_pre_action 16:39:35 INFO - Running main action method: read_buildbot_config 16:39:35 INFO - Using buildbot properties: 16:39:35 INFO - { 16:39:35 INFO - "properties": { 16:39:35 INFO - "buildnumber": 919, 16:39:35 INFO - "product": "firefox", 16:39:35 INFO - "script_repo_revision": "production", 16:39:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:39:35 INFO - "repository": "", 16:39:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:39:35 INFO - "buildid": "20151124161231", 16:39:35 INFO - "slavename": "talos-linux64-ix-055", 16:39:35 INFO - "pgo_build": "False", 16:39:35 INFO - "basedir": "/builds/slave/test", 16:39:35 INFO - "project": "", 16:39:35 INFO - "platform": "ubuntu64_hw", 16:39:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:39:35 INFO - "slavebuilddir": "test", 16:39:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:39:35 INFO - "branch": "fx-team", 16:39:35 INFO - "repo_path": "integration/fx-team", 16:39:35 INFO - "stage_platform": "linux64", 16:39:35 INFO - "builduid": "439540b90c354e98b669fc05c2cb9f0b", 16:39:35 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 16:39:35 INFO - }, 16:39:35 INFO - "sourcestamp": { 16:39:35 INFO - "repository": "", 16:39:35 INFO - "hasPatch": false, 16:39:35 INFO - "project": "", 16:39:35 INFO - "branch": "fx-team-linux64-talos", 16:39:35 INFO - "changes": [ 16:39:35 INFO - { 16:39:35 INFO - "category": null, 16:39:35 INFO - "files": [ 16:39:35 INFO - { 16:39:35 INFO - "url": null, 16:39:35 INFO - "name": "https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:39:35 INFO - } 16:39:35 INFO - ], 16:39:35 INFO - "repository": "", 16:39:35 INFO - "rev": "e84368c1f7b7c61f28f60365b64a70fdf3465c08", 16:39:35 INFO - "who": "mdeboer@mozilla.com", 16:39:35 INFO - "when": 1448411936, 16:39:35 INFO - "number": 6702611, 16:39:35 INFO - "comments": "Bug 1227526: Wait for the feedback page to be opened, before closing the window. r=Standard8", 16:39:35 INFO - "project": "", 16:39:35 INFO - "at": "Tue 24 Nov 2015 16:38:56", 16:39:35 INFO - "branch": "fx-team-linux64-talos", 16:39:35 INFO - "revlink": "", 16:39:35 INFO - "properties": [ 16:39:35 INFO - [ 16:39:35 INFO - "buildid", 16:39:35 INFO - "20151124161231", 16:39:35 INFO - "Change" 16:39:35 INFO - ], 16:39:35 INFO - [ 16:39:35 INFO - "builduid", 16:39:35 INFO - "439540b90c354e98b669fc05c2cb9f0b", 16:39:35 INFO - "Change" 16:39:35 INFO - ], 16:39:35 INFO - [ 16:39:35 INFO - "pgo_build", 16:39:35 INFO - "False", 16:39:35 INFO - "Change" 16:39:35 INFO - ] 16:39:35 INFO - ], 16:39:35 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 16:39:35 INFO - } 16:39:35 INFO - ], 16:39:35 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 16:39:35 INFO - } 16:39:35 INFO - } 16:39:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:39:35 INFO - Running post-action listener: _resource_record_post_action 16:39:35 INFO - ##### 16:39:35 INFO - ##### Running download-and-extract step. 16:39:35 INFO - ##### 16:39:35 INFO - Running pre-action listener: _resource_record_pre_action 16:39:35 INFO - Running main action method: download_and_extract 16:39:35 INFO - mkdir: /builds/slave/test/build/tests 16:39:35 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')]} 16:39:35 INFO - https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/test_packages.json 16:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/test_packages.json 16:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:39:39 INFO - Downloaded 1302 bytes. 16:39:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:39:39 INFO - Using the following test package requirements: 16:39:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:39:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:39:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'jsshell-linux-x86_64.zip'], 16:39:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:39:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:39:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:39:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:39:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:39:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:39:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:39:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:39:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:39: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')]} 16:39:39 INFO - https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:42 INFO - Downloaded 21342009 bytes. 16:39:42 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 16:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:42 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 16:39:43 INFO - Return code: 0 16:39:43 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 16:39:43 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')]} 16:39:43 INFO - https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:39:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:45 INFO - Downloaded 21342009 bytes. 16:39:45 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 16:39:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:39:45 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 16:39:46 INFO - Return code: 0 16:39: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')]} 16:39:46 INFO - https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:47 INFO - Downloaded 11130997 bytes. 16:39:47 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 16:39:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:39:47 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 16:39:47 INFO - Return code: 0 16:39:47 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')]} 16:39:47 INFO - https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_-V1y_UZT7-yis37amYgmw/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 16:39:49 INFO - Downloaded 56071036 bytes. 16:39:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:39:49 INFO - mkdir: /builds/slave/test/properties 16:39:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:49 INFO - Contents: 16:39:49 INFO - build_url:https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:39:49 INFO - Running post-action listener: _resource_record_post_action 16:39:49 INFO - Running post-action listener: set_extra_try_arguments 16:39:49 INFO - ##### 16:39:49 INFO - ##### Running populate-webroot step. 16:39:49 INFO - ##### 16:39:49 INFO - Running pre-action listener: _resource_record_pre_action 16:39:49 INFO - Running main action method: populate_webroot 16:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:39:49 INFO - '../fennec_ids.txt'], 16:39:49 INFO - 'tests': ['tcheck2']}, 16:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:49 INFO - '--tppagecycles', 16:39:49 INFO - '7'], 16:39:49 INFO - 'tests': ['tsvgm']}}, 16:39:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:39:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:39:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:39:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'tests': ['damp', 'tps']}, 16:39:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['damp', 'tps']}, 16:39:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:49 INFO - 'other': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'other_l64': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'other_nol64': {'tests': ['a11yr', 16:39:49 INFO - 'ts_paint', 16:39:49 INFO - 'tpaint', 16:39:49 INFO - 'sessionrestore', 16:39:49 INFO - 'sessionrestore_no_auto_restore']}, 16:39:49 INFO - 'svgr': {'tests': ['tsvgx', 16:39:49 INFO - 'tsvgr_opacity', 16:39:49 INFO - 'tart', 16:39:49 INFO - 'tscrollx', 16:39:49 INFO - 'cart']}, 16:39:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['tsvgx', 16:39:49 INFO - 'tsvgr_opacity', 16:39:49 INFO - 'tart', 16:39:49 INFO - 'tscrollx', 16:39:49 INFO - 'cart']}, 16:39:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'tests': ['tp5o']}, 16:39:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'talos_options': ['--e10s'], 16:39:49 INFO - 'tests': ['tp5o']}, 16:39:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'talos_options': ['--xperf_path', 16:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:49 INFO - 'tests': ['tp5n']}, 16:39:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:49 INFO - 'talos_options': ['--e10s', 16:39:49 INFO - '--xperf_path', 16:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:49 INFO - 'tests': ['tp5n']}}, 16:39:49 INFO - 'talos.zip': {'path': '', 16:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:49 INFO - Running post-action listener: _resource_record_post_action 16:39:49 INFO - ##### 16:39:49 INFO - ##### Running create-virtualenv step. 16:39:49 INFO - ##### 16:39:49 INFO - Running pre-action listener: _resource_record_pre_action 16:39:49 INFO - Running main action method: create_virtualenv 16:39:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:49 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 16:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:49 INFO - Using real prefix '/usr' 16:39:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:51 INFO - Installing pip.................done. 16:39:51 INFO - Return code: 0 16:39:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:51 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')]} 16:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 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')]} 16:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:39:51 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 16:39:51 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 16:39:51 INFO - Using env: {'DISPLAY': ':0', 16:39:51 INFO - 'HOME': '/home/cltbld', 16:39:51 INFO - 'LANG': 'en_US.UTF-8', 16:39:51 INFO - 'LANGUAGE': 'en_US:en', 16:39:51 INFO - 'LOGNAME': 'cltbld', 16:39:51 INFO - 'MAIL': '/var/mail/cltbld', 16:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:51 INFO - 'MOZ_NO_REMOTE': '1', 16:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:51 INFO - 'NO_EM_RESTART': '1', 16:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:51 INFO - 'PWD': '/builds/slave/test', 16:39:51 INFO - 'SHELL': '/bin/bash', 16:39:51 INFO - 'SHLVL': '1', 16:39:51 INFO - 'TERM': 'linux', 16:39:51 INFO - 'TMOUT': '86400', 16:39:51 INFO - 'USER': 'cltbld', 16:39:51 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:51 INFO - '_': '/tools/buildbot/bin/python'} 16:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:52 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 16:39:52 INFO - Cleaning up... 16:39:52 INFO - Return code: 0 16:39:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:52 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:39:52 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 16:39:52 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 16:39:52 INFO - Using env: {'DISPLAY': ':0', 16:39:52 INFO - 'HOME': '/home/cltbld', 16:39:52 INFO - 'LANG': 'en_US.UTF-8', 16:39:52 INFO - 'LANGUAGE': 'en_US:en', 16:39:52 INFO - 'LOGNAME': 'cltbld', 16:39:52 INFO - 'MAIL': '/var/mail/cltbld', 16:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:52 INFO - 'MOZ_NO_REMOTE': '1', 16:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:52 INFO - 'NO_EM_RESTART': '1', 16:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:52 INFO - 'PWD': '/builds/slave/test', 16:39:52 INFO - 'SHELL': '/bin/bash', 16:39:52 INFO - 'SHLVL': '1', 16:39:52 INFO - 'TERM': 'linux', 16:39:52 INFO - 'TMOUT': '86400', 16:39:52 INFO - 'USER': 'cltbld', 16:39:52 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:52 INFO - '_': '/tools/buildbot/bin/python'} 16:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:52 INFO - Downloading/unpacking psutil>=0.7.1 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:52 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 16:39:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:39:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:54 INFO - Installing collected packages: psutil 16:39:54 INFO - Running setup.py install for psutil 16:39:54 INFO - building 'psutil._psutil_linux' extension 16:39:54 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 16:39:54 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 16:39:54 INFO - building 'psutil._psutil_posix' extension 16:39:54 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 16:39:54 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 16:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:54 INFO - Successfully installed psutil 16:39:54 INFO - Cleaning up... 16:39:54 INFO - Return code: 0 16:39:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:39: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')]} 16:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:54 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:39:54 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 16:39:54 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 16:39:54 INFO - Using env: {'DISPLAY': ':0', 16:39:54 INFO - 'HOME': '/home/cltbld', 16:39:54 INFO - 'LANG': 'en_US.UTF-8', 16:39:54 INFO - 'LANGUAGE': 'en_US:en', 16:39:54 INFO - 'LOGNAME': 'cltbld', 16:39:54 INFO - 'MAIL': '/var/mail/cltbld', 16:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:54 INFO - 'MOZ_NO_REMOTE': '1', 16:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:54 INFO - 'NO_EM_RESTART': '1', 16:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:54 INFO - 'PWD': '/builds/slave/test', 16:39:54 INFO - 'SHELL': '/bin/bash', 16:39:54 INFO - 'SHLVL': '1', 16:39:54 INFO - 'TERM': 'linux', 16:39:54 INFO - 'TMOUT': '86400', 16:39:54 INFO - 'USER': 'cltbld', 16:39:54 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:54 INFO - '_': '/tools/buildbot/bin/python'} 16:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:39:54 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 16:39:54 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 16:39:54 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 16:39:54 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 16:39:54 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 16:39:54 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 16:39:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:39:56 INFO - Installing collected packages: mozsystemmonitor 16:39:56 INFO - Running setup.py install for mozsystemmonitor 16:39:56 INFO - Successfully installed mozsystemmonitor 16:39:56 INFO - Cleaning up... 16:39:56 INFO - Return code: 0 16:39:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:39:56 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')]} 16:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:56 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')]} 16:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:56 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:39:56 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 16:39:56 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 16:39:56 INFO - Using env: {'DISPLAY': ':0', 16:39:56 INFO - 'HOME': '/home/cltbld', 16:39:56 INFO - 'LANG': 'en_US.UTF-8', 16:39:56 INFO - 'LANGUAGE': 'en_US:en', 16:39:56 INFO - 'LOGNAME': 'cltbld', 16:39:56 INFO - 'MAIL': '/var/mail/cltbld', 16:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:56 INFO - 'MOZ_NO_REMOTE': '1', 16:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:56 INFO - 'NO_EM_RESTART': '1', 16:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:56 INFO - 'PWD': '/builds/slave/test', 16:39:56 INFO - 'SHELL': '/bin/bash', 16:39:56 INFO - 'SHLVL': '1', 16:39:56 INFO - 'TERM': 'linux', 16:39:56 INFO - 'TMOUT': '86400', 16:39:56 INFO - 'USER': 'cltbld', 16:39:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:56 INFO - '_': '/tools/buildbot/bin/python'} 16:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:39:56 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 16:39:56 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 16:39:56 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 16:39:56 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 16:39:56 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 16:39:56 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 16:39:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:39:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:39:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:59 INFO - Downloading docopt-0.6.1.tar.gz 16:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:39:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:39:59 INFO - Running setup.py install for blobuploader 16:39:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:39:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:39:59 INFO - Running setup.py install for requests 16:39:59 INFO - Running setup.py install for docopt 16:39:59 INFO - Successfully installed blobuploader requests docopt 16:39:59 INFO - Cleaning up... 16:40:00 INFO - Return code: 0 16:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:40:00 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 16:40:00 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 16:40:00 INFO - Using env: {'DISPLAY': ':0', 16:40:00 INFO - 'HOME': '/home/cltbld', 16:40:00 INFO - 'LANG': 'en_US.UTF-8', 16:40:00 INFO - 'LANGUAGE': 'en_US:en', 16:40:00 INFO - 'LOGNAME': 'cltbld', 16:40:00 INFO - 'MAIL': '/var/mail/cltbld', 16:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:00 INFO - 'MOZ_NO_REMOTE': '1', 16:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:00 INFO - 'NO_EM_RESTART': '1', 16:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:00 INFO - 'PWD': '/builds/slave/test', 16:40:00 INFO - 'SHELL': '/bin/bash', 16:40:00 INFO - 'SHLVL': '1', 16:40:00 INFO - 'TERM': 'linux', 16:40:00 INFO - 'TMOUT': '86400', 16:40:00 INFO - 'USER': 'cltbld', 16:40:00 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:00 INFO - '_': '/tools/buildbot/bin/python'} 16:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:00 INFO - Running setup.py (path:/tmp/pip-NElZgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:00 INFO - Running setup.py (path:/tmp/pip-WALg49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:00 INFO - Running setup.py (path:/tmp/pip-odFs9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:00 INFO - Running setup.py (path:/tmp/pip-Oz8LOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:00 INFO - Running setup.py (path:/tmp/pip-2v2yh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:00 INFO - Running setup.py (path:/tmp/pip-MwsT9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:00 INFO - Running setup.py (path:/tmp/pip-1tH7Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:00 INFO - Running setup.py (path:/tmp/pip-eqnmtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:00 INFO - Running setup.py (path:/tmp/pip-u6hEB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:00 INFO - Running setup.py (path:/tmp/pip-CJkb2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:00 INFO - Running setup.py (path:/tmp/pip-2k0YaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:01 INFO - Running setup.py (path:/tmp/pip-0J_Y9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:01 INFO - Running setup.py (path:/tmp/pip-blIxdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:01 INFO - Running setup.py (path:/tmp/pip-_Ii9BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:01 INFO - Running setup.py (path:/tmp/pip-hflxoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:01 INFO - Running setup.py (path:/tmp/pip-0z9smO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:01 INFO - Running setup.py (path:/tmp/pip-B6_cWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:01 INFO - Running setup.py install for manifestparser 16:40:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:40:01 INFO - Running setup.py install for mozcrash 16:40:01 INFO - Running setup.py install for mozdebug 16:40:01 INFO - Running setup.py install for mozdevice 16:40:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:40:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:40:01 INFO - Running setup.py install for mozfile 16:40:02 INFO - Running setup.py install for mozhttpd 16:40:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozinfo 16:40:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozInstall 16:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozleak 16:40:02 INFO - Running setup.py install for mozlog 16:40:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for moznetwork 16:40:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozprocess 16:40:02 INFO - Running setup.py install for mozprofile 16:40:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozrunner 16:40:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:40:02 INFO - Running setup.py install for mozscreenshot 16:40:03 INFO - Running setup.py install for moztest 16:40:03 INFO - Running setup.py install for mozversion 16:40:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:40:03 INFO - Cleaning up... 16:40:03 INFO - Return code: 0 16:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:03 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')]} 16:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:03 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')]} 16:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:03 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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:40:03 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 16:40:03 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 16:40:03 INFO - Using env: {'DISPLAY': ':0', 16:40:03 INFO - 'HOME': '/home/cltbld', 16:40:03 INFO - 'LANG': 'en_US.UTF-8', 16:40:03 INFO - 'LANGUAGE': 'en_US:en', 16:40:03 INFO - 'LOGNAME': 'cltbld', 16:40:03 INFO - 'MAIL': '/var/mail/cltbld', 16:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:03 INFO - 'MOZ_NO_REMOTE': '1', 16:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:03 INFO - 'NO_EM_RESTART': '1', 16:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:03 INFO - 'PWD': '/builds/slave/test', 16:40:03 INFO - 'SHELL': '/bin/bash', 16:40:03 INFO - 'SHLVL': '1', 16:40:03 INFO - 'TERM': 'linux', 16:40:03 INFO - 'TMOUT': '86400', 16:40:03 INFO - 'USER': 'cltbld', 16:40:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:03 INFO - '_': '/tools/buildbot/bin/python'} 16:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:03 INFO - Running setup.py (path:/tmp/pip-vwm8qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:03 INFO - Running setup.py (path:/tmp/pip-CYpdFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:03 INFO - Running setup.py (path:/tmp/pip-8HHLRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:03 INFO - Running setup.py (path:/tmp/pip-jfgIbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:03 INFO - Running setup.py (path:/tmp/pip-FmAYCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:03 INFO - Running setup.py (path:/tmp/pip-K0PsD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:03 INFO - Running setup.py (path:/tmp/pip-wiQVwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:03 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)) 16:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:03 INFO - Running setup.py (path:/tmp/pip-d0K2iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:04 INFO - Running setup.py (path:/tmp/pip-416Gg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:04 INFO - Running setup.py (path:/tmp/pip-fDaS3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:04 INFO - Running setup.py (path:/tmp/pip-HsXyOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:04 INFO - Running setup.py (path:/tmp/pip-5wFWye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:04 INFO - Running setup.py (path:/tmp/pip-NVU4tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:04 INFO - Running setup.py (path:/tmp/pip-Rwh4Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:04 INFO - Running setup.py (path:/tmp/pip-36JOSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:04 INFO - Running setup.py (path:/tmp/pip-5arhTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:04 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)) 16:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:04 INFO - Running setup.py (path:/tmp/pip-FiqcEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:04 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)) 16:40:04 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)) 16:40:04 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)) 16:40:04 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)) 16:40:04 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)) 16:40:04 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)) 16:40:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:06 INFO - Downloading blessings-1.5.1.tar.gz 16:40:06 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 16:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:40:06 INFO - Installing collected packages: blessings 16:40:06 INFO - Running setup.py install for blessings 16:40:06 INFO - Successfully installed blessings 16:40:06 INFO - Cleaning up... 16:40:06 INFO - Return code: 0 16:40:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:40:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:06 INFO - Reading from file tmpfile_stdout 16:40:06 INFO - Current package versions: 16:40:06 INFO - argparse == 1.2.1 16:40:06 INFO - blessings == 1.5.1 16:40:06 INFO - blobuploader == 1.2.4 16:40:06 INFO - docopt == 0.6.1 16:40:06 INFO - manifestparser == 1.1 16:40:06 INFO - mozInstall == 1.12 16:40:06 INFO - mozcrash == 0.16 16:40:06 INFO - mozdebug == 0.1 16:40:06 INFO - mozdevice == 0.47 16:40:06 INFO - mozfile == 1.2 16:40:06 INFO - mozhttpd == 0.7 16:40:06 INFO - mozinfo == 0.9 16:40:06 INFO - mozleak == 0.1 16:40:06 INFO - mozlog == 3.1 16:40:06 INFO - moznetwork == 0.27 16:40:06 INFO - mozprocess == 0.22 16:40:06 INFO - mozprofile == 0.27 16:40:06 INFO - mozrunner == 6.11 16:40:06 INFO - mozscreenshot == 0.1 16:40:06 INFO - mozsystemmonitor == 0.0 16:40:06 INFO - moztest == 0.7 16:40:06 INFO - mozversion == 1.4 16:40:06 INFO - psutil == 3.1.1 16:40:06 INFO - requests == 1.2.3 16:40:06 INFO - wsgiref == 0.1.2 16:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4007de5c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2576900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, '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': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', '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 16:40:06 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 16:40:06 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 16:40:06 INFO - Using env: {'DISPLAY': ':0', 16:40:06 INFO - 'HOME': '/home/cltbld', 16:40:06 INFO - 'LANG': 'en_US.UTF-8', 16:40:06 INFO - 'LANGUAGE': 'en_US:en', 16:40:06 INFO - 'LOGNAME': 'cltbld', 16:40:06 INFO - 'MAIL': '/var/mail/cltbld', 16:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:06 INFO - 'MOZ_NO_REMOTE': '1', 16:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:06 INFO - 'NO_EM_RESTART': '1', 16:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:06 INFO - 'PWD': '/builds/slave/test', 16:40:06 INFO - 'SHELL': '/bin/bash', 16:40:06 INFO - 'SHLVL': '1', 16:40:06 INFO - 'TERM': 'linux', 16:40:06 INFO - 'TMOUT': '86400', 16:40:06 INFO - 'USER': 'cltbld', 16:40:06 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:06 INFO - '_': '/tools/buildbot/bin/python'} 16:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:06 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)) 16:40:07 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)) 16:40:07 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)) 16:40:07 INFO - Cleaning up... 16:40:07 INFO - Return code: 0 16:40:07 INFO - Running post-action listener: _resource_record_post_action 16:40:07 INFO - Running post-action listener: _start_resource_monitoring 16:40:07 INFO - Starting resource monitoring. 16:40:07 INFO - ##### 16:40:07 INFO - ##### Running install step. 16:40:07 INFO - ##### 16:40:07 INFO - Running pre-action listener: _resource_record_pre_action 16:40:07 INFO - Running main action method: install 16:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:07 INFO - Reading from file tmpfile_stdout 16:40:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:07 INFO - Reading from file tmpfile_stdout 16:40:07 INFO - Output received: 16:40:07 INFO - Usage: mozinstall [options] installer 16:40:07 INFO - Options: 16:40:07 INFO - -h, --help show this help message and exit 16:40:07 INFO - -d DEST, --destination=DEST 16:40:07 INFO - Directory to install application into. [default: 16:40:07 INFO - "/builds/slave/test"] 16:40:07 INFO - --app=APP Application being installed. [default: firefox] 16:40:07 INFO - mkdir: /builds/slave/test/build/application 16:40:07 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'] 16:40:07 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 16:40:21 INFO - Reading from file tmpfile_stdout 16:40:21 INFO - Output received: 16:40:21 INFO - /builds/slave/test/build/application/firefox/firefox 16:40:21 INFO - Running post-action listener: _resource_record_post_action 16:40:21 INFO - ##### 16:40:21 INFO - ##### Running run-tests step. 16:40:21 INFO - ##### 16:40:21 INFO - Running pre-action listener: _resource_record_pre_action 16:40:21 INFO - Running main action method: run_tests 16:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:40:21 INFO - Python 2.7.3 16:40:21 INFO - Return code: 0 16:40:21 INFO - grabbing minidump binary from tooltool 16:40:21 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')]} 16:40:21 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 0x25bcb70>, '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 0x260ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:40:21 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 16:40:21 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 16:40:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:40:21 INFO - Return code: 0 16:40:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:40:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:40:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:40:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:40:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 16:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 16:40:21 INFO - Using env: {'DISPLAY': ':0', 16:40:21 INFO - 'HOME': '/home/cltbld', 16:40:21 INFO - 'LANG': 'en_US.UTF-8', 16:40:21 INFO - 'LANGUAGE': 'en_US:en', 16:40:21 INFO - 'LOGNAME': 'cltbld', 16:40:21 INFO - 'MAIL': '/var/mail/cltbld', 16:40:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:21 INFO - 'MOZ_NO_REMOTE': '1', 16:40:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:21 INFO - 'NO_EM_RESTART': '1', 16:40:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:21 INFO - 'PWD': '/builds/slave/test', 16:40:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:21 INFO - 'SHELL': '/bin/bash', 16:40:21 INFO - 'SHLVL': '1', 16:40:21 INFO - 'TERM': 'linux', 16:40:21 INFO - 'TMOUT': '86400', 16:40:21 INFO - 'USER': 'cltbld', 16:40:21 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977', 16:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:21 INFO - '_': '/tools/buildbot/bin/python'} 16:40:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 16:40:21 INFO - mozversion INFO | application_buildid: 20151124161231 16:40:21 INFO - mozversion INFO | application_changeset: e84368c1f7b7c61f28f60365b64a70fdf3465c08 16:40:21 INFO - mozversion INFO | application_display_name: Nightly 16:40:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:40:21 INFO - mozversion INFO | application_name: Firefox 16:40:21 INFO - mozversion INFO | application_remotingname: firefox 16:40:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:40:21 INFO - mozversion INFO | application_vendor: Mozilla 16:40:21 INFO - mozversion INFO | application_version: 45.0a1 16:40:21 INFO - mozversion INFO | platform_buildid: 20151124161231 16:40:21 INFO - mozversion INFO | platform_changeset: e84368c1f7b7c61f28f60365b64a70fdf3465c08 16:40:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:40:21 INFO - mozversion INFO | platform_version: 45.0a1 16:40:21 INFO - 2015-11-24 16:40:21,736 DEBUG : using testdate: 1448412021 16:40:21 INFO - 2015-11-24 16:40:21,736 DEBUG : actual date: 1448412021 16:40:21 INFO - 2015-11-24 16:40:21,748 INFO : starting webserver on 'localhost:40541' 16:40:21 INFO - 2015-11-24 16:40:21,749 INFO : Starting test suite talos-linux64-ix-055 16:40:21 INFO - 2015-11-24 16:40:21,749 INFO : Starting test dromaeo_css 16:40:21 INFO - 2015-11-24 16:40:21,750 DEBUG : operating with platform_type : linux_ 16:40:21 INFO - 2015-11-24 16:40:21,750 INFO : Initialising browser for dromaeo_css test... 16:40:21 INFO - 2015-11-24 16:40:21,766 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw8G4rv/profile http://localhost:40541/getInfo.html 16:40:26 INFO - 2015-11-24 16:40:26,054 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:40:26 INFO - 2015-11-24 16:40:26,054 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:40:26 INFO - 2015-11-24 16:40:26,054 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:40:26 INFO - 2015-11-24 16:40:26,055 DEBUG : BROWSER_OUTPUT: __metrics 16:40:26 INFO - 2015-11-24 16:40:26,196 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:27 INFO - 2015-11-24 16:40:27,436 INFO : Browser initialized. 16:40:27 INFO - 2015-11-24 16:40:27,437 INFO : Running cycle 1/1 for dromaeo_css test... 16:40:27 INFO - 2015-11-24 16:40:27,437 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw8G4rv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:40:39 INFO - 2015-11-24 16:40:39,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 142319616 16:40:39 INFO - 2015-11-24 16:40:39,352 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-24 16:41:30,543 DEBUG : BROWSER_OUTPUT: 1448412090540 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] 16:43:42 INFO - 2015-11-24 16:43:42,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40541/tests/dromaeo/cssquery-ext.html) 16:43:43 INFO - 2015-11-24 16:43:43,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 244658176 16:43:43 INFO - 2015-11-24 16:43:43,632 DEBUG : BROWSER_OUTPUT: 16:46:46 INFO - 2015-11-24 16:46:46,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-ext.html (next: http://localhost:40541/tests/dromaeo/cssquery-jquery.html) 16:46:46 INFO - 2015-11-24 16:46:46,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 206966784 16:46:46 INFO - 2015-11-24 16:46:46,606 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-11-24 16:49:48,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40541/tests/dromaeo/cssquery-mootools.html) 16:49:49 INFO - 2015-11-24 16:49:49,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 206385152 16:49:49 INFO - 2015-11-24 16:49:49,244 DEBUG : BROWSER_OUTPUT: 16:52:51 INFO - 2015-11-24 16:52:51,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40541/tests/dromaeo/cssquery-prototype.html) 16:52:51 INFO - 2015-11-24 16:52:51,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 202047488 16:52:51 INFO - 2015-11-24 16:52:51,740 DEBUG : BROWSER_OUTPUT: 16:55:54 INFO - 2015-11-24 16:55:54,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40541/tests/dromaeo/cssquery-yui.html) 16:55:55 INFO - 2015-11-24 16:55:55,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 206573568 16:55:55 INFO - 2015-11-24 16:55:55,107 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/dromaeo/cssquery-yui.html (next: http://localhost:40541/tests/dromaeo/cssquery-dojo.html) 16:58:57 INFO - 2015-11-24 16:58:57,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 250056704 16:58:57 INFO - 2015-11-24 16:58:57,695 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2595.6755405574304;2681.9061332853353;2686.476137153256;2700.0819721294756;2710.756031957124;4516.54834516549;4636.629069674426;4657.487676355602;4680.297955306705;4692.061587682464;4611.193041217782;4617.676762626617;4652.348671186037;4715.693479923802;4750.643701722376;4295.506016808075;4306.5262821089655;4321.157374312011;4377.168338015783;4387.078713470175;4380;4436.378906953029;4448.799804008828;4449.5995360417555;4451.421315229032;4156.750594964282;4270.316749320125;4276.994906197041;4389.824407023715;4449.4660640723;4238.258304796648;4338.240807858612;4342.088161486092;4355.499117601485;4356.172327257811;4325.156594464081;4328.134373125387;4331.480222373304;4351.216780979423;4392.670549708785;4516.051629157881;4627.884302892421;4632.374629425019;4633.791479383436;4650.209464391061;4910.361652985125;4930.1865192243595;5022.598192144656;5022.874428139289;5061.873453163664;5036.269740887551;5037.042961837239;5038.647294689373;5038.823641172578;5083;4520.50274469808;4617.422822147231;4675.906481870344;4677.181493238703;4685.203515402356;5060.165072762953;5097.923531146962;5159.535641792257;5182.24857395683;5231;4910.8281210157475;4921.704697718077;4926.236433352836;4927.876803079952;4973.403191616957;4773.188557945157;4878.512148785093;4989.950100499022;4993.800247990112;5007.974960125176;4854.563089321978;4922.1140194765285;4927.728974906415;4932.802687892444;4941.332920055746;4937.5556199942175;4991.051700177028;5003.649744517922;5007.098722230034;5046;4019.0756126091164;4108.6918481114035;4187.5184353799095;4201.474815648044;4242.766647834337;3550.591681956608;3614.295212433603;3624.873129440457;3630.655087766711;3660.652238037382;4295.355696645465;4297.054647977502;4312.396264522969;4337.696361254745;4341.044970106572;4798.928016079762;4945.7774400152075;4978.925316120261;5001.524855138756;5037.244413337955;4244.830206791694;4263.16868210696;4274.166537525215;4356.607905288476;4383.517813040563;4430.867073987785;4467.352233926127;4470.530594287618;4472.977635111869;4508.819647214074;4615.100055489147;4803.327534145153;4811.975940120277;4822.638302127284;4826.975865120652;4872.512748725099;4887.560119589254;4889.168841296917;4959.752012399438;5004.724740139181;4755.809767609257;4827.324174615627;4829.323894654681;4832.395950506187;4858.05267972742;4781.187198176388;4996.675216110941;5011.523905228997;5014.323066385991;5055.115354812967;4883.90232195347;4922.360093187863;4928.581070609039;4939.975300123477;4995.125852975787;4870;4901.656884018227;4908.312836202863;4913.6069114471475;4958.181899986462;4693.812247510062;4897.2654101885;4897.755112244445;4902.681325713817;4956.727379994135;4596.126735920165;4642.675012749075;4648.7443190624845;4702.623790096853;4721.693089949143;4897.755112244445;4921.26181072842;4921.557059864629;4927.975360123177;4965.379327584052;4810.927836082532;4815.15734746425;4818.10864989978;4845.1520983828395;4858.6356023297685 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.1890817768325;571.9628224165428;574.7040274258754;577.0795581048229;583.4777873802949;27952.16143515695;28454;28464.57303140452;28488.575571221434;28502.714972850266;28659;29164.56253156199;37658;38415.42376864342;38469.61530384696;8042.155573664754;8163.795905102361;8186.877196842022;8191.303739182176;8192.385571082163;7188.281171882796;8011.519308841459;8132.674693012273;8133.75598732036;8136.959315203416;7141.500094993353;10359.27485076045;10629.149668026577;10635.308704934194;10636.361818290927;10061;10184.89815101847;10201.67378240824;10203.234757393226;10206.438645874474;7141.071660684078;7337.046183996046;7340.559566425978;9946.602135914627;10185.796284074351;27060.729392706216;36442.27115457702;37152.62847371519;37162;37196;2647.6699317304915;2680.892764289426;2691.434798692277;2879.5824605432094;3387.7289816814596;26172.476550469073;26915.46169076627;27243.182704518895;27275.45449091007;27568.448631027266;3369.578802649669;3370.191154122993;3394.558707368051;3428.3828910796046;3443.8794642187654;202520;203537;203637;203726.9813650937;203939;51535.48464515382;51814.48185518172;51814.740926295126;51892.48107518952;51955.48044519506;55595.166072508946;55682.16476752852;55697.443025570035;55794.72102639461;55842.37024593388;14219;14434.711305773826;14452.783208251885;14481.85518144805;14487.710245795235;10678.1991350649;10767.461626918623;10775.568977240822;10781.784364312669;10794.24440289188;17858.01780902037;18027.819721802876;18238.452846414628;18271.08644567766;18273.63452730938;7234.74678386254;7478.439117066133;7583.886241706379;7666.233376662289;7685.615719214129;826.5495305058757;888.1207604471656;922.5018490015451;923.8290916180528;964;26620.60069098965;26645;26706.732932670813;26745;26750.866245668647;888.5335199020566;898.3846065445191;967.9225661947028;981.4640088261847;1006.8389057750871;12903.354832258537;13060.151090179108;13105;13188.472461101448;13345.266010369523;200104;204047;204193;204195;204212;41084.794576027525;41331.7933410331;41342.58657413387;41359.1728165435;41360.58639413567;1162.0819552553558;1168.8889555492215;1171.7305019845483;1177.0995188680665;1188.2454641302836;25160.245192644248;25775.355616109748;26449.206523804318;26516.734832651426;26557.734422655525;39984;40157.79921100376;40235.1952960945;40264.59735402608;40307;244056;244106;244399.55802431036;247499;247681;28185;28922.566161507173;28999.565006524495;29013.129606111852;29018.564721529616;38265.23469530649;38364.80817595894;38920.61079389283;39105.80447097746;39234.2153156941;33202.5019624701;33782.49326260059;34192;34425.311493769485;34686.65313346834;32813.85065081109;33349.83325083359;33559.66440335565;33592.328153436305;33716.83141584276;27020.72979270261;32776.83611581927;33354.499682505266;33432;33735.662643374235;21262;28706.856465718374;29189.416211675223;29349.41301174007;29472.642188624428;22892.313230603108;23589.29232123039;23617.40956476102;24019.639705404083;25459.745402545737 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.683950247265;332.97336213102955;333.70300432614977;334.81585128179523;337.340499323822;12971.610851674464;13469.595912122628;14890.77663835042;15273;15728.21358932053;8256.95871520643;10040.497975101234;10342.224333175023;14553.636159096028;15071.698566028674;4466.776661166945;4572.9314060289125;4579.381783459224;4588.380568623226;4597.37935378723;3334.333133373323;3426.023583278766;4373.300271956487;4575.428071491064;4912.877178070541;5083.517065878754;5091.9236211456855;5120.8975820483565;5123;5124.1545145051205;5085.033843569729;5090.312807770941;5090.516400941905;6124.2650881894015;6373.649449280288;6106.511479081662;6122.908156377658;6125.387461253884;6128.908066379008;6139.140520327158;18964.905175474036;19781.703274450894;19813.603727925503;19904.900475497674;20440.795592044185;1807.9186436610385;1855.3506272804545;1869.8878067315868;1939.2630800295797;1972.5660354721938;13642;13726.107802992774;13780.242086685228;14063.367148478343;14064.156150630995;1746.5371676505736;1765.48800847754;1840.8343249107645;1842.769653793276;1870.2705944681586;55904.720476397764;56839.43160568424;58233.12650310249;61593.07610385803;64773.3522664772;14981.850181498046;15280.617984550252;15309.234538273042;15322.923385383001;15361.078335299917;22800.201992930168;22857.88571057134;23187.884060579927;23193.420164496023;23205.071797127926;8116.228958248957;8338.8332233355;8441.198086181803;8473;8526.275266602284;6953;6986.685599147949;6996;7143.071400717873;7201.6399180041835;7405.1484079330485;7423.369013633794;7442.330190282901;7449.88825167623;7470;2249.3476891701553;2856.61435706177;2857.9285517862218;2904.2448963269703;2913.985430072836;379.74746793382093;380.708757800283;875.8686197070363;934.6635211323918;941.5480569326625;8602.913970860336;8787;9009.054049324857;9094.136057074567;9639.759006024906;383.9539255289383;391.85305510433585;393.1096067407325;401.2997319677124;408.9795510224477;5153.304303918923;5235.397929238186;5257.579393648499;5272.288241087481;5475.123980163155;423764;426238;448505;460062;467320;70007;70333.64833175801;71929.64035179895;72769.63615181891;73408.63295683487;1027.198784947742;1074.5325783284297;1075.8816530181673;1114.7213196700825;1140.1790710688292;13283.203007819562;13561.525346612822;13841;13985;14187.929060354632;32329.838350808095;32507.18732031718;32543.34913301768;33055.50416743799;33181.33637327288;38935.80532097322;48948.265776012675;49179.8197153246;49405.50594494153;50085.24872126994;13065.869341306845;13147.276899770222;13172.802407963696;13630.86369136296;13736.175829450265;16796.160191990595;17609.911950440164;17650.823491764917;17678.292868285123;18032.729509057113;14357.712845742817;14399.208043557286;14647.560573182822;14909.179995100374;15148;13098.803517947428;13141.868581314064;13260;13668.726625467236;14034.929825350808;14079.366428510537;14178.645533861736;14284.642883927985;14312.713745725236;14580.635484112558;13284.53504127351;13433.66415839612;13547.525836596065;13757.243351615758;13862;11118.555257789598;13275.66810829737;13565.321733913068;13605.183688978694;15024.24878756036 16:58:57 INFO - 2015-11-24 16:58:57,696 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1225.7180848404862;1351.5337208663013;1394.8605139486053;1576.4167258114499;1640.9589760255997;6076.635401875885;6264.34224406437;6591.802245932629;6617.503687223453;6622.304658010899;6699.665016749167;6748.831279218022;6776.695048722807;6805.421539169164;6841.144856892888;2049.938501844947;2071.2439959414783;2072.875627462357;2073.8548301618894;2074.460640233535;2036.7657719362242;2042.5914817036578;2052.733144691188;2077.750669919604;2087.269455690511;2009.146112902018;2028.4421784009369;2034.389683095073;2041.1223174035233;2042.8672136311093;2055.2601063617085;2063.8555301128927;2068.8965551722354;2069.4722845674255;2072.4715197624587;2015.556577552936;2033.2476983516194;2035.9491012724652;2036.8166864982222;2037.5822956294073;5694.601377903548;5921.467067963861;6743.123393958803;6762.087118239024;6772.322767723188;3957.7625342479255;4040.4949381327333;4042.959570404317;4045.9595404045876;4051.1897620476025;2648.298200976743;2665.4269332093695;2699.85150816707;2716.5246081935584;2717.252755492236;879.4503435352905;885.2431171348533;902.7607683963755;930.734740598926;932.9440233586007;9066.95466522663;9175.632974681004;9185.908140918573;9188.908110918872;9190.494522801244;3640.3993341098953;3688.3360995021153;3709.536307961505;3714.405695088827;3728.794916279631;8035.397345199133;8045.235702608243;8059.959700201462;8060.959695201486;8062.798430039179;3896.7077469189926;3915.5497117831246;3931.9017024574614;3935.311320518898;3944.3886197639413;3589.2462582857893;3598.8200589970397;3599.1901822090344;3601.2077342984503;3602.441621548664;3127.202563346332;3155.936881262362;3159.462891308483;3185.490321548541;3189.1389324882616;988.9554970026367;991.3853410885297;991.504247876062;992.2954702161402;998.236349192868;1111.9054880335261;1130.4008875296106;1141.263884794303;1149.7068247596976;1154.3939431798206;6248.75004999804;6325.715342809584;6335.461485773761;6371.617702937839;6375.203099612549;427.2821659611882;439.28396713357023;451.46952331011585;451.5958217395413;453.85930361588015;4797.856064318076;4799.784009719571;4841.515848415131;4851.975740121276;4861.465238823726;7198.244184360671;7837.373010159287;8067.314278286294;8076.4750291230885;8089.757307280674;7949.7217597383815;7977.441579089524;7979.48133371329;7981.1220765715725;7983.002124734408;6191.81424557264;6319.3364696706185;6343.809685709436;6345.619262844244;6361.809145725636;6172.506199503939;6214.782482613087;6218.253809542884;6221.440070393686;6227.532935029801;7072.257412971564;7402.222766609429;7447.404207663266;7485.176630570524;7519.962400187964;7492;7554.848903022019;7649.158592554703;7686.500377475446;7695.038120234971;5770.740316685676;5873.207117039145;5895.7052147393315;5907.2911250650195;5937.050071988461;6355.936440635534;6437.485001199986;6441.1626488556185;6449.032645103084;6455.096286519797;6143.232095988002;6247.219097612799;6271.6550589718;6277.654728989949;6353.650549219838;5814.505767009851;5930.495907847881;5973.611715238496;6166.445019948226;6178.752849885954;6065.636061836304;6183.412575805291;6192.225971753531;6200.100985357008;6209.503239740719;5765.625234359753;5787.768489260382;5809.912851307318;5811.244538210175;5812.505936995233;5681.233033540584;5692.829215123553;5748.109043098327;5779.624324418899;5793.015187418233 16:58:57 INFO - 2015-11-24 16:58:57,698 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.7357498975891;311.3834607477195;315.70323895538206;315.7111243212461;316.8811695614143;5259.973700131499;5365.141577347626;5377.892442151155;5383.67697938124;5391.865203369918;5287.418383977769;5338.652987555806;5340.49265319795;5344.732763361826;5345.812896548621;3996.260691772017;4099.836006559734;4217.072244106292;4224.704270701052;4230.957690423103;4099.159672267193;4181.121964387467;4196.9370459443135;4200.789960501978;4214.072903961123;4156.272652285853;4166.250074986501;4169.187008533338;4170.728902621335;4171.144915292373;3957.683385329181;4041.555428902818;4063.187362527506;4147.6267135957605;4166.0834616384345;3627.020704409821;3630.09247688078;3631.2011357501306;3633.745637805355;3643.744937854351;5208.479152084761;5214.348206474191;5220.582353411718;5225.895482090375;5230.503102205284;4753.9762301188275;4762.166620841339;4762.452317983441;4763.785629646674;4769.928451073237;5481.287432633772;5634.4365563443735;5637.605367624268;5643.266375371176;5654.180143879155;4058.431819545266;4058.6144316289906;4058.715889887709;4059.472268605092;4060.330045542482;5962.493188079018;5983.1623572699855;5988.520918326567;5990.101484777275;5991.670458124801;4187.6440502557625;4188.659628918716;4192.371144328315;4195.664346852305;4197.538270790211;4161.126163505637;4243.342281946303;4254.468191476066;4264.87205383839;4280.72175308604;4797.424309082932;4804.231322988305;4815.181419158752;4816.060868130751;4818.325434439182;5672.489475947102;5673;5681.176229446707;5684.118961560965;5686.772529098873;1488.8436714145075;1505.570912289992;1506.028611545547;1506.7513860213162;1508.58513908676;1028.783955369366;1030.3663247102977;1045.5765415006783;1059.433203236265;1067.631667074858;4964.751762411865;4986.077575648516;4989.151844186497;5007.37407824022;5012.774425150877;5889.528837692974;5894.852628684317;5900.822975310747;5902.527797776168;5903.793367232212;4950.059488697136;4964.801407943714;4982.476839931827;5001;5001.24981252815;2950.173951293641;3032.1964679359985;3145.779795414345;3172;3209.406259841937;5538.556915446755;5623.044082505984;5626;5633.746481408347;5640.097584386478;6111.297200821962;6117;6127.571070025056;6128.080787881853;6132.478739307119;5615.634983726127;5620.606557540933;5625.353084395265;5629.408912064175;5633.605647604711;5809.215755872903;5950.31571369298;5957.76168953237;5959.791407300723;5968.820935371946;5803.593748437569;5810.302763668386;5810.360860305447;5813.82558523245;5816.82549523515;5615.466530679579;5622.971885140548;5628.058319879635;5628.296462942132;5630.18362337467;4106.815193316368;4118.341065429517;4122.793860307032;4125.834966601303;4262.978685106555;5935.821925342247;5939.287285525765;5941.31674857397;5942.316633587193;5947.078202878561;5704.2014118024335;5723.484886360247;5726.4273572642405;5736.541076713769;5739.966805974965;5604.271444712162;5713.628614140068;5713.942860571341;5728.484436400744;5730.968425683251;5564.721763911869;5573.665580065209;5577.888442231051;5581.330240371181;5589.329280486368;5737.110747833925;5743.052396354555;5746.396628353963;5747.1379293106365;5747.3103227612955;5390.00284947286;5411.594130440154;5538.196961440488;5540.972295138498;5575.832725018256 16:58:57 INFO - 2015-11-24 16:58:57,699 DEBUG : BROWSER_OUTPUT: |5;yui.html;645.7642960319483;747.6486051555769;755.1579988313033;759.9810004749884;776.8213310938484;10391.4804259787;10608.098311643509;10633.627823026185;10645.57417703291;10653.201009924267;9612.942576316616;10928.836067458995;11122.721931951704;11280.943595282011;11337.943310283457;734.6216698400328;752.3792870881517;753.7701001194633;753.7964749517627;754.6226886556722;737.3621817128172;738.6934422214774;743.4498471131378;744.0996394362827;746.8842329438945;774.357283454734;782.9060512738479;782.909965353983;784.725346128856;786.4769927997875;765.1353970013904;770.6455030685835;771.0246538129243;771.814764456532;774.0440555913442;569.4647031790104;570.6661602962272;571.1404336473622;573.2891214893543;574.1703238819907;9176.8623470648;9361.906380936172;9419.387739796892;9436.197923176538;9465.810683786285;8807.07525709804;8910.554472276424;8969.910300896972;9283.814323713488;9297.209737172348;8270.627821748036;8293.751187464386;8315.83368332636;8365.912431383882;8379.45533540318;3152.4010438016703;3199.632042315117;3211.678832116793;3226.0966929259844;3283.4746440569634;37796.43305350422;38657.26042328102;38673.41989870154;38772.22455550873;39716.801415993024;8697.695580654647;8748.650053997897;8795.51624660637;8803.911960880308;8879.822403552022;16062.839371606367;16074.598135046717;16145.273462694207;16173.838261617468;16198.514044578682;6259.342769009279;6355.841103972438;6386;6394.4564712;6409.519286053564;3458.39478091333;3521.3133438979667;3574.8927532174075;3592.964070359263;3593.7304702147444;2669.6529451171614;2689.354554906808;2706.796990225741;2707.810453268292;2710.1327575176147;465.7601335312317;466.65467554009786;473.97393143377445;482.0503607892446;482.7755093881362;515.8968206358743;523.4974424552396;560.117814442255;584.5849446892754;592.8428966323928;6964.268751781091;6999.335063168991;7010.964945175241;7062.258462861429;7136.750213742494;453.99560938457;455.0875494633239;514.1208533407914;538.9029974604609;540.5351397797891;3157.8105313681253;3168.920776980548;3176.8093914365213;3306.173456635841;3699.7040236780995;47295.29057064078;47868.76065619649;47879.76060119747;48002.759986199846;50352.74823625859;42258;43088.78455607702;44901.32648010283;45274.773626132315;45586.772066139456;45268;46172.538274617495;46557.767211164406;47608;47658.285125723145;7144.3212894774915;7609.6575654094595;7942.404319675932;8048.637811298388;8244.917550824415;32759.67240327566;33099.17252068718;33194.83402582972;33210;33410;40483.59516404798;40863.387049194884;40929.1814163721;40994.59005409908;41236.14437350266;9483.478408687313;9513.619455221991;9615.326927115315;9726.221902247662;10033.147182489278;10512.579496820348;10524.736881578021;10533.473326333806;10594.205434592282;11202.775944481227;9265.305102117503;9420.717378478657;9483.241340692866;9528.857067144138;9683.612655493702;9945.602175912882;9956.20350371954;9979.201663866728;10002.099811017044;10012.69961901144;8896.288296936358;9195.77010574741;9331.72004839856;9381.484018378782;9830.459324737209;8133.79665508367;8606.65573377058;8661.480311181349;8826.779330516789;8868.379213455255;7858.764237072897;8235.670573177245;8449.28181104613;8509.787255318666;8568.828623427371 16:58:57 INFO - 2015-11-24 16:58:57,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:57 INFO - 2015-11-24 16:58:57,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:58:57 INFO - 2015-11-24 16:58:57,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,891 16:58:57 INFO - 2015-11-24 16:58:57,699 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: __startTimestamp1448413137691__endTimestamp 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4617.31 Median:4755.81 stddev:477.96 (10.0%) stddev-sans-first:452.35 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: Values: 2595.7 2681.9 2686.5 2700.1 2710.8 4516.5 4636.6 4657.5 4680.3 4692.1 4611.2 4617.7 4652.3 4715.7 4750.6 4295.5 4306.5 4321.2 4377.2 4387.1 4380.0 4436.4 4448.8 4449.6 4451.4 4156.8 4270.3 4277.0 4389.8 4449.5 4238.3 4338.2 4342.1 4355.5 4356.2 4325.2 4328.1 4331.5 4351.2 4392.7 4516.1 4627.9 4632.4 4633.8 4650.2 4910.4 4930.2 5022.6 5022.9 5061.9 5036.3 5037.0 5038.6 5038.8 5083.0 4520.5 4617.4 4675.9 4677.2 4685.2 5060.2 5097.9 5159.5 5182.2 5231.0 4910.8 4921.7 4926.2 4927.9 4973.4 4773.2 4878.5 4990.0 4993.8 5008.0 4854.6 4922.1 4927.7 4932.8 4941.3 4937.6 4991.1 5003.6 5007.1 5046.0 4019.1 4108.7 4187.5 4201.5 4242.8 3550.6 3614.3 3624.9 3630.7 3660.7 4295.4 4297.1 4312.4 4337.7 4341.0 4798.9 4945.8 4978.9 5001.5 5037.2 4244.8 4263.2 4274.2 4356.6 4383.5 4430.9 4467.4 4470.5 4473.0 4508.8 4615.1 4803.3 4812.0 4822.6 4827.0 4872.5 4887.6 4889.2 4959.8 5004.7 4755.8 4827.3 4829.3 4832.4 4858.1 4781.2 4996.7 5011.5 5014.3 5055.1 4883.9 4922.4 4928.6 4940.0 4995.1 4870.0 4901.7 4908.3 4913.6 4958.2 4693.8 4897.3 4897.8 4902.7 4956.7 4596.1 4642.7 4648.7 4702.6 4721.7 4897.8 4921.3 4921.6 4928.0 4965.4 4810.9 4815.2 4818.1 4845.2 4858.6 16:58:57 INFO - 2015-11-24 16:58:57,700 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,701 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37667.56 Median:29176.99 stddev:56618.36 (194.1%) stddev-sans-first:56708.64 16:58:57 INFO - 2015-11-24 16:58:57,701 DEBUG : BROWSER_OUTPUT: Values: 561.2 572.0 574.7 577.1 583.5 27952.2 28454.0 28464.6 28488.6 28502.7 28659.0 29164.6 37658.0 38415.4 38469.6 8042.2 8163.8 8186.9 8191.3 8192.4 7188.3 8011.5 8132.7 8133.8 8137.0 7141.5 10359.3 10629.1 10635.3 10636.4 10061.0 10184.9 10201.7 10203.2 10206.4 7141.1 7337.0 7340.6 9946.6 10185.8 27060.7 36442.3 37152.6 37162.0 37196.0 2647.7 2680.9 2691.4 2879.6 3387.7 26172.5 26915.5 27243.2 27275.5 27568.4 3369.6 3370.2 3394.6 3428.4 3443.9 202520.0 203537.0 203637.0 203727.0 203939.0 51535.5 51814.5 51814.7 51892.5 51955.5 55595.2 55682.2 55697.4 55794.7 55842.4 14219.0 14434.7 14452.8 14481.9 14487.7 10678.2 10767.5 10775.6 10781.8 10794.2 17858.0 18027.8 18238.5 18271.1 18273.6 7234.7 7478.4 7583.9 7666.2 7685.6 826.5 888.1 922.5 923.8 964.0 26620.6 26645.0 26706.7 26745.0 26750.9 888.5 898.4 967.9 981.5 1006.8 12903.4 13060.2 13105.0 13188.5 13345.3 200104.0 204047.0 204193.0 204195.0 204212.0 41084.8 41331.8 41342.6 41359.2 41360.6 1162.1 1168.9 1171.7 1177.1 1188.2 25160.2 25775.4 26449.2 26516.7 26557.7 39984.0 40157.8 40235.2 40264.6 40307.0 244056.0 244106.0 244399.6 247499.0 247681.0 28185.0 28922.6 28999.6 29013.1 29018.6 38265.2 38364.8 38920.6 39105.8 39234.2 33202.5 33782.5 34192.0 34425.3 34686.7 32813.9 33349.8 33559.7 33592.3 33716.8 27020.7 32776.8 33354.5 33432.0 33735.7 21262.0 28706.9 29189.4 29349.4 29472.6 22892.3 23589.3 23617.4 24019.6 25459.7 16:58:57 INFO - 2015-11-24 16:58:57,701 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,701 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26112.38 Median:32525.27 stddev:72800.26 (223.8%) stddev-sans-first:72978.75 16:58:57 INFO - 2015-11-24 16:58:57,702 DEBUG : BROWSER_OUTPUT: Values: 332.7 333.0 333.7 334.8 337.3 12971.6 13469.6 14890.8 15273.0 15728.2 8257.0 10040.5 10342.2 14553.6 15071.7 4466.8 4572.9 4579.4 4588.4 4597.4 3334.3 3426.0 4373.3 4575.4 4912.9 5083.5 5091.9 5120.9 5123.0 5124.2 5085.0 5090.3 5090.5 6124.3 6373.6 6106.5 6122.9 6125.4 6128.9 6139.1 18964.9 19781.7 19813.6 19904.9 20440.8 1807.9 1855.4 1869.9 1939.3 1972.6 13642.0 13726.1 13780.2 14063.4 14064.2 1746.5 1765.5 1840.8 1842.8 1870.3 55904.7 56839.4 58233.1 61593.1 64773.4 14981.9 15280.6 15309.2 15322.9 15361.1 22800.2 22857.9 23187.9 23193.4 23205.1 8116.2 8338.8 8441.2 8473.0 8526.3 6953.0 6986.7 6996.0 7143.1 7201.6 7405.1 7423.4 7442.3 7449.9 7470.0 2249.3 2856.6 2857.9 2904.2 2914.0 379.7 380.7 875.9 934.7 941.5 8602.9 8787.0 9009.1 9094.1 9639.8 384.0 391.9 393.1 401.3 409.0 5153.3 5235.4 5257.6 5272.3 5475.1 423764.0 426238.0 448505.0 460062.0 467320.0 70007.0 70333.6 71929.6 72769.6 73408.6 1027.2 1074.5 1075.9 1114.7 1140.2 13283.2 13561.5 13841.0 13985.0 14187.9 32329.8 32507.2 32543.3 33055.5 33181.3 38935.8 48948.3 49179.8 49405.5 50085.2 13065.9 13147.3 13172.8 13630.9 13736.2 16796.2 17609.9 17650.8 17678.3 18032.7 14357.7 14399.2 14647.6 14909.2 15148.0 13098.8 13141.9 13260.0 13668.7 14034.9 14079.4 14178.6 14284.6 14312.7 14580.6 13284.5 13433.7 13547.5 13757.2 13862.0 11118.6 13275.7 13565.3 13605.2 15024.2 16:58:57 INFO - 2015-11-24 16:58:57,702 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,702 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4718.73 Median:5914.38 stddev:2439.21 (41.2%) stddev-sans-first:2431.92 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: Values: 1225.7 1351.5 1394.9 1576.4 1641.0 6076.6 6264.3 6591.8 6617.5 6622.3 6699.7 6748.8 6776.7 6805.4 6841.1 2049.9 2071.2 2072.9 2073.9 2074.5 2036.8 2042.6 2052.7 2077.8 2087.3 2009.1 2028.4 2034.4 2041.1 2042.9 2055.3 2063.9 2068.9 2069.5 2072.5 2015.6 2033.2 2035.9 2036.8 2037.6 5694.6 5921.5 6743.1 6762.1 6772.3 3957.8 4040.5 4043.0 4046.0 4051.2 2648.3 2665.4 2699.9 2716.5 2717.3 879.5 885.2 902.8 930.7 932.9 9067.0 9175.6 9185.9 9188.9 9190.5 3640.4 3688.3 3709.5 3714.4 3728.8 8035.4 8045.2 8060.0 8061.0 8062.8 3896.7 3915.5 3931.9 3935.3 3944.4 3589.2 3598.8 3599.2 3601.2 3602.4 3127.2 3155.9 3159.5 3185.5 3189.1 989.0 991.4 991.5 992.3 998.2 1111.9 1130.4 1141.3 1149.7 1154.4 6248.8 6325.7 6335.5 6371.6 6375.2 427.3 439.3 451.5 451.6 453.9 4797.9 4799.8 4841.5 4852.0 4861.5 7198.2 7837.4 8067.3 8076.5 8089.8 7949.7 7977.4 7979.5 7981.1 7983.0 6191.8 6319.3 6343.8 6345.6 6361.8 6172.5 6214.8 6218.3 6221.4 6227.5 7072.3 7402.2 7447.4 7485.2 7520.0 7492.0 7554.8 7649.2 7686.5 7695.0 5770.7 5873.2 5895.7 5907.3 5937.1 6355.9 6437.5 6441.2 6449.0 6455.1 6143.2 6247.2 6271.7 6277.7 6353.7 5814.5 5930.5 5973.6 6166.4 6178.8 6065.6 6183.4 6192.2 6200.1 6209.5 5765.6 5787.8 5809.9 5811.2 5812.5 5681.2 5692.8 5748.1 5779.6 5793.0 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4731.62 Median:5273.70 stddev:1383.21 (26.2%) stddev-sans-first:1346.57 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: Values: 303.7 311.4 315.7 315.7 316.9 5260.0 5365.1 5377.9 5383.7 5391.9 5287.4 5338.7 5340.5 5344.7 5345.8 3996.3 4099.8 4217.1 4224.7 4231.0 4099.2 4181.1 4196.9 4200.8 4214.1 4156.3 4166.3 4169.2 4170.7 4171.1 3957.7 4041.6 4063.2 4147.6 4166.1 3627.0 3630.1 3631.2 3633.7 3643.7 5208.5 5214.3 5220.6 5225.9 5230.5 4754.0 4762.2 4762.5 4763.8 4769.9 5481.3 5634.4 5637.6 5643.3 5654.2 4058.4 4058.6 4058.7 4059.5 4060.3 5962.5 5983.2 5988.5 5990.1 5991.7 4187.6 4188.7 4192.4 4195.7 4197.5 4161.1 4243.3 4254.5 4264.9 4280.7 4797.4 4804.2 4815.2 4816.1 4818.3 5672.5 5673.0 5681.2 5684.1 5686.8 1488.8 1505.6 1506.0 1506.8 1508.6 1028.8 1030.4 1045.6 1059.4 1067.6 4964.8 4986.1 4989.2 5007.4 5012.8 5889.5 5894.9 5900.8 5902.5 5903.8 4950.1 4964.8 4982.5 5001.0 5001.2 2950.2 3032.2 3145.8 3172.0 3209.4 5538.6 5623.0 5626.0 5633.7 5640.1 6111.3 6117.0 6127.6 6128.1 6132.5 5615.6 5620.6 5625.4 5629.4 5633.6 5809.2 5950.3 5957.8 5959.8 5968.8 5803.6 5810.3 5810.4 5813.8 5816.8 5615.5 5623.0 5628.1 5628.3 5630.2 4106.8 4118.3 4122.8 4125.8 4263.0 5935.8 5939.3 5941.3 5942.3 5947.1 5704.2 5723.5 5726.4 5736.5 5740.0 5604.3 5713.6 5713.9 5728.5 5731.0 5564.7 5573.7 5577.9 5581.3 5589.3 5737.1 5743.1 5746.4 5747.1 5747.3 5390.0 5411.6 5538.2 5541.0 5575.8 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11970.49 Median:588.71 stddev:14191.18 (2410.5%) stddev-sans-first:14205.51 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: Values: 645.8 747.6 755.2 760.0 776.8 10391.5 10608.1 10633.6 10645.6 10653.2 9612.9 10928.8 11122.7 11280.9 11337.9 734.6 752.4 753.8 753.8 754.6 737.4 738.7 743.4 744.1 746.9 774.4 782.9 782.9 784.7 786.5 765.1 770.6 771.0 771.8 774.0 569.5 570.7 571.1 573.3 574.2 9176.9 9361.9 9419.4 9436.2 9465.8 8807.1 8910.6 8969.9 9283.8 9297.2 8270.6 8293.8 8315.8 8365.9 8379.5 3152.4 3199.6 3211.7 3226.1 3283.5 37796.4 38657.3 38673.4 38772.2 39716.8 8697.7 8748.7 8795.5 8803.9 8879.8 16062.8 16074.6 16145.3 16173.8 16198.5 6259.3 6355.8 6386.0 6394.5 6409.5 3458.4 3521.3 3574.9 3593.0 3593.7 2669.7 2689.4 2706.8 2707.8 2710.1 465.8 466.7 474.0 482.1 482.8 515.9 523.5 560.1 584.6 592.8 6964.3 6999.3 7011.0 7062.3 7136.8 454.0 455.1 514.1 538.9 540.5 3157.8 3168.9 3176.8 3306.2 3699.7 47295.3 47868.8 47879.8 48002.8 50352.7 42258.0 43088.8 44901.3 45274.8 45586.8 45268.0 46172.5 46557.8 47608.0 47658.3 7144.3 7609.7 7942.4 8048.6 8244.9 32759.7 33099.2 33194.8 33210.0 33410.0 40483.6 40863.4 40929.2 40994.6 41236.1 9483.5 9513.6 9615.3 9726.2 10033.1 10512.6 10524.7 10533.5 10594.2 11202.8 9265.3 9420.7 9483.2 9528.9 9683.6 9945.6 9956.2 9979.2 10002.1 10012.7 8896.3 9195.8 9331.7 9381.5 9830.5 8133.8 8606.7 8661.5 8826.8 8868.4 7858.8 8235.7 8449.3 8509.8 8568.8 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:57 INFO - 2015-11-24 16:58:57,704 DEBUG : BROWSER_OUTPUT: 16:58:58 INFO - 2015-11-24 16:58:58,397 INFO : Browser exited with error code: 0 16:58:58 INFO - 2015-11-24 16:58:58,419 INFO : Completed test dromaeo_css (00:18:36) 16:58:58 INFO - 2015-11-24 16:58:58,419 INFO : Starting test kraken 16:58:58 INFO - 2015-11-24 16:58:58,419 DEBUG : operating with platform_type : linux_ 16:58:58 INFO - 2015-11-24 16:58:58,419 INFO : Initialising browser for kraken test... 16:58:58 INFO - 2015-11-24 16:58:58,425 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhz_oi/profile http://localhost:40541/getInfo.html 16:59:02 INFO - 2015-11-24 16:59:02,451 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:59:02 INFO - 2015-11-24 16:59:02,451 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:59:02 INFO - 2015-11-24 16:59:02,451 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:59:02 INFO - 2015-11-24 16:59:02,453 DEBUG : BROWSER_OUTPUT: __metrics 16:59:02 INFO - 2015-11-24 16:59:02,581 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:03 INFO - 2015-11-24 16:59:03,744 INFO : Browser initialized. 16:59:03 INFO - 2015-11-24 16:59:03,744 INFO : Running cycle 1/1 for kraken test... 16:59:03 INFO - 2015-11-24 16:59:03,744 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhz_oi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:59:15 INFO - 2015-11-24 16:59:15,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 142069760 16:59:15 INFO - 2015-11-24 16:59:15,597 DEBUG : BROWSER_OUTPUT: 16:59:18 INFO - 2015-11-24 16:59:18,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40541/tests/kraken/driver.html?testName=audio-beat-detection) 16:59:18 INFO - 2015-11-24 16:59:18,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 177168384 16:59:18 INFO - 2015-11-24 16:59:18,779 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-24 16:59:21,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40541/tests/kraken/driver.html?testName=audio-dft) 16:59:22 INFO - 2015-11-24 16:59:22,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 168075264 16:59:22 INFO - 2015-11-24 16:59:22,090 DEBUG : BROWSER_OUTPUT: 16:59:25 INFO - 2015-11-24 16:59:25,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40541/tests/kraken/driver.html?testName=audio-fft) 16:59:25 INFO - 2015-11-24 16:59:25,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 150880256 16:59:25 INFO - 2015-11-24 16:59:25,696 DEBUG : BROWSER_OUTPUT: 16:59:27 INFO - 2015-11-24 16:59:27,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40541/tests/kraken/driver.html?testName=audio-oscillator) 16:59:28 INFO - 2015-11-24 16:59:28,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 154468352 16:59:28 INFO - 2015-11-24 16:59:28,316 DEBUG : BROWSER_OUTPUT: 16:59:30 INFO - 2015-11-24 16:59:30,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:59:31 INFO - 2015-11-24 16:59:31,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 157499392 16:59:31 INFO - 2015-11-24 16:59:31,130 DEBUG : BROWSER_OUTPUT: 16:59:34 INFO - 2015-11-24 16:59:34,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40541/tests/kraken/driver.html?testName=imaging-darkroom) 16:59:34 INFO - 2015-11-24 16:59:34,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 155377664 16:59:34 INFO - 2015-11-24 16:59:34,706 DEBUG : BROWSER_OUTPUT: 16:59:38 INFO - 2015-11-24 16:59:38,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40541/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:38 INFO - 2015-11-24 16:59:38,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 156209152 16:59:38 INFO - 2015-11-24 16:59:38,712 DEBUG : BROWSER_OUTPUT: 16:59:41 INFO - 2015-11-24 16:59:41,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40541/tests/kraken/driver.html?testName=json-parse-financial) 16:59:42 INFO - 2015-11-24 16:59:42,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 156516352 16:59:42 INFO - 2015-11-24 16:59:42,116 DEBUG : BROWSER_OUTPUT: 16:59:43 INFO - 2015-11-24 16:59:43,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:59:44 INFO - 2015-11-24 16:59:44,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 166666240 16:59:44 INFO - 2015-11-24 16:59:44,443 DEBUG : BROWSER_OUTPUT: 16:59:46 INFO - 2015-11-24 16:59:46,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:59:46 INFO - 2015-11-24 16:59:46,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 166440960 16:59:46 INFO - 2015-11-24 16:59:46,934 DEBUG : BROWSER_OUTPUT: 16:59:49 INFO - 2015-11-24 16:59:49,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:59:49 INFO - 2015-11-24 16:59:49,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 174702592 16:59:49 INFO - 2015-11-24 16:59:49,652 DEBUG : BROWSER_OUTPUT: 16:59:52 INFO - 2015-11-24 16:59:52,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:59:52 INFO - 2015-11-24 16:59:52,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 181002240 16:59:52 INFO - 2015-11-24 16:59:52,793 DEBUG : BROWSER_OUTPUT: 16:59:55 INFO - 2015-11-24 16:59:55,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:59:55 INFO - 2015-11-24 16:59:55,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 181968896 16:59:55 INFO - 2015-11-24 16:59:55,962 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40541/tests/kraken/driver.html?testName=ai-astar) 16:59:57 INFO - 2015-11-24 16:59:57,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 239898624 16:59:57 INFO - 2015-11-24 16:59:57,987 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:59:57 INFO - 2015-11-24 16:59:57,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:59:57 INFO - 2015-11-24 16:59:57,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:59:57 INFO - 2015-11-24 16:59:57,990 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:59:57 INFO - 2015-11-24 16:59:57,991 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;106;113;113;112;101;113;113;105 16:59:57 INFO - 2015-11-24 16:59:57,991 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;133;159;173;136;160;161;132;165;139 16:59:57 INFO - 2015-11-24 16:59:57,991 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;165;159;160;160;161;161;162;163;161 16:59:57 INFO - 2015-11-24 16:59:57,991 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;85;93;72;72;72;118;95;73 16:59:57 INFO - 2015-11-24 16:59:57,991 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;131;93;95;94;126;94;100;138 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;109;110;109 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;146;147;145;146;146;147 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;96;96 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;70;72;70;70;70;72;69;69 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;69;69;69;69;68;69;69 16:59:57 INFO - 2015-11-24 16:59:57,992 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;84;84;82;88;84;82;83;82 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;119;126;119;117;125;128;123;132;127 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;137;167;141;159;140;148;136;142;139 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;69;68;69;69;70;70;68;69 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,981 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: __startTimestamp1448413197989__endTimestamp 16:59:57 INFO - 2015-11-24 16:59:57,993 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:113.00 stddev:4.46 (3.9%) stddev-sans-first:4.72 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 106.0 113.0 113.0 112.0 101.0 113.0 113.0 105.0 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.30 Median:159.50 stddev:14.89 (9.3%) stddev-sans-first:15.73 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: Values: 155.0 133.0 159.0 173.0 136.0 160.0 161.0 132.0 165.0 139.0 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.80 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: Values: 161.0 165.0 159.0 160.0 160.0 161.0 161.0 162.0 163.0 161.0 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.70 Median:74.00 stddev:15.35 (20.7%) stddev-sans-first:15.78 16:59:57 INFO - 2015-11-24 16:59:57,997 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 85.0 93.0 72.0 72.0 72.0 118.0 95.0 73.0 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:93.50 stddev:18.18 (19.4%) stddev-sans-first:18.78 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 131.0 93.0 95.0 94.0 126.0 94.0 100.0 138.0 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:59:57 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 147.0 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 72.0 70.0 70.0 70.0 72.0 69.0 69.0 16:59:58 INFO - 2015-11-24 16:59:57,998 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.44 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.96 (2.3%) stddev-sans-first:1.87 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 84.0 84.0 82.0 88.0 84.0 82.0 83.0 82.0 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.50 stddev:5.14 (4.1%) stddev-sans-first:4.92 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: Values: 131.0 119.0 126.0 119.0 117.0 125.0 128.0 123.0 132.0 127.0 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:145.00 stddev:10.25 (7.1%) stddev-sans-first:10.71 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: Values: 151.0 137.0 167.0 141.0 159.0 140.0 148.0 136.0 142.0 139.0 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.71 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 69.0 68.0 69.0 69.0 70.0 70.0 68.0 69.0 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:59:58 INFO - 2015-11-24 16:59:57,999 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-24 16:59:58,981 INFO : Browser exited with error code: 0 16:59:59 INFO - 2015-11-24 16:59:59,040 INFO : Completed test kraken (00:01:00) 16:59:59 INFO - 2015-11-24 16:59:59,040 INFO : Starting test v8_7 16:59:59 INFO - 2015-11-24 16:59:59,040 DEBUG : operating with platform_type : linux_ 16:59:59 INFO - 2015-11-24 16:59:59,040 INFO : Initialising browser for v8_7 test... 16:59:59 INFO - 2015-11-24 16:59:59,046 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn95_Tl/profile http://localhost:40541/getInfo.html 17:00:03 INFO - 2015-11-24 17:00:03,061 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:00:03 INFO - 2015-11-24 17:00:03,061 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:00:03 INFO - 2015-11-24 17:00:03,061 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:00:03 INFO - 2015-11-24 17:00:03,061 DEBUG : BROWSER_OUTPUT: __metrics 17:00:03 INFO - 2015-11-24 17:00:03,218 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:04 INFO - 2015-11-24 17:00:04,566 INFO : Browser initialized. 17:00:04 INFO - 2015-11-24 17:00:04,567 INFO : Running cycle 1/1 for v8_7 test... 17:00:04 INFO - 2015-11-24 17:00:04,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn95_Tl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:00:16 INFO - 2015-11-24 17:00:16,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 17:00:16 INFO - 2015-11-24 17:00:16,477 DEBUG : BROWSER_OUTPUT: 17:00:37 INFO - 2015-11-24 17:00:37,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40541/tests/v8_7/run.html (next: http://localhost:40541/tests/v8_7/run.html) 17:00:38 INFO - 2015-11-24 17:00:38,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 436629504 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |0;Richards;189.465706707086 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.71779141104295 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4970.297029702971 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |5;Earley;785.7142857142857 17:00:38 INFO - 2015-11-24 17:00:38,148 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: |8;Splay;619.4852941176471 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: __startTimestamp1448413238146__endTimestamp 17:00:38 INFO - 2015-11-24 17:00:38,149 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: Values: 189.5 17:00:38 INFO - 2015-11-24 17:00:38,150 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,151 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,152 DEBUG : BROWSER_OUTPUT: Values: 191.7 17:00:38 INFO - 2015-11-24 17:00:38,152 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,152 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,152 DEBUG : BROWSER_OUTPUT: Values: 278.5 17:00:38 INFO - 2015-11-24 17:00:38,152 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4970.30 Median:4970.30 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: Values: 4970.3 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: Values: 1966.6 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,153 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.71 Median:785.71 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: Values: 785.7 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: Values: 11952.4 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,154 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: Values: 26894.7 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.49 Median:619.49 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: Values: 619.5 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:00:38 INFO - 2015-11-24 17:00:38,155 DEBUG : BROWSER_OUTPUT: Values: 4840.6 17:00:38 INFO - 2015-11-24 17:00:38,156 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:00:38 INFO - 2015-11-24 17:00:38,156 DEBUG : BROWSER_OUTPUT: 17:00:39 INFO - 2015-11-24 17:00:39,105 INFO : Browser exited with error code: 0 17:00:39 INFO - 2015-11-24 17:00:39,120 INFO : Completed test v8_7 (00:00:40) 17:00:39 INFO - 2015-11-24 17:00:39,155 INFO : Completed test suite (00:20:17) 17:00:39 INFO - 2015-11-24 17:00:39,156 DEBUG : Working with test: dromaeo_css 17:00:39 INFO - 2015-11-24 17:00:39,156 DEBUG : Generating results file: dromaeo_css 17:00:39 INFO - 2015-11-24 17:00:39,157 DEBUG : Working with test: kraken 17:00:39 INFO - 2015-11-24 17:00:39,157 DEBUG : Generating results file: kraken 17:00:39 INFO - 2015-11-24 17:00:39,157 INFO : javascript benchmark 17:00:39 INFO - 2015-11-24 17:00:39,157 DEBUG : Working with test: v8_7 17:00:39 INFO - 2015-11-24 17:00:39,158 DEBUG : Generating results file: v8_7 17:00:39 INFO - 2015-11-24 17:00:39,158 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-11-24 17:00:39,299 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 17:00:39 INFO - 2015-11-24 17:00:39,299 DEBUG : process_Request line: dromaeo_css 6230.66 graph.html#tests=[[72,132,35]] 17:00:39 INFO - 2015-11-24 17:00:39,299 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-11-24 17:00:39,422 DEBUG : process_Request line: kraken 1524.60 graph.html#tests=[[232,132,35]] 17:00:39 INFO - 2015-11-24 17:00:39,422 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:00:39 INFO - 2015-11-24 17:00:39,549 DEBUG : process_Request line: v8_7 19586.60 graph.html#tests=[[230,132,35]] 17:00:39 INFO - 2015-11-24 17:00:39,550 INFO : javascript benchmark 17:00:39 INFO - 2015-11-24 17:00:39,554 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.6755405574304, 2681.9061332853353, 2686.476137153256, 2700.0819721294756, 2710.756031957124, 4516.54834516549, 4636.629069674426, 4657.487676355602, 4680.297955306705, 4692.061587682464, 4611.193041217782, 4617.676762626617, 4652.348671186037, 4715.693479923802, 4750.643701722376, 4295.506016808075, 4306.5262821089655, 4321.157374312011, 4377.168338015783, 4387.078713470175, 4380.0, 4436.378906953029, 4448.799804008828, 4449.5995360417555, 4451.421315229032, 4156.750594964282, 4270.316749320125, 4276.994906197041, 4389.824407023715, 4449.4660640723, 4238.258304796648, 4338.240807858612, 4342.088161486092, 4355.499117601485, 4356.172327257811, 4325.156594464081, 4328.134373125387, 4331.480222373304, 4351.216780979423, 4392.670549708785, 4516.051629157881, 4627.884302892421, 4632.374629425019, 4633.791479383436, 4650.209464391061, 4910.361652985125, 4930.1865192243595, 5022.598192144656, 5022.874428139289, 5061.873453163664, 5036.269740887551, 5037.042961837239, 5038.647294689373, 5038.823641172578, 5083.0, 4520.50274469808, 4617.422822147231, 4675.906481870344, 4677.181493238703, 4685.203515402356, 5060.165072762953, 5097.923531146962, 5159.535641792257, 5182.24857395683, 5231.0, 4910.8281210157475, 4921.704697718077, 4926.236433352836, 4927.876803079952, 4973.403191616957, 4773.188557945157, 4878.512148785093, 4989.950100499022, 4993.800247990112, 5007.974960125176, 4854.563089321978, 4922.1140194765285, 4927.728974906415, 4932.802687892444, 4941.332920055746, 4937.5556199942175, 4991.051700177028, 5003.649744517922, 5007.098722230034, 5046.0, 4019.0756126091164, 4108.6918481114035, 4187.5184353799095, 4201.474815648044, 4242.766647834337, 3550.591681956608, 3614.295212433603, 3624.873129440457, 3630.655087766711, 3660.652238037382, 4295.355696645465, 4297.054647977502, 4312.396264522969, 4337.696361254745, 4341.044970106572, 4798.928016079762, 4945.7774400152075, 4978.925316120261, 5001.524855138756, 5037.244413337955, 4244.830206791694, 4263.16868210696, 4274.166537525215, 4356.607905288476, 4383.517813040563, 4430.867073987785, 4467.352233926127, 4470.530594287618, 4472.977635111869, 4508.819647214074, 4615.100055489147, 4803.327534145153, 4811.975940120277, 4822.638302127284, 4826.975865120652, 4872.512748725099, 4887.560119589254, 4889.168841296917, 4959.752012399438, 5004.724740139181, 4755.809767609257, 4827.324174615627, 4829.323894654681, 4832.395950506187, 4858.05267972742, 4781.187198176388, 4996.675216110941, 5011.523905228997, 5014.323066385991, 5055.115354812967, 4883.90232195347, 4922.360093187863, 4928.581070609039, 4939.975300123477, 4995.125852975787, 4870.0, 4901.656884018227, 4908.312836202863, 4913.6069114471475, 4958.181899986462, 4693.812247510062, 4897.2654101885, 4897.755112244445, 4902.681325713817, 4956.727379994135, 4596.126735920165, 4642.675012749075, 4648.7443190624845, 4702.623790096853, 4721.693089949143, 4897.755112244445, 4921.26181072842, 4921.557059864629, 4927.975360123177, 4965.379327584052, 4810.927836082532, 4815.15734746425, 4818.10864989978, 4845.1520983828395, 4858.6356023297685], "unit": "ms", "name": "dojo.html", "value": 4587.607175982977}, {"lowerIsBetter": false, "replicates": [561.1890817768325, 571.9628224165428, 574.7040274258754, 577.0795581048229, 583.4777873802949, 27952.16143515695, 28454.0, 28464.57303140452, 28488.575571221434, 28502.714972850266, 28659.0, 29164.56253156199, 37658.0, 38415.42376864342, 38469.61530384696, 8042.155573664754, 8163.795905102361, 8186.877196842022, 8191.303739182176, 8192.385571082163, 7188.281171882796, 8011.519308841459, 8132.674693012273, 8133.75598732036, 8136.959315203416, 7141.500094993353, 10359.27485076045, 10629.149668026577, 10635.308704934194, 10636.361818290927, 10061.0, 10184.89815101847, 10201.67378240824, 10203.234757393226, 10206.438645874474, 7141.071660684078, 7337.046183996046, 7340.559566425978, 9946.602135914627, 10185.796284074351, 27060.729392706216, 36442.27115457702, 37152.62847371519, 37162.0, 37196.0, 2647.6699317304915, 2680.892764289426, 2691.434798692277, 2879.5824605432094, 3387.7289816814596, 26172.476550469073, 26915.46169076627, 27243.182704518895, 27275.45449091007, 27568.448631027266, 3369.578802649669, 3370.191154122993, 3394.558707368051, 3428.3828910796046, 3443.8794642187654, 202520.0, 203537.0, 203637.0, 203726.9813650937, 203939.0, 51535.48464515382, 51814.48185518172, 51814.740926295126, 51892.48107518952, 51955.48044519506, 55595.166072508946, 55682.16476752852, 55697.443025570035, 55794.72102639461, 55842.37024593388, 14219.0, 14434.711305773826, 14452.783208251885, 14481.85518144805, 14487.710245795235, 10678.1991350649, 10767.461626918623, 10775.568977240822, 10781.784364312669, 10794.24440289188, 17858.01780902037, 18027.819721802876, 18238.452846414628, 18271.08644567766, 18273.63452730938, 7234.74678386254, 7478.439117066133, 7583.886241706379, 7666.233376662289, 7685.615719214129, 826.5495305058757, 888.1207604471656, 922.5018490015451, 923.8290916180528, 964.0, 26620.60069098965, 26645.0, 26706.732932670813, 26745.0, 26750.866245668647, 888.5335199020566, 898.3846065445191, 967.9225661947028, 981.4640088261847, 1006.8389057750871, 12903.354832258537, 13060.151090179108, 13105.0, 13188.472461101448, 13345.266010369523, 200104.0, 204047.0, 204193.0, 204195.0, 204212.0, 41084.794576027525, 41331.7933410331, 41342.58657413387, 41359.1728165435, 41360.58639413567, 1162.0819552553558, 1168.8889555492215, 1171.7305019845483, 1177.0995188680665, 1188.2454641302836, 25160.245192644248, 25775.355616109748, 26449.206523804318, 26516.734832651426, 26557.734422655525, 39984.0, 40157.79921100376, 40235.1952960945, 40264.59735402608, 40307.0, 244056.0, 244106.0, 244399.55802431036, 247499.0, 247681.0, 28185.0, 28922.566161507173, 28999.565006524495, 29013.129606111852, 29018.564721529616, 38265.23469530649, 38364.80817595894, 38920.61079389283, 39105.80447097746, 39234.2153156941, 33202.5019624701, 33782.49326260059, 34192.0, 34425.311493769485, 34686.65313346834, 32813.85065081109, 33349.83325083359, 33559.66440335565, 33592.328153436305, 33716.83141584276, 27020.72979270261, 32776.83611581927, 33354.499682505266, 33432.0, 33735.662643374235, 21262.0, 28706.856465718374, 29189.416211675223, 29349.41301174007, 29472.642188624428, 22892.313230603108, 23589.29232123039, 23617.40956476102, 24019.639705404083, 25459.745402545737], "unit": "ms", "name": "ext.html", "value": 16530.38594738546}, {"lowerIsBetter": false, "replicates": [332.683950247265, 332.97336213102955, 333.70300432614977, 334.81585128179523, 337.340499323822, 12971.610851674464, 13469.595912122628, 14890.77663835042, 15273.0, 15728.21358932053, 8256.95871520643, 10040.497975101234, 10342.224333175023, 14553.636159096028, 15071.698566028674, 4466.776661166945, 4572.9314060289125, 4579.381783459224, 4588.380568623226, 4597.37935378723, 3334.333133373323, 3426.023583278766, 4373.300271956487, 4575.428071491064, 4912.877178070541, 5083.517065878754, 5091.9236211456855, 5120.8975820483565, 5123.0, 5124.1545145051205, 5085.033843569729, 5090.312807770941, 5090.516400941905, 6124.2650881894015, 6373.649449280288, 6106.511479081662, 6122.908156377658, 6125.387461253884, 6128.908066379008, 6139.140520327158, 18964.905175474036, 19781.703274450894, 19813.603727925503, 19904.900475497674, 20440.795592044185, 1807.9186436610385, 1855.3506272804545, 1869.8878067315868, 1939.2630800295797, 1972.5660354721938, 13642.0, 13726.107802992774, 13780.242086685228, 14063.367148478343, 14064.156150630995, 1746.5371676505736, 1765.48800847754, 1840.8343249107645, 1842.769653793276, 1870.2705944681586, 55904.720476397764, 56839.43160568424, 58233.12650310249, 61593.07610385803, 64773.3522664772, 14981.850181498046, 15280.617984550252, 15309.234538273042, 15322.923385383001, 15361.078335299917, 22800.201992930168, 22857.88571057134, 23187.884060579927, 23193.420164496023, 23205.071797127926, 8116.228958248957, 8338.8332233355, 8441.198086181803, 8473.0, 8526.275266602284, 6953.0, 6986.685599147949, 6996.0, 7143.071400717873, 7201.6399180041835, 7405.1484079330485, 7423.369013633794, 7442.330190282901, 7449.88825167623, 7470.0, 2249.3476891701553, 2856.61435706177, 2857.9285517862218, 2904.2448963269703, 2913.985430072836, 379.74746793382093, 380.708757800283, 875.8686197070363, 934.6635211323918, 941.5480569326625, 8602.913970860336, 8787.0, 9009.054049324857, 9094.136057074567, 9639.759006024906, 383.9539255289383, 391.85305510433585, 393.1096067407325, 401.2997319677124, 408.9795510224477, 5153.304303918923, 5235.397929238186, 5257.579393648499, 5272.288241087481, 5475.123980163155, 423764.0, 426238.0, 448505.0, 460062.0, 467320.0, 70007.0, 70333.64833175801, 71929.64035179895, 72769.63615181891, 73408.63295683487, 1027.198784947742, 1074.5325783284297, 1075.8816530181673, 1114.7213196700825, 1140.1790710688292, 13283.203007819562, 13561.525346612822, 13841.0, 13985.0, 14187.929060354632, 32329.838350808095, 32507.18732031718, 32543.34913301768, 33055.50416743799, 33181.33637327288, 38935.80532097322, 48948.265776012675, 49179.8197153246, 49405.50594494153, 50085.24872126994, 13065.869341306845, 13147.276899770222, 13172.802407963696, 13630.86369136296, 13736.175829450265, 16796.160191990595, 17609.911950440164, 17650.823491764917, 17678.292868285123, 18032.729509057113, 14357.712845742817, 14399.208043557286, 14647.560573182822, 14909.179995100374, 15148.0, 13098.803517947428, 13141.868581314064, 13260.0, 13668.726625467236, 14034.929825350808, 14079.366428510537, 14178.645533861736, 14284.642883927985, 14312.713745725236, 14580.635484112558, 13284.53504127351, 13433.66415839612, 13547.525836596065, 13757.243351615758, 13862.0, 11118.555257789598, 13275.66810829737, 13565.321733913068, 13605.183688978694, 15024.24878756036], "unit": "ms", "name": "jquery.html", "value": 8639.52908634448}, {"lowerIsBetter": false, "replicates": [1225.7180848404862, 1351.5337208663013, 1394.8605139486053, 1576.4167258114499, 1640.9589760255997, 6076.635401875885, 6264.34224406437, 6591.802245932629, 6617.503687223453, 6622.304658010899, 6699.665016749167, 6748.831279218022, 6776.695048722807, 6805.421539169164, 6841.144856892888, 2049.938501844947, 2071.2439959414783, 2072.875627462357, 2073.8548301618894, 2074.460640233535, 2036.7657719362242, 2042.5914817036578, 2052.733144691188, 2077.750669919604, 2087.269455690511, 2009.146112902018, 2028.4421784009369, 2034.389683095073, 2041.1223174035233, 2042.8672136311093, 2055.2601063617085, 2063.8555301128927, 2068.8965551722354, 2069.4722845674255, 2072.4715197624587, 2015.556577552936, 2033.2476983516194, 2035.9491012724652, 2036.8166864982222, 2037.5822956294073, 5694.601377903548, 5921.467067963861, 6743.123393958803, 6762.087118239024, 6772.322767723188, 3957.7625342479255, 4040.4949381327333, 4042.959570404317, 4045.9595404045876, 4051.1897620476025, 2648.298200976743, 2665.4269332093695, 2699.85150816707, 2716.5246081935584, 2717.252755492236, 879.4503435352905, 885.2431171348533, 902.7607683963755, 930.734740598926, 932.9440233586007, 9066.95466522663, 9175.632974681004, 9185.908140918573, 9188.908110918872, 9190.494522801244, 3640.3993341098953, 3688.3360995021153, 3709.536307961505, 3714.405695088827, 3728.794916279631, 8035.397345199133, 8045.235702608243, 8059.959700201462, 8060.959695201486, 8062.798430039179, 3896.7077469189926, 3915.5497117831246, 3931.9017024574614, 3935.311320518898, 3944.3886197639413, 3589.2462582857893, 3598.8200589970397, 3599.1901822090344, 3601.2077342984503, 3602.441621548664, 3127.202563346332, 3155.936881262362, 3159.462891308483, 3185.490321548541, 3189.1389324882616, 988.9554970026367, 991.3853410885297, 991.504247876062, 992.2954702161402, 998.236349192868, 1111.9054880335261, 1130.4008875296106, 1141.263884794303, 1149.7068247596976, 1154.3939431798206, 6248.75004999804, 6325.715342809584, 6335.461485773761, 6371.617702937839, 6375.203099612549, 427.2821659611882, 439.28396713357023, 451.46952331011585, 451.5958217395413, 453.85930361588015, 4797.856064318076, 4799.784009719571, 4841.515848415131, 4851.975740121276, 4861.465238823726, 7198.244184360671, 7837.373010159287, 8067.314278286294, 8076.4750291230885, 8089.757307280674, 7949.7217597383815, 7977.441579089524, 7979.48133371329, 7981.1220765715725, 7983.002124734408, 6191.81424557264, 6319.3364696706185, 6343.809685709436, 6345.619262844244, 6361.809145725636, 6172.506199503939, 6214.782482613087, 6218.253809542884, 6221.440070393686, 6227.532935029801, 7072.257412971564, 7402.222766609429, 7447.404207663266, 7485.176630570524, 7519.962400187964, 7492.0, 7554.848903022019, 7649.158592554703, 7686.500377475446, 7695.038120234971, 5770.740316685676, 5873.207117039145, 5895.7052147393315, 5907.2911250650195, 5937.050071988461, 6355.936440635534, 6437.485001199986, 6441.1626488556185, 6449.032645103084, 6455.096286519797, 6143.232095988002, 6247.219097612799, 6271.6550589718, 6277.654728989949, 6353.650549219838, 5814.505767009851, 5930.495907847881, 5973.611715238496, 6166.445019948226, 6178.752849885954, 6065.636061836304, 6183.412575805291, 6192.225971753531, 6200.100985357008, 6209.503239740719, 5765.625234359753, 5787.768489260382, 5809.912851307318, 5811.244538210175, 5812.505936995233, 5681.233033540584, 5692.829215123553, 5748.109043098327, 5779.624324418899, 5793.015187418233], "unit": "ms", "name": "mootools.html", "value": 3839.26017933757}, {"lowerIsBetter": false, "replicates": [303.7357498975891, 311.3834607477195, 315.70323895538206, 315.7111243212461, 316.8811695614143, 5259.973700131499, 5365.141577347626, 5377.892442151155, 5383.67697938124, 5391.865203369918, 5287.418383977769, 5338.652987555806, 5340.49265319795, 5344.732763361826, 5345.812896548621, 3996.260691772017, 4099.836006559734, 4217.072244106292, 4224.704270701052, 4230.957690423103, 4099.159672267193, 4181.121964387467, 4196.9370459443135, 4200.789960501978, 4214.072903961123, 4156.272652285853, 4166.250074986501, 4169.187008533338, 4170.728902621335, 4171.144915292373, 3957.683385329181, 4041.555428902818, 4063.187362527506, 4147.6267135957605, 4166.0834616384345, 3627.020704409821, 3630.09247688078, 3631.2011357501306, 3633.745637805355, 3643.744937854351, 5208.479152084761, 5214.348206474191, 5220.582353411718, 5225.895482090375, 5230.503102205284, 4753.9762301188275, 4762.166620841339, 4762.452317983441, 4763.785629646674, 4769.928451073237, 5481.287432633772, 5634.4365563443735, 5637.605367624268, 5643.266375371176, 5654.180143879155, 4058.431819545266, 4058.6144316289906, 4058.715889887709, 4059.472268605092, 4060.330045542482, 5962.493188079018, 5983.1623572699855, 5988.520918326567, 5990.101484777275, 5991.670458124801, 4187.6440502557625, 4188.659628918716, 4192.371144328315, 4195.664346852305, 4197.538270790211, 4161.126163505637, 4243.342281946303, 4254.468191476066, 4264.87205383839, 4280.72175308604, 4797.424309082932, 4804.231322988305, 4815.181419158752, 4816.060868130751, 4818.325434439182, 5672.489475947102, 5673.0, 5681.176229446707, 5684.118961560965, 5686.772529098873, 1488.8436714145075, 1505.570912289992, 1506.028611545547, 1506.7513860213162, 1508.58513908676, 1028.783955369366, 1030.3663247102977, 1045.5765415006783, 1059.433203236265, 1067.631667074858, 4964.751762411865, 4986.077575648516, 4989.151844186497, 5007.37407824022, 5012.774425150877, 5889.528837692974, 5894.852628684317, 5900.822975310747, 5902.527797776168, 5903.793367232212, 4950.059488697136, 4964.801407943714, 4982.476839931827, 5001.0, 5001.24981252815, 2950.173951293641, 3032.1964679359985, 3145.779795414345, 3172.0, 3209.406259841937, 5538.556915446755, 5623.044082505984, 5626.0, 5633.746481408347, 5640.097584386478, 6111.297200821962, 6117.0, 6127.571070025056, 6128.080787881853, 6132.478739307119, 5615.634983726127, 5620.606557540933, 5625.353084395265, 5629.408912064175, 5633.605647604711, 5809.215755872903, 5950.31571369298, 5957.76168953237, 5959.791407300723, 5968.820935371946, 5803.593748437569, 5810.302763668386, 5810.360860305447, 5813.82558523245, 5816.82549523515, 5615.466530679579, 5622.971885140548, 5628.058319879635, 5628.296462942132, 5630.18362337467, 4106.815193316368, 4118.341065429517, 4122.793860307032, 4125.834966601303, 4262.978685106555, 5935.821925342247, 5939.287285525765, 5941.31674857397, 5942.316633587193, 5947.078202878561, 5704.2014118024335, 5723.484886360247, 5726.4273572642405, 5736.541076713769, 5739.966805974965, 5604.271444712162, 5713.628614140068, 5713.942860571341, 5728.484436400744, 5730.968425683251, 5564.721763911869, 5573.665580065209, 5577.888442231051, 5581.330240371181, 5589.329280486368, 5737.110747833925, 5743.052396354555, 5746.396628353963, 5747.1379293106365, 5747.3103227612955, 5390.00284947286, 5411.594130440154, 5538.196961440488, 5540.972295138498, 5575.832725018256], "unit": "ms", "name": "prototype.html", "value": 4292.279498119656}, {"lowerIsBetter": false, "replicates": [645.7642960319483, 747.6486051555769, 755.1579988313033, 759.9810004749884, 776.8213310938484, 10391.4804259787, 10608.098311643509, 10633.627823026185, 10645.57417703291, 10653.201009924267, 9612.942576316616, 10928.836067458995, 11122.721931951704, 11280.943595282011, 11337.943310283457, 734.6216698400328, 752.3792870881517, 753.7701001194633, 753.7964749517627, 754.6226886556722, 737.3621817128172, 738.6934422214774, 743.4498471131378, 744.0996394362827, 746.8842329438945, 774.357283454734, 782.9060512738479, 782.909965353983, 784.725346128856, 786.4769927997875, 765.1353970013904, 770.6455030685835, 771.0246538129243, 771.814764456532, 774.0440555913442, 569.4647031790104, 570.6661602962272, 571.1404336473622, 573.2891214893543, 574.1703238819907, 9176.8623470648, 9361.906380936172, 9419.387739796892, 9436.197923176538, 9465.810683786285, 8807.07525709804, 8910.554472276424, 8969.910300896972, 9283.814323713488, 9297.209737172348, 8270.627821748036, 8293.751187464386, 8315.83368332636, 8365.912431383882, 8379.45533540318, 3152.4010438016703, 3199.632042315117, 3211.678832116793, 3226.0966929259844, 3283.4746440569634, 37796.43305350422, 38657.26042328102, 38673.41989870154, 38772.22455550873, 39716.801415993024, 8697.695580654647, 8748.650053997897, 8795.51624660637, 8803.911960880308, 8879.822403552022, 16062.839371606367, 16074.598135046717, 16145.273462694207, 16173.838261617468, 16198.514044578682, 6259.342769009279, 6355.841103972438, 6386.0, 6394.4564712, 6409.519286053564, 3458.39478091333, 3521.3133438979667, 3574.8927532174075, 3592.964070359263, 3593.7304702147444, 2669.6529451171614, 2689.354554906808, 2706.796990225741, 2707.810453268292, 2710.1327575176147, 465.7601335312317, 466.65467554009786, 473.97393143377445, 482.0503607892446, 482.7755093881362, 515.8968206358743, 523.4974424552396, 560.117814442255, 584.5849446892754, 592.8428966323928, 6964.268751781091, 6999.335063168991, 7010.964945175241, 7062.258462861429, 7136.750213742494, 453.99560938457, 455.0875494633239, 514.1208533407914, 538.9029974604609, 540.5351397797891, 3157.8105313681253, 3168.920776980548, 3176.8093914365213, 3306.173456635841, 3699.7040236780995, 47295.29057064078, 47868.76065619649, 47879.76060119747, 48002.759986199846, 50352.74823625859, 42258.0, 43088.78455607702, 44901.32648010283, 45274.773626132315, 45586.772066139456, 45268.0, 46172.538274617495, 46557.767211164406, 47608.0, 47658.285125723145, 7144.3212894774915, 7609.6575654094595, 7942.404319675932, 8048.637811298388, 8244.917550824415, 32759.67240327566, 33099.17252068718, 33194.83402582972, 33210.0, 33410.0, 40483.59516404798, 40863.387049194884, 40929.1814163721, 40994.59005409908, 41236.14437350266, 9483.478408687313, 9513.619455221991, 9615.326927115315, 9726.221902247662, 10033.147182489278, 10512.579496820348, 10524.736881578021, 10533.473326333806, 10594.205434592282, 11202.775944481227, 9265.305102117503, 9420.717378478657, 9483.241340692866, 9528.857067144138, 9683.612655493702, 9945.602175912882, 9956.20350371954, 9979.201663866728, 10002.099811017044, 10012.69961901144, 8896.288296936358, 9195.77010574741, 9331.72004839856, 9381.484018378782, 9830.459324737209, 8133.79665508367, 8606.65573377058, 8661.480311181349, 8826.779330516789, 8868.379213455255, 7858.764237072897, 8235.670573177245, 8449.28181104613, 8509.787255318666, 8568.828623427371], "unit": "ms", "name": "yui.html", "value": 5418.273367712087}], "name": "dromaeo_css", "value": 6230.657252607739}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 113.0, 113.0, 112.0, 101.0, 113.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 159.0, 173.0, 136.0, 160.0, 161.0, 132.0, 165.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 159.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 85.0, 93.0, 72.0, 72.0, 72.0, 118.0, 95.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 131.0, 93.0, 95.0, 94.0, 126.0, 94.0, 100.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 72.0, 70.0, 70.0, 70.0, 72.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 84.0, 82.0, 88.0, 84.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [131.0, 119.0, 126.0, 119.0, 117.0, 125.0, 128.0, 123.0, 132.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [151.0, 137.0, 167.0, 141.0, 159.0, 140.0, 148.0, 136.0, 142.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 68.0, 69.0, 69.0, 70.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1524.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "Richards", "value": 186.32395599999998}, {"lowerIsBetter": false, "replicates": [191.71779141104295], "unit": "score", "name": "DeltaBlue", "value": 344.87148800000006}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [4970.297029702971], "unit": "score", "name": "Decrypt", "value": 53.55434462151397}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [785.7142857142857], "unit": "score", "name": "Earley", "value": 848.2256363636362}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [619.4852941176471], "unit": "score", "name": "Splay", "value": 131.5463026706231}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19586.60496617231}]} 17:00:39 INFO - RETURN: dromaeo_css: 6230.66 17:00:39 INFO - RETURN: kraken: 1524.60 17:00:39 INFO - RETURN: v8_7: 19586.60 17:00:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19586.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1524.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6230.66"}}} 17:00:39 INFO - Return code: 0 17:00:39 INFO - # TBPL SUCCESS # 17:00:39 INFO - Running post-action listener: _resource_record_post_action 17:00:39 INFO - Running post-run listener: _resource_record_post_run 17:00:40 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516132864; Read time: 28; Write time: 548056 17:00:40 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 229203968; Read time: 0; Write time: 331116 17:00:40 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 281387008; Read time: 0; Write time: 197504 17:00:40 INFO - Running post-run listener: _upload_blobber_files 17:00:40 INFO - Blob upload gear active. 17:00:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:00:40 INFO - Copying logs to upload dir... 17:00:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.738147 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-24 17:00:40.596709) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 17:00:40.599738) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010053 build_url: 'https://queue.taskcluster.net/v1/task/_-V1y_UZT7-yis37amYgmw/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-24 17:00:40.650102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:00:40.650434) ========= 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=820bb6602ddf640013a48df2000001a9-1448409740.779638-392552977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:00:40.700422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 17:00:40.700719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 17:00:40.700996) ========= ========= Total master_lag: 0.24 =========