builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1447906947.4 results: success (0) buildid: 20151118201146 builduid: db85f176eb0544c9bdedfe7f10be2e56 revision: cae56980cbec07da0f7c28be592bff3461086520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.399870) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.400434) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.400713) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006554 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.426648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.426930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.440211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.440459) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004691 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.495918) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.496177) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.496522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.496804) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 20:22:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.7M=0s 2015-11-18 20:22:28 (47.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.683779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.684113) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016964 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.769128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:27.769428) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae56980cbec07da0f7c28be592bff3461086520 --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 cae56980cbec07da0f7c28be592bff3461086520 --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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 20:22:28,343 truncating revision to first 12 chars 2015-11-18 20:22:28,343 Setting DEBUG logging. 2015-11-18 20:22:28,343 attempt 1/10 2015-11-18 20:22:28,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae56980cbec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 20:22:28,596 unpacking tar archive at: fx-team-cae56980cbec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:28.324319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:28.324599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:28.332152) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:28.332404) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 20:22:28.332782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-18 20:22:28.333065) ========= /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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:28 INFO - MultiFileLogger online at 20151118 20:22:28 in /builds/slave/test 20:22:28 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 20:22:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:28 INFO - {'append_to_log': False, 20:22:28 INFO - 'base_work_dir': '/builds/slave/test', 20:22:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:22:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:28 INFO - 'branch': 'Fx-Team-Non-PGO', 20:22:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:28 INFO - 'config_files': ('talos/linux_config.py',), 20:22:28 INFO - 'default_actions': ('clobber', 20:22:28 INFO - 'read-buildbot-config', 20:22:28 INFO - 'download-and-extract', 20:22:28 INFO - 'populate-webroot', 20:22:28 INFO - 'create-virtualenv', 20:22:28 INFO - 'install', 20:22:28 INFO - 'run-tests'), 20:22:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:28 INFO - 'download_minidump_stackwalk': True, 20:22:28 INFO - 'download_symbols': 'ondemand', 20:22:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:28 INFO - 'installer_path': 'installer.exe', 20:22:28 INFO - 'log_level': 'info', 20:22:28 INFO - 'log_name': 'talos', 20:22:28 INFO - 'log_to_console': True, 20:22:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:28 INFO - 'opt_config_files': (), 20:22:28 INFO - 'pip_index': False, 20:22:28 INFO - 'sps_profile': False, 20:22:28 INFO - 'sps_profile_interval': 0, 20:22:28 INFO - 'suite': 'dromaeojs', 20:22:28 INFO - 'system_bits': '64', 20:22:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:28 INFO - 'title': 'talos-linux64-ix-034', 20:22:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:28 INFO - 'use_talos_json': True, 20:22:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:28 INFO - 'work_dir': 'build'} 20:22:28 INFO - ##### 20:22:28 INFO - ##### Running clobber step. 20:22:28 INFO - ##### 20:22:28 INFO - Running pre-action listener: _resource_record_pre_action 20:22:28 INFO - Running main action method: clobber 20:22:28 INFO - rmtree: /builds/slave/test/build 20:22:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:29 INFO - Running post-action listener: _resource_record_post_action 20:22:29 INFO - ##### 20:22:29 INFO - ##### Running read-buildbot-config step. 20:22:29 INFO - ##### 20:22:29 INFO - Running pre-action listener: _resource_record_pre_action 20:22:29 INFO - Running main action method: read_buildbot_config 20:22:29 INFO - Using buildbot properties: 20:22:29 INFO - { 20:22:29 INFO - "properties": { 20:22:29 INFO - "buildnumber": 1108, 20:22:29 INFO - "product": "firefox", 20:22:29 INFO - "script_repo_revision": "production", 20:22:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:22:29 INFO - "repository": "", 20:22:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:22:29 INFO - "buildid": "20151118201146", 20:22:29 INFO - "slavename": "talos-linux64-ix-034", 20:22:29 INFO - "pgo_build": "False", 20:22:29 INFO - "basedir": "/builds/slave/test", 20:22:29 INFO - "project": "", 20:22:29 INFO - "platform": "ubuntu64_hw", 20:22:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:22:29 INFO - "slavebuilddir": "test", 20:22:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:22:29 INFO - "branch": "fx-team", 20:22:29 INFO - "repo_path": "integration/fx-team", 20:22:29 INFO - "stage_platform": "linux64", 20:22:29 INFO - "builduid": "db85f176eb0544c9bdedfe7f10be2e56", 20:22:29 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 20:22:29 INFO - }, 20:22:29 INFO - "sourcestamp": { 20:22:29 INFO - "repository": "", 20:22:29 INFO - "hasPatch": false, 20:22:29 INFO - "project": "", 20:22:29 INFO - "branch": "fx-team-linux64-talos", 20:22:29 INFO - "changes": [ 20:22:29 INFO - { 20:22:29 INFO - "category": null, 20:22:29 INFO - "files": [ 20:22:29 INFO - { 20:22:29 INFO - "url": null, 20:22:29 INFO - "name": "https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:22:29 INFO - } 20:22:29 INFO - ], 20:22:29 INFO - "repository": "", 20:22:29 INFO - "rev": "cae56980cbec07da0f7c28be592bff3461086520", 20:22:29 INFO - "who": "mconley@mozilla.com", 20:22:29 INFO - "when": 1447906894, 20:22:29 INFO - "number": 6680903, 20:22:29 INFO - "comments": "Bug 1171708 - Add tests for async window flushing. r=billm", 20:22:29 INFO - "project": "", 20:22:29 INFO - "at": "Wed 18 Nov 2015 20:21:34", 20:22:29 INFO - "branch": "fx-team-linux64-talos", 20:22:29 INFO - "revlink": "", 20:22:29 INFO - "properties": [ 20:22:29 INFO - [ 20:22:29 INFO - "buildid", 20:22:29 INFO - "20151118201146", 20:22:29 INFO - "Change" 20:22:29 INFO - ], 20:22:29 INFO - [ 20:22:29 INFO - "builduid", 20:22:29 INFO - "db85f176eb0544c9bdedfe7f10be2e56", 20:22:29 INFO - "Change" 20:22:29 INFO - ], 20:22:29 INFO - [ 20:22:29 INFO - "pgo_build", 20:22:29 INFO - "False", 20:22:29 INFO - "Change" 20:22:29 INFO - ] 20:22:29 INFO - ], 20:22:29 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 20:22:29 INFO - } 20:22:29 INFO - ], 20:22:29 INFO - "revision": "cae56980cbec07da0f7c28be592bff3461086520" 20:22:29 INFO - } 20:22:29 INFO - } 20:22:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:22:29 INFO - Running post-action listener: _resource_record_post_action 20:22:29 INFO - ##### 20:22:29 INFO - ##### Running download-and-extract step. 20:22:29 INFO - ##### 20:22:29 INFO - Running pre-action listener: _resource_record_pre_action 20:22:29 INFO - Running main action method: download_and_extract 20:22:29 INFO - mkdir: /builds/slave/test/build/tests 20:22:29 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')]} 20:22:29 INFO - https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/test_packages.json 20:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/test_packages.json 20:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:22:34 INFO - Downloaded 1302 bytes. 20:22:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:22:34 INFO - Using the following test package requirements: 20:22:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'jsshell-linux-x86_64.zip'], 20:22:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:34 INFO - https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:35 INFO - Downloaded 21291871 bytes. 20:22:35 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 20:22:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:35 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 20:22:36 INFO - Return code: 0 20:22:36 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 20:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:36 INFO - https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:39 INFO - Downloaded 21291871 bytes. 20:22:39 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 20:22:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:22:39 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 20:22:40 INFO - Return code: 0 20:22:40 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')]} 20:22:40 INFO - https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:41 INFO - Downloaded 11130997 bytes. 20:22:41 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 20:22:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:41 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 20:22:41 INFO - Return code: 0 20:22:41 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')]} 20:22:41 INFO - https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l8VVvdn7QVmCgovEew2W1w/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 20:22:43 INFO - Downloaded 55664684 bytes. 20:22:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:43 INFO - mkdir: /builds/slave/test/properties 20:22:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:43 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:43 INFO - Contents: 20:22:43 INFO - build_url:https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:22:43 INFO - Running post-action listener: _resource_record_post_action 20:22:43 INFO - Running post-action listener: set_extra_try_arguments 20:22:43 INFO - ##### 20:22:43 INFO - ##### Running populate-webroot step. 20:22:43 INFO - ##### 20:22:43 INFO - Running pre-action listener: _resource_record_pre_action 20:22:43 INFO - Running main action method: populate_webroot 20:22:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:22:43 INFO - '../fennec_ids.txt'], 20:22:43 INFO - 'tests': ['tcheck2']}, 20:22:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:43 INFO - '--tppagecycles', 20:22:43 INFO - '7'], 20:22:43 INFO - 'tests': ['tsvgm']}}, 20:22:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:22:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:22:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:22:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'tests': ['damp', 'tps']}, 20:22:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['damp', 'tps']}, 20:22:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:22:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:43 INFO - 'other': {'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'other_l64': {'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'other_nol64': {'tests': ['a11yr', 20:22:43 INFO - 'ts_paint', 20:22:43 INFO - 'tpaint', 20:22:43 INFO - 'sessionrestore', 20:22:43 INFO - 'sessionrestore_no_auto_restore']}, 20:22:43 INFO - 'svgr': {'tests': ['tsvgx', 20:22:43 INFO - 'tsvgr_opacity', 20:22:43 INFO - 'tart', 20:22:43 INFO - 'tscrollx', 20:22:43 INFO - 'cart']}, 20:22:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['tsvgx', 20:22:43 INFO - 'tsvgr_opacity', 20:22:43 INFO - 'tart', 20:22:43 INFO - 'tscrollx', 20:22:43 INFO - 'cart']}, 20:22:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'tests': ['tp5o']}, 20:22:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'talos_options': ['--e10s'], 20:22:43 INFO - 'tests': ['tp5o']}, 20:22:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'talos_options': ['--xperf_path', 20:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:43 INFO - 'tests': ['tp5n']}, 20:22:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:43 INFO - 'talos_options': ['--e10s', 20:22:43 INFO - '--xperf_path', 20:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:43 INFO - 'tests': ['tp5n']}}, 20:22:43 INFO - 'talos.zip': {'path': '', 20:22:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:43 INFO - Running post-action listener: _resource_record_post_action 20:22:43 INFO - ##### 20:22:43 INFO - ##### Running create-virtualenv step. 20:22:43 INFO - ##### 20:22:43 INFO - Running pre-action listener: _resource_record_pre_action 20:22:43 INFO - Running main action method: create_virtualenv 20:22:43 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:43 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 20:22:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:43 INFO - Using real prefix '/usr' 20:22:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:44 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:46 INFO - Installing pip.................done. 20:22:46 INFO - Return code: 0 20:22:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22:46 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 20:22:46 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 20:22:46 INFO - Using env: {'DISPLAY': ':0', 20:22:46 INFO - 'HOME': '/home/cltbld', 20:22:46 INFO - 'LANG': 'en_US.UTF-8', 20:22:46 INFO - 'LANGUAGE': 'en_US:en', 20:22:46 INFO - 'LOGNAME': 'cltbld', 20:22:46 INFO - 'MAIL': '/var/mail/cltbld', 20:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:46 INFO - 'MOZ_NO_REMOTE': '1', 20:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:46 INFO - 'NO_EM_RESTART': '1', 20:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:46 INFO - 'PWD': '/builds/slave/test', 20:22:46 INFO - 'SHELL': '/bin/bash', 20:22:46 INFO - 'SHLVL': '1', 20:22:46 INFO - 'TERM': 'linux', 20:22:46 INFO - 'TMOUT': '86400', 20:22:46 INFO - 'USER': 'cltbld', 20:22:46 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:46 INFO - '_': '/tools/buildbot/bin/python'} 20:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:46 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 20:22:46 INFO - Cleaning up... 20:22:46 INFO - Return code: 0 20:22:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22:46 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 20:22:46 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 20:22:46 INFO - Using env: {'DISPLAY': ':0', 20:22:46 INFO - 'HOME': '/home/cltbld', 20:22:46 INFO - 'LANG': 'en_US.UTF-8', 20:22:46 INFO - 'LANGUAGE': 'en_US:en', 20:22:46 INFO - 'LOGNAME': 'cltbld', 20:22:46 INFO - 'MAIL': '/var/mail/cltbld', 20:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:46 INFO - 'MOZ_NO_REMOTE': '1', 20:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:46 INFO - 'NO_EM_RESTART': '1', 20:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:46 INFO - 'PWD': '/builds/slave/test', 20:22:46 INFO - 'SHELL': '/bin/bash', 20:22:46 INFO - 'SHLVL': '1', 20:22:46 INFO - 'TERM': 'linux', 20:22:46 INFO - 'TMOUT': '86400', 20:22:46 INFO - 'USER': 'cltbld', 20:22:46 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:46 INFO - '_': '/tools/buildbot/bin/python'} 20:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:46 INFO - Downloading/unpacking psutil>=0.7.1 20:22:46 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 20:22:46 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 20:22:46 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 20:22:46 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 20:22:46 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 20:22:46 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 20:22:48 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:22:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:48 INFO - Installing collected packages: psutil 20:22:48 INFO - Running setup.py install for psutil 20:22:48 INFO - building 'psutil._psutil_linux' extension 20:22:48 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 20:22:48 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 20:22:48 INFO - building 'psutil._psutil_posix' extension 20:22:48 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 20:22:49 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 20:22:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:49 INFO - Successfully installed psutil 20:22:49 INFO - Cleaning up... 20:22:49 INFO - Return code: 0 20:22:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:49 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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22:49 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 20:22:49 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 20:22:49 INFO - Using env: {'DISPLAY': ':0', 20:22:49 INFO - 'HOME': '/home/cltbld', 20:22:49 INFO - 'LANG': 'en_US.UTF-8', 20:22:49 INFO - 'LANGUAGE': 'en_US:en', 20:22:49 INFO - 'LOGNAME': 'cltbld', 20:22:49 INFO - 'MAIL': '/var/mail/cltbld', 20:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:49 INFO - 'MOZ_NO_REMOTE': '1', 20:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:49 INFO - 'NO_EM_RESTART': '1', 20:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:49 INFO - 'PWD': '/builds/slave/test', 20:22:49 INFO - 'SHELL': '/bin/bash', 20:22:49 INFO - 'SHLVL': '1', 20:22:49 INFO - 'TERM': 'linux', 20:22:49 INFO - 'TMOUT': '86400', 20:22:49 INFO - 'USER': 'cltbld', 20:22:49 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:49 INFO - '_': '/tools/buildbot/bin/python'} 20:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:22:49 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 20:22:49 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 20:22:49 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 20:22:49 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 20:22:49 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 20:22:49 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 20:22:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:22:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:22:51 INFO - Installing collected packages: mozsystemmonitor 20:22:51 INFO - Running setup.py install for mozsystemmonitor 20:22:51 INFO - Successfully installed mozsystemmonitor 20:22:51 INFO - Cleaning up... 20:22:51 INFO - Return code: 0 20:22:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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', '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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:22: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 blobuploader==1.2.4 20:22:51 INFO - Using env: {'DISPLAY': ':0', 20:22:51 INFO - 'HOME': '/home/cltbld', 20:22:51 INFO - 'LANG': 'en_US.UTF-8', 20:22:51 INFO - 'LANGUAGE': 'en_US:en', 20:22:51 INFO - 'LOGNAME': 'cltbld', 20:22:51 INFO - 'MAIL': '/var/mail/cltbld', 20:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:51 INFO - 'MOZ_NO_REMOTE': '1', 20:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:51 INFO - 'NO_EM_RESTART': '1', 20:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:51 INFO - 'PWD': '/builds/slave/test', 20:22:51 INFO - 'SHELL': '/bin/bash', 20:22:51 INFO - 'SHLVL': '1', 20:22:51 INFO - 'TERM': 'linux', 20:22:51 INFO - 'TMOUT': '86400', 20:22:51 INFO - 'USER': 'cltbld', 20:22:51 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:51 INFO - '_': '/tools/buildbot/bin/python'} 20:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:22:51 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 20:22:51 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 20:22:51 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 20:22:51 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 20:22:51 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 20:22:51 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 20:22:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:22:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:22:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:22:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 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 20:22:53 INFO - Downloading docopt-0.6.1.tar.gz 20:22:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 20:22:53 INFO - Running setup.py install for blobuploader 20:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:22:53 INFO - Running setup.py install for requests 20:22:54 INFO - Running setup.py install for docopt 20:22:54 INFO - Successfully installed blobuploader requests docopt 20:22:54 INFO - Cleaning up... 20:22:54 INFO - Return code: 0 20:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22: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')]} 20:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:54 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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22:54 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 20:22:54 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 20:22:54 INFO - Using env: {'DISPLAY': ':0', 20:22:54 INFO - 'HOME': '/home/cltbld', 20:22:54 INFO - 'LANG': 'en_US.UTF-8', 20:22:54 INFO - 'LANGUAGE': 'en_US:en', 20:22:54 INFO - 'LOGNAME': 'cltbld', 20:22:54 INFO - 'MAIL': '/var/mail/cltbld', 20:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:54 INFO - 'MOZ_NO_REMOTE': '1', 20:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:54 INFO - 'NO_EM_RESTART': '1', 20:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:54 INFO - 'PWD': '/builds/slave/test', 20:22:54 INFO - 'SHELL': '/bin/bash', 20:22:54 INFO - 'SHLVL': '1', 20:22:54 INFO - 'TERM': 'linux', 20:22:54 INFO - 'TMOUT': '86400', 20:22:54 INFO - 'USER': 'cltbld', 20:22:54 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:54 INFO - '_': '/tools/buildbot/bin/python'} 20:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:54 INFO - Running setup.py (path:/tmp/pip-UnOfLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:54 INFO - Running setup.py (path:/tmp/pip-6evOUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:54 INFO - Running setup.py (path:/tmp/pip-nBqb8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:54 INFO - Running setup.py (path:/tmp/pip-ZWlIMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:54 INFO - Running setup.py (path:/tmp/pip-ggpUQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:54 INFO - Running setup.py (path:/tmp/pip-FHsegv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:55 INFO - Running setup.py (path:/tmp/pip-yiRYge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:55 INFO - Running setup.py (path:/tmp/pip-q0ao0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:55 INFO - Running setup.py (path:/tmp/pip-iFh8Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:55 INFO - Running setup.py (path:/tmp/pip-wITooM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:55 INFO - Running setup.py (path:/tmp/pip-Gwk0ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:55 INFO - Running setup.py (path:/tmp/pip-bLTz8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:55 INFO - Running setup.py (path:/tmp/pip-nNTOnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:55 INFO - Running setup.py (path:/tmp/pip-CEzMVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:55 INFO - Running setup.py (path:/tmp/pip-mVU7il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:55 INFO - Running setup.py (path:/tmp/pip-U_hsr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:55 INFO - Running setup.py (path:/tmp/pip-Q6R2da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:22:55 INFO - Running setup.py install for manifestparser 20:22:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:22:55 INFO - Running setup.py install for mozcrash 20:22:56 INFO - Running setup.py install for mozdebug 20:22:56 INFO - Running setup.py install for mozdevice 20:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for mozfile 20:22:56 INFO - Running setup.py install for mozhttpd 20:22:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for mozinfo 20:22:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for mozInstall 20:22:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for mozleak 20:22:56 INFO - Running setup.py install for mozlog 20:22:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for moznetwork 20:22:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:22:56 INFO - Running setup.py install for mozprocess 20:22:57 INFO - Running setup.py install for mozprofile 20:22:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:22:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:22:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:22:57 INFO - Running setup.py install for mozrunner 20:22:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:22:57 INFO - Running setup.py install for mozscreenshot 20:22:57 INFO - Running setup.py install for moztest 20:22:57 INFO - Running setup.py install for mozversion 20:22:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:22:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:22:57 INFO - Cleaning up... 20:22:57 INFO - Return code: 0 20:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:57 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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:22:57 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 20:22:57 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 20:22:57 INFO - Using env: {'DISPLAY': ':0', 20:22:57 INFO - 'HOME': '/home/cltbld', 20:22:57 INFO - 'LANG': 'en_US.UTF-8', 20:22:57 INFO - 'LANGUAGE': 'en_US:en', 20:22:57 INFO - 'LOGNAME': 'cltbld', 20:22:57 INFO - 'MAIL': '/var/mail/cltbld', 20:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:57 INFO - 'MOZ_NO_REMOTE': '1', 20:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:57 INFO - 'NO_EM_RESTART': '1', 20:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:57 INFO - 'PWD': '/builds/slave/test', 20:22:57 INFO - 'SHELL': '/bin/bash', 20:22:57 INFO - 'SHLVL': '1', 20:22:57 INFO - 'TERM': 'linux', 20:22:57 INFO - 'TMOUT': '86400', 20:22:57 INFO - 'USER': 'cltbld', 20:22:57 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:57 INFO - '_': '/tools/buildbot/bin/python'} 20:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:57 INFO - Running setup.py (path:/tmp/pip-ANkcwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:57 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)) 20:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:57 INFO - Running setup.py (path:/tmp/pip-Pxk2Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:58 INFO - Running setup.py (path:/tmp/pip-0eES_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:58 INFO - Running setup.py (path:/tmp/pip-nixolC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:58 INFO - Running setup.py (path:/tmp/pip-nNgxur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:58 INFO - Running setup.py (path:/tmp/pip-Z50eQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:58 INFO - Running setup.py (path:/tmp/pip-QQ4KhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:58 INFO - Running setup.py (path:/tmp/pip-dxPz6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:58 INFO - Running setup.py (path:/tmp/pip-XYvScd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:58 INFO - Running setup.py (path:/tmp/pip-slsDdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:58 INFO - Running setup.py (path:/tmp/pip-Og1vi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:58 INFO - Running setup.py (path:/tmp/pip-nwZ1v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:58 INFO - Running setup.py (path:/tmp/pip-e4w081-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:58 INFO - Running setup.py (path:/tmp/pip-3mzHAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:58 INFO - Running setup.py (path:/tmp/pip-VXRr78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:58 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)) 20:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:58 INFO - Running setup.py (path:/tmp/pip-kWBV6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:59 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)) 20:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:59 INFO - Running setup.py (path:/tmp/pip-D8qb1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:59 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)) 20:22:59 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)) 20:22:59 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)) 20:22:59 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)) 20:22:59 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)) 20:22:59 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)) 20:22:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:23:00 INFO - Downloading blessings-1.5.1.tar.gz 20:23:00 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 20:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:23:00 INFO - Installing collected packages: blessings 20:23:00 INFO - Running setup.py install for blessings 20:23:00 INFO - Successfully installed blessings 20:23:00 INFO - Cleaning up... 20:23:01 INFO - Return code: 0 20:23:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:01 INFO - Reading from file tmpfile_stdout 20:23:01 INFO - Current package versions: 20:23:01 INFO - argparse == 1.2.1 20:23:01 INFO - blessings == 1.5.1 20:23:01 INFO - blobuploader == 1.2.4 20:23:01 INFO - docopt == 0.6.1 20:23:01 INFO - manifestparser == 1.1 20:23:01 INFO - mozInstall == 1.12 20:23:01 INFO - mozcrash == 0.16 20:23:01 INFO - mozdebug == 0.1 20:23:01 INFO - mozdevice == 0.47 20:23:01 INFO - mozfile == 1.2 20:23:01 INFO - mozhttpd == 0.7 20:23:01 INFO - mozinfo == 0.9 20:23:01 INFO - mozleak == 0.1 20:23:01 INFO - mozlog == 3.0 20:23:01 INFO - moznetwork == 0.27 20:23:01 INFO - mozprocess == 0.22 20:23:01 INFO - mozprofile == 0.27 20:23:01 INFO - mozrunner == 6.11 20:23:01 INFO - mozscreenshot == 0.1 20:23:01 INFO - mozsystemmonitor == 0.0 20:23:01 INFO - moztest == 0.7 20:23:01 INFO - mozversion == 1.4 20:23:01 INFO - psutil == 3.1.1 20:23:01 INFO - requests == 1.2.3 20:23:01 INFO - wsgiref == 0.1.2 20:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f992671bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24156c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', '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 20:23:01 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 20:23:01 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 20:23:01 INFO - Using env: {'DISPLAY': ':0', 20:23:01 INFO - 'HOME': '/home/cltbld', 20:23:01 INFO - 'LANG': 'en_US.UTF-8', 20:23:01 INFO - 'LANGUAGE': 'en_US:en', 20:23:01 INFO - 'LOGNAME': 'cltbld', 20:23:01 INFO - 'MAIL': '/var/mail/cltbld', 20:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:01 INFO - 'MOZ_NO_REMOTE': '1', 20:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:01 INFO - 'NO_EM_RESTART': '1', 20:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:01 INFO - 'PWD': '/builds/slave/test', 20:23:01 INFO - 'SHELL': '/bin/bash', 20:23:01 INFO - 'SHLVL': '1', 20:23:01 INFO - 'TERM': 'linux', 20:23:01 INFO - 'TMOUT': '86400', 20:23:01 INFO - 'USER': 'cltbld', 20:23:01 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:01 INFO - '_': '/tools/buildbot/bin/python'} 20:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 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)) 20:23:01 INFO - Cleaning up... 20:23:01 INFO - Return code: 0 20:23:01 INFO - Running post-action listener: _resource_record_post_action 20:23:01 INFO - Running post-action listener: _start_resource_monitoring 20:23:01 INFO - Starting resource monitoring. 20:23:01 INFO - ##### 20:23:01 INFO - ##### Running install step. 20:23:01 INFO - ##### 20:23:01 INFO - Running pre-action listener: _resource_record_pre_action 20:23:01 INFO - Running main action method: install 20:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:01 INFO - Reading from file tmpfile_stdout 20:23:01 INFO - Detecting whether we're running mozinstall >=1.0... 20:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:23:01 INFO - Reading from file tmpfile_stdout 20:23:01 INFO - Output received: 20:23:01 INFO - Usage: mozinstall [options] installer 20:23:01 INFO - Options: 20:23:01 INFO - -h, --help show this help message and exit 20:23:01 INFO - -d DEST, --destination=DEST 20:23:01 INFO - Directory to install application into. [default: 20:23:01 INFO - "/builds/slave/test"] 20:23:01 INFO - --app=APP Application being installed. [default: firefox] 20:23:01 INFO - mkdir: /builds/slave/test/build/application 20:23:01 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'] 20:23:01 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 20:23:15 INFO - Reading from file tmpfile_stdout 20:23:15 INFO - Output received: 20:23:15 INFO - /builds/slave/test/build/application/firefox/firefox 20:23:15 INFO - Running post-action listener: _resource_record_post_action 20:23:15 INFO - ##### 20:23:15 INFO - ##### Running run-tests step. 20:23:15 INFO - ##### 20:23:15 INFO - Running pre-action listener: _resource_record_pre_action 20:23:15 INFO - Running main action method: run_tests 20:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:23:15 INFO - Python 2.7.3 20:23:15 INFO - Return code: 0 20:23:15 INFO - grabbing minidump binary from tooltool 20:23:15 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')]} 20:23:15 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 0x250cb70>, '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 0x255ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255e250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:23:15 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 20:23:15 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 20:23:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:23:15 INFO - Return code: 0 20:23:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:23:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:23:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:23:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:23:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:23:15 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/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test/build 20:23:15 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/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 20:23:15 INFO - Using env: {'DISPLAY': ':0', 20:23:15 INFO - 'HOME': '/home/cltbld', 20:23:15 INFO - 'LANG': 'en_US.UTF-8', 20:23:15 INFO - 'LANGUAGE': 'en_US:en', 20:23:15 INFO - 'LOGNAME': 'cltbld', 20:23:15 INFO - 'MAIL': '/var/mail/cltbld', 20:23:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:23:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:15 INFO - 'MOZ_NO_REMOTE': '1', 20:23:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:15 INFO - 'NO_EM_RESTART': '1', 20:23:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:15 INFO - 'PWD': '/builds/slave/test', 20:23:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:23:15 INFO - 'SHELL': '/bin/bash', 20:23:15 INFO - 'SHLVL': '1', 20:23:15 INFO - 'TERM': 'linux', 20:23:15 INFO - 'TMOUT': '86400', 20:23:15 INFO - 'USER': 'cltbld', 20:23:15 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492', 20:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:15 INFO - '_': '/tools/buildbot/bin/python'} 20:23:15 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/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 20:23:16 INFO - mozversion INFO | application_buildid: 20151118201146 20:23:16 INFO - mozversion INFO | application_changeset: cae56980cbec07da0f7c28be592bff3461086520 20:23:16 INFO - mozversion INFO | application_display_name: Nightly 20:23:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:23:16 INFO - mozversion INFO | application_name: Firefox 20:23:16 INFO - mozversion INFO | application_remotingname: firefox 20:23:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:23:16 INFO - mozversion INFO | application_vendor: Mozilla 20:23:16 INFO - mozversion INFO | application_version: 45.0a1 20:23:16 INFO - mozversion INFO | platform_buildid: 20151118201146 20:23:16 INFO - mozversion INFO | platform_changeset: cae56980cbec07da0f7c28be592bff3461086520 20:23:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:23:16 INFO - mozversion INFO | platform_version: 45.0a1 20:23:16 INFO - 2015-11-18 20:23:16,103 DEBUG : using testdate: 1447906996 20:23:16 INFO - 2015-11-18 20:23:16,103 DEBUG : actual date: 1447906996 20:23:16 INFO - 2015-11-18 20:23:16,116 INFO : starting webserver on 'localhost:37249' 20:23:16 INFO - 2015-11-18 20:23:16,117 INFO : Starting test suite talos-linux64-ix-034 20:23:16 INFO - 2015-11-18 20:23:16,117 INFO : Starting test dromaeo_css 20:23:16 INFO - 2015-11-18 20:23:16,117 DEBUG : operating with platform_type : linux_ 20:23:16 INFO - 2015-11-18 20:23:16,118 INFO : Initialising browser for dromaeo_css test... 20:23:16 INFO - 2015-11-18 20:23:16,130 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLj7CP/profile http://localhost:37249/getInfo.html 20:23:20 INFO - 2015-11-18 20:23:20,741 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:23:20 INFO - 2015-11-18 20:23:20,741 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:23:20 INFO - 2015-11-18 20:23:20,741 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:23:20 INFO - 2015-11-18 20:23:20,741 DEBUG : BROWSER_OUTPUT: __metrics 20:23:20 INFO - 2015-11-18 20:23:20,866 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:22 INFO - 2015-11-18 20:23:22,298 INFO : Browser initialized. 20:23:22 INFO - 2015-11-18 20:23:22,299 INFO : Running cycle 1/1 for dromaeo_css test... 20:23:22 INFO - 2015-11-18 20:23:22,299 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLj7CP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:23:34 INFO - 2015-11-18 20:23:34,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 20:23:34 INFO - 2015-11-18 20:23:34,193 DEBUG : BROWSER_OUTPUT: 20:24:25 INFO - 2015-11-18 20:24:25,485 DEBUG : BROWSER_OUTPUT: 1447907065484 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] 20:26:37 INFO - 2015-11-18 20:26:37,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37249/tests/dromaeo/cssquery-ext.html) 20:26:38 INFO - 2015-11-18 20:26:38,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 227168256 20:26:38 INFO - 2015-11-18 20:26:38,541 DEBUG : BROWSER_OUTPUT: 20:29:40 INFO - 2015-11-18 20:29:40,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-ext.html (next: http://localhost:37249/tests/dromaeo/cssquery-jquery.html) 20:29:41 INFO - 2015-11-18 20:29:41,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 218304512 20:29:41 INFO - 2015-11-18 20:29:41,511 DEBUG : BROWSER_OUTPUT: 20:32:43 INFO - 2015-11-18 20:32:43,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37249/tests/dromaeo/cssquery-mootools.html) 20:32:44 INFO - 2015-11-18 20:32:44,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 212066304 20:32:44 INFO - 2015-11-18 20:32:44,084 DEBUG : BROWSER_OUTPUT: 20:35:46 INFO - 2015-11-18 20:35:46,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37249/tests/dromaeo/cssquery-prototype.html) 20:35:46 INFO - 2015-11-18 20:35:46,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 197746688 20:35:46 INFO - 2015-11-18 20:35:46,628 DEBUG : BROWSER_OUTPUT: 20:38:49 INFO - 2015-11-18 20:38:49,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37249/tests/dromaeo/cssquery-yui.html) 20:38:49 INFO - 2015-11-18 20:38:49,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 205254656 20:38:49 INFO - 2015-11-18 20:38:49,922 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/dromaeo/cssquery-yui.html (next: http://localhost:37249/tests/dromaeo/cssquery-dojo.html) 20:41:52 INFO - 2015-11-18 20:41:52,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 249884672 20:41:52 INFO - 2015-11-18 20:41:52,467 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2665.5335316319647;2742.3829638331367;2763.2953596832804;2777.2362600284905;2788.3308006078546;4464.687471876961;4595.264757638778;4660.62714982801;4773.809047638095;4831.637627177958;4646.349511068444;4693.812247510095;4746.477887432388;4747.76261186941;4754.38193034905;4280.914381712364;4283.293256612656;4359.651227901761;4457.264551349023;4488.259437192859;4076.3070278052655;4428;4439.644828413735;4476.37330773692;4508.774561271924;4233.153369326147;4292.7424354538825;4353.455818022747;4363.040131171138;4376.912461750747;4296.484421869364;4312.698111132222;4314.439122914001;4322.567743225683;4362.781860906942;4119.361498967664;4250.511191213019;4278.037441575651;4289.1850548395705;4338.089001309729;4544.931826022579;4615.976920115411;4656.650751193674;4658.114958157939;4664.883377915546;5092.541671249568;5094.617903657204;5098.260752190911;5115.948840511622;5135.152699804527;4785.282207668843;5106.157484015133;5115.386153661584;5119.488051194888;5128.282040514331;4636.466806317283;4651.813927442899;4700.271457924027;4781.760911954389;4820.879478013007;5303.496167864047;5312.282841816383;5317.255584218213;5327.067763141435;5363.088274993261;4659.277811939155;5072.442031376546;5093.694378337312;5102.387713474407;5131.461196574381;4974;5037.647364684511;5053.191489361684;5057.974710126426;5116.386033675983;5001.7499125043605;5017.54842064216;5018.799248030038;5019.949800502021;5067.467915868854;4975.278584605212;4978.800847966113;4983.90032199354;5007.974960125249;5032.672876263031;4071.572484889044;4178.958210417918;4181.038361176947;4181.289180839264;4186.853460128881;3615.6565126312958;3671.0455281626437;3682.9263414731554;3693.7229707772026;3762.3415902217002;4396.758178300161;4414.09511050234;4416.293393057095;4424.181526417558;4465.575770301816;5140.845774626767;5167.664101833444;5183.922241166386;5184.766685499161;5221.295125158131;4147.315692910696;4254.404383386328;4256.723312984646;4275.166342563232;4369.213541562485;4512.774361281989;4524.0951809637545;4532.206863798822;4535.4103966484145;4570.200214962369;4801.4718380977365;4801.591864691541;4814.807407703653;4818.469968303484;4843.418789745253;4738.455077665974;4840.7337596432535;4851.660383773102;5070.4676009019995;5093.0577843099145;4816.060868130821;4887.047025829929;4889.975550122226;4905.705657660552;4938.358013458227;5009.298698182184;5039.6220283479615;5044.873878153076;5047.091523525653;5095.566876815364;4801.375821143229;4908.993656300521;4914.631402644887;5134.460881607378;5135.075686376488;4853.369062022056;4898.779554919965;4903.509649035068;4910.7544622768;4916.532929371704;4827.106985207748;4837.395325584302;4844.709317440824;4878.707277563358;4886.560209581155;4534.365188873627;4615.792289347055;4640.628749700083;4749.643776716829;4822.059698358927;4777.522247775195;4827.734474603931;4836.758162091952;4843.806247750051;4878.682885612424;4849.030193961151;4912.901741965212;4913.65604407688;4918.95081049185;4954.20732682769 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.4817922973176;551.4099913092992;578.846605649503;580.5993864233678;585.4789237578555;25434.49131017381;25981.350466238353;37252.44121338182;37941.24117517648;37954.8102259489;40927.38608920861;41478.17043659125;41522.37716434256;41578.7921060395;41584.79207603958;6966.12923384577;7826.139124696293;8106.310963568104;8107.554084525349;8108.148644392342;7094.184168820574;10257.38455692657;10513.632022879201;10513.894861051369;10534.894651053506;10069;10139.239557033252;10169.796604067915;10173.287869849113;10176.135028522547;7165.713371465135;7356.117265928123;10139.49302534874;10257.948710256438;10309.793804123876;9923.503824808731;10041.297109202358;10050.497475126287;10059.798804023952;10068.546915388752;37422.43866342007;37888.43167352465;37924.241515169815;38058.42912356317;38086.047848803726;2570.768630823216;2593;2721.2788611018095;2811.578263260507;3186.1556687477837;28730.281742956595;28881.711182888113;28971.71028289711;29009.41981160386;29190.56214156768;3058.6788387219467;3117.360941007111;3141.1832923439842;3211.277462570926;3212.405704944593;221617;221655;222518;222652;223007;51647.483525164265;52845.7357713209;57076;57200.71399642975;63106.111736032995;57619.13571296434;57673.711631441576;57846.421535784946;57908.71045644745;58065.129023064685;12321;12335.136540442083;12357.629271121701;12410.503579856886;12411.875881241253;9436.150746432853;9496.762580935532;9529;9530.761730956781;9537.47543885093;19252;19419.270390983347;19488.31128806953;19500.878103297095;19644.187174142142;7267.563946163247;7356.427391462743;7395;7395.593242371721;7455.254474552501;808.421978285517;809.4536188073145;814.9551774652332;946.9337146399686;949.534727983297;26151.73848261531;26804.731952680613;27328.45343093127;27560.448791024068;27603.171904842886;856.0497847389393;863.1559013052008;869.2263885142229;885.2740752582949;995.1292618958412;13339.399727012307;14083.507077252247;14658.560243192722;14802;14874.776878346833;263349;267548;267720;268924;269115;46716.532834671896;46944.999999999316;46949.530504694514;47014.29478557824;47092.05815883663;1130.1015692524463;1142.3374442823142;1143.8798926112638;1146.1117633833678;1294.5404381444453;26739;27245.318867028484;27662.308442289104;27697.169084927486;28198.295042624097;40866.38700419437;41404;41405.79297103495;41433;41451.58548414477;247956;251104;251355;254619;259521;26806.865965670047;26857.731422686305;26966;26966.460670786866;27247.45505089927;36328.63671363253;37934;38788.41817372798;38805.80597096997;39617.40573891452;31981.360372791947;32282.35435291234;32664.673353267113;33385.33229335351;33764.83117584397;32299;33456.1635959103;33570.16074598154;33744.662553375136;33951.320973580885;30586.694133058383;31055;31061.8446907764;31067.378652427276;31470.685293146777;27288.454230914875;28252;28340.716592834633;28368.57447138336;28409.147725568266;21923.342299731034;22069.668954965367;22456.663150052435;23098.769012310335;23503.764962350157 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |2;jquery.html;305.30999940135285;306.75766144745654;309.54342345041056;311.1272879572798;313.7364613724472;12252.509899604027;12631.936840315786;14754.77867831982;15221.315040823161;15357.769633455508;9743.853842192355;10011.349262297945;10018.348807327518;14932.104073755583;15401.768973465407;4100.507939047318;4230.259704551707;4235.6187943085115;4236.322188449833;4236.8560488668045;3138.6861313868544;3230.91922701932;4068.5524592294823;4506.954930450703;4687.92968105477;4605.9769701151445;4609.792559334821;4619.16854966106;4619.607333376667;4635.8145674173165;4594.885127871813;4601.033782905593;4609.907801843961;6022.8494287642725;6295.779647712308;5871.566966939933;6032.9698351508405;6043.516518678539;6044.939550604482;6159.938400616026;19305.131269092926;19436.514087147934;19723.112459939337;20591.89704051485;20657.483562910897;930.5579849571467;1894.1287007976348;1958.99020504898;1994.9900250498654;2073.751149862011;13398.464061437531;13497.2576508292;13547.525836595672;13748;13845.723085538233;1896.5258685328668;1899.278274255774;1915.0999030455664;1990.950226244341;1995.7804641489424;54058.72970635161;54409;54617.726911365586;54937;59246.703766481325;14570.635734106732;15436;15526.922365388327;15540.06759594428;15630.296636651377;22404.77595224027;22505.54988900213;22541.4364640882;22648.433789155402;22659.20692775745;7628.160902300742;7628.504147230412;7709.460337776414;7729.690812367442;7832.412569057344;6475.7085931133215;6583.341665833378;6611.537192396486;6621.238557565845;6652.467802575782;7565.243475652501;7664.697001509757;7670.539767613961;7677.117131529834;7707.576083315359;1009.2027298434301;2021.7263124231933;2885.4806134895503;2934.9266268343035;2982.6453378068263;381.75186129015805;382.1344654357826;389.31674910531837;390.40853107542097;404.1956506551941;10003.14973227284;10083.596656133672;10128.746781330527;10140.594376224868;10284.794304113875;396.73815281914375;396.9325214713506;400.155671533065;409.81763115413355;425.63182846837265;5340.626156169031;5520.613557050968;5586.804461843816;5665.1502274658305;5676.574256930747;340771;424190;462756;497621;500709;53745;55951.720241398536;56949;57019.144712829344;57925.71037144872;448.79804088159807;456.3497016751183;457.5835989249767;457.7299393357868;460.0477012583986;9291.21024712907;9638.469884156159;9691.903080969381;10096.444695541815;10326.432046237529;30367;31266.37467250597;31694;31866.522002170448;31974.401279936374;37943.24113517659;38106.42840357452;38791.80604096961;39877.2024559513;39994.800025999684;6068.393160683896;6108.17539632144;6190.350013248544;6201.627902325875;6207.379262073757;10816.188785840935;10852.891471085504;10899.618513351994;10916.126709863032;11225.326480411202;9568.09103135201;9772.364796288219;9774.804503910023;9919.057689519484;10037.197024237897;9380.437173769596;9625.951870240604;9696.127348538665;9817.901820981699;9995.550200240861;9650.324477286522;9697;9822.656207033006;10126.59493620247;10130.189584833048;6084.482818960438;6161.229846269216;6161.815145545641;6163.229596300463;6169;9538.28462865274;9557.330986830855;9610.807783844144;9882.308238423242;9889.604415823287 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1168.4216312925103;1361.5506882728698;1368.2543014057342;1462.6416527950646;1659.6265840185952;5431.348238211415;6278.1210630511705;6476.74093036278;6482.481401487881;6491.707873145714;6563.212414510253;6582.934170658292;6680.498962577814;6690.832729181773;6703.597784132955;1942.766867975845;1943.7375954246208;1958.9706154407695;1959.6766533521952;1960.0787629813965;1972.3589833304234;1986.1261045140163;1994.1225860621353;2012.6276638821791;2015.2745011795741;1910.2072639854443;1930.3436831477295;1939.350317643591;1940.796216397279;1941.2235105957589;1965.0764140853776;1971.3297478857185;1974.7037944308324;1983.3851506033031;1985.0273366050676;1965.4496740912568;1983.4942089767162;1986.7715212750575;1989.6219718253485;1993.8404927605757;5544.833654990357;5685.914711279334;6616.900746488806;6674.833129171761;6678.964760462136;3741.2517496500536;3841.635044670752;3842.9423558646645;3845.942310865339;3848.230353929225;2729.3586007288272;2732.098407525512;2775.680796708384;2779.027340430853;2824.308044529083;841.9494830310201;879.6789171952255;884.9601767920459;922.8569571716395;922.9030951750104;8930.196282334557;8996.280297576179;8997.415168014059;9008.324375671851;9011.63953441868;3570.8251756591853;3590.6768390844427;3621.9275614487565;3641.9089522761615;3643.7267204959735;7940.364770818321;7949.7217597383815;7954.761357159295;7958.920410795934;7977.122516523178;4084.36692312692;4085.3667681509414;4090.284200264942;4094.7747873867224;4095.037666148453;3717.3494638438165;3718.330700473941;3718.4980027696456;3724.236531511088;3728.1611637381916;3161.810291382478;3171.2864605463587;3178.5867837181017;3212.16483714236;3212.180893872048;965.1940629574244;976;979.8432250839974;996.6810620601483;1002.6691191906654;878.8242351529719;889.5596679643618;901.9503927283931;903.8192361527721;1159.4029075026367;6471.805845824632;6494.1557597512965;6494.318096599789;6524.739010439529;6528;383.1933779394335;385.3026022898563;385.74926297906586;385.849518687712;386.05994403627255;4448.933266001012;4795.520447955177;4841.661083724105;4845.370101886802;4856.17445034345;7055.082839230867;7911.485753426009;7975.960120199478;8031.036275646959;8056.959715201504;7875.6062196889925;7901.68393264263;7927.326177274881;7928.3260922821055;7943.4836735612;6095.1466794647895;6503.8699226015215;6510.609363438209;6510.934890651033;6521.250056243498;6281.277653069773;6300.936990630218;6304.495640348669;6310.242770867525;6317.747290108344;7042.859142817218;7307.2327405621645;7317.15852676949;7338.11942566874;7351.742689005859;6979.8604027918145;7141.85716285661;7278.7989981654555;7310;7502.887456688263;5845.707714614337;5875.059990401515;5910.468057874812;5911.881762364643;5918.141869428822;6414.61512309263;6446.258680251643;6458.806235812933;6459.6770161490795;6467.838304042249;6154.5384096192065;6178.907316390168;6284.465820405134;6369.1401660777055;6398.104265402941;6036.849078773066;6203.782867599793;6214.036824292242;6222.408871157233;6288.496920246461;6136.631802091889;6238.844028899314;6271.937280627135;6281.340459251713;6287.151234583455;5856.531477481706;5893.204417403767;5893.233879595625;5898.852528686817;5899.115132729953;5613.12996485529;5834.299884013945;5864.706764661664;5869.853253668693;5912.615679980788 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |4;prototype.html;276.12468474934457;283.2310277596326;283.5293412934529;286.1002148243772;287.1643517364469;5342.198670199472;5399.9730001350035;5429.701366424845;5455.781768729256;5463.617546771728;5094.46508116648;5232.45059268777;5241.86895327617;5243.475652434764;5347.759350829212;3979.582143874895;4000.6199411055977;4063.4108054332105;4075.8981025474304;4078.6737061035046;4043.1105156865588;4098.7130900836955;4115.444415003981;4121.649659778923;4125.23683118624;3861.864834730785;3943.881683549498;3949.19041596472;4067.2678917794783;4078.7552746835136;4032.6773858091283;4049.372347286146;4083.203775263825;4088.672906167529;4088.9795551022203;3540.291941611688;3540.6459354064646;3546.5744110706883;3549.893503194908;3551.076720052779;5147.433782283946;5161.4322424533275;5169.793208271664;5172.456892026321;5172.612054095958;4557.361969324297;4711.95288047122;4722.150012997659;4723.315119307681;4728;5668;5668.404817494145;5671.319441666985;5677;5685.602007859451;3825.330567150765;3826.8469261229516;3827.2154208387215;3828.0812604974885;3829.4064420014665;5899.439553242435;5981.342052374235;5982.04287314032;5986.742784015362;5986.790462333841;3802.2775672622115;3831.4635950966886;3840.3663395539425;3852.845886164578;3853.2293541291856;3982.980085099614;3996.3406038003986;4000.3799411091327;4002.5397079335667;4013.2776100302226;4614.377059096979;4635.490096089427;4644.790984405709;4646.047560250141;4646.1172377248895;5665.830025099253;5671.517920976763;5674.404187560329;5674.659520428788;5678.488935995781;1383.7163381506766;1393.226759148662;1395.490645914234;1397.7414178377032;1397.7973193887033;870.6996086350199;874.0953113527469;914.6524320758069;928.5078908178676;932.0446542294068;4883.34074899891;4885.560299572984;4900.852974410774;4901.387326584177;4901.852944411673;5748.9712551437815;5750.223719797774;5751.568632352591;5752.137179423036;5759.222504961776;4803.327534145223;4826.276058591239;4879.926801097987;4881.048195601895;4891.51084891508;3094.798838075518;3103.239706271978;3192.632847222599;3192.8563214654932;3197.1527545200543;5604.719764011783;5613.550915926716;5614.214010038598;5621.269234999506;5624.3813180550105;6076.605020673642;6084.0265557511475;6085.330613632497;6087.6956152192215;6089.1779609753;5486.615936884459;5606.831795046155;5634.32388113429;5635.154726791015;5639;5908.763649453974;5911.586188966903;5920.407959204045;5923.911141332969;5931.288245410578;5742.856428589152;5775.653460792366;5783.248177736868;5787.7395517200985;5793.478586927196;5473.425290344616;5580.832575022756;5584.162375643686;5630.324361076697;5632.971835140798;3921.6666583339593;3947.282931924622;3955.2089582084272;3956.3669812829808;3960.861369852041;5874.823755287348;5884.911726324023;5888.735006924784;5889.823305300848;5893.057110862242;5607.579431542569;5620.26936498269;5649.519790817826;5651.067573850269;5658.688772117573;5493.670379777226;5621.8594535136945;5633.267675202362;5635.436456354496;5635.492805647511;5562.582806289463;5588.832335029955;5591.580631452739;5598.272224610774;5598.608097433141;5721.8569535761935;5724.112762521816;5726.599138060295;5731.939591175646;5758.539316854725;5410.053240682943;5558.888822223452;5559.4162612926675;5560.777568897199;5571.1086226203615 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.3644710419308;698.5110422704107;727.7671145233521;763.4236151705463;785.6111224943654;12006.519739210433;12336.81494777579;12349.876501234996;12356.691082722937;12370.567030153947;12237;12355.135140540144;12361.134720569564;12364;12368.876311236885;607.7417097733456;620.7361871204743;621.0466933257451;779.3453499060788;796.2077732655987;795.1889073145388;796.2037962037933;798.9081255655616;801.4710291207804;801.5110782422718;823.9052508961456;831.1854382704953;831.6590198018813;831.7754206364278;831.7837362285788;641.172886975803;650.1418128070949;800.4396922154457;816.603947085663;821.2198411509031;609.20194545146;609.4788955443121;609.7317180440592;609.7743834781115;610.7129649064976;12195.817062744067;12333;12365.443555039954;12378.81431778524;12380.257184568954;11435.714107147305;11521.135914806338;11810.232334898204;12061.819072713917;12148.939255303756;8490.957545212295;8702.651893924236;9990.300678952477;10102.33311503601;10119.848202276971;2904.4626744052416;2954.290970167144;2984.940301193964;2986.9850650746607;3024.833634150121;35770.28459430797;35966;35991.82004089963;36012.459813102825;36111.458328124834;6828.624425656537;6937.826554336182;7036.155661320572;7152.821179470451;7169.820754481179;10618.203634727426;10934.781304373868;10951.671449856518;10957.890421095846;10969.067629251444;5432.891342173134;5485.396606373296;5703.201551782754;5774.740136693775;5780.5953583248765;3493.4410494320787;3498.8600455981987;3528.435450327935;3540.46892966052;3555.715542756573;2368.7868091871815;2389.928302150938;2390.175389490623;2392.952140957171;2398.2205783120207;379.14502796194404;383.1666126175557;548.2297372192077;551.7268951868771;570.5948776368741;518.2713015970916;560.9775608975677;571.6598623818821;603.4418163199024;603.8449103434519;7858.292753652085;7871.173526779606;7925.326347260548;8163.428560000862;8189;436.3541957902322;572.390404219505;575.925129733132;576.881739243454;603.6951339573487;3267.3465306938706;3268.6894744999186;3363.83180840957;3370.325934812998;3432.7940323580665;55440.72279638576;55967.72016139893;56150.7192464035;56162;56189.71905140448;48853.755731221114;49347.75326123346;49370.259446108335;49750.502494974586;49896.251556226685;44332.55667443349;44409.11181776346;44912.32631510595;45386.092278154254;45471.090578188254;7166.140063192451;7263.854722905407;7489.101307843093;7541.321281084729;7561.243875612395;33796.15509612279;33942;34611.4808277871;34632.82683586566;34756.13109672177;39583.40624890571;40961.590384095776;43657;44035.55964440315;44189.77905110583;8841.646334146562;9632.711018669452;9681.322307438411;9752.414855108716;9866.260030497884;10250.53872575721;10417.871746285211;10452.32059916103;10459.372437653765;10582.629607963992;9893.139443374726;9915.65295214664;9986.700398988041;10168.49157542105;10253.846192306972;9242.399244049115;9366;9457.007014263403;9607.807843842944;9700.660476883275;9768.853467197856;9906.653267135904;10089.142422893843;10098.54556544972;10111.595536178766;8338.79153021155;8505.617247223767;8578.485290882567;8765.517896515752;8826;7752.1472638008645;7870.763877083697;7916.129225785274;7983.281504664608;8112.675492980215 20:41:52 INFO - 2015-11-18 20:41:52,468 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: __startTimestamp1447908112461__endTimestamp 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4659.37 Median:4801.47 stddev:493.80 (10.3%) stddev-sans-first:469.89 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: Values: 2665.5 2742.4 2763.3 2777.2 2788.3 4464.7 4595.3 4660.6 4773.8 4831.6 4646.3 4693.8 4746.5 4747.8 4754.4 4280.9 4283.3 4359.7 4457.3 4488.3 4076.3 4428.0 4439.6 4476.4 4508.8 4233.2 4292.7 4353.5 4363.0 4376.9 4296.5 4312.7 4314.4 4322.6 4362.8 4119.4 4250.5 4278.0 4289.2 4338.1 4544.9 4616.0 4656.7 4658.1 4664.9 5092.5 5094.6 5098.3 5115.9 5135.2 4785.3 5106.2 5115.4 5119.5 5128.3 4636.5 4651.8 4700.3 4781.8 4820.9 5303.5 5312.3 5317.3 5327.1 5363.1 4659.3 5072.4 5093.7 5102.4 5131.5 4974.0 5037.6 5053.2 5058.0 5116.4 5001.7 5017.5 5018.8 5019.9 5067.5 4975.3 4978.8 4983.9 5008.0 5032.7 4071.6 4179.0 4181.0 4181.3 4186.9 3615.7 3671.0 3682.9 3693.7 3762.3 4396.8 4414.1 4416.3 4424.2 4465.6 5140.8 5167.7 5183.9 5184.8 5221.3 4147.3 4254.4 4256.7 4275.2 4369.2 4512.8 4524.1 4532.2 4535.4 4570.2 4801.5 4801.6 4814.8 4818.5 4843.4 4738.5 4840.7 4851.7 5070.5 5093.1 4816.1 4887.0 4890.0 4905.7 4938.4 5009.3 5039.6 5044.9 5047.1 5095.6 4801.4 4909.0 4914.6 5134.5 5135.1 4853.4 4898.8 4903.5 4910.8 4916.5 4827.1 4837.4 4844.7 4878.7 4886.6 4534.4 4615.8 4640.6 4749.6 4822.1 4777.5 4827.7 4836.8 4843.8 4878.7 4849.0 4912.9 4913.7 4919.0 4954.2 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,469 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40925.87 Median:31064.61 stddev:64647.17 (208.1%) stddev-sans-first:64757.42 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: Values: 545.5 551.4 578.8 580.6 585.5 25434.5 25981.4 37252.4 37941.2 37954.8 40927.4 41478.2 41522.4 41578.8 41584.8 6966.1 7826.1 8106.3 8107.6 8108.1 7094.2 10257.4 10513.6 10513.9 10534.9 10069.0 10139.2 10169.8 10173.3 10176.1 7165.7 7356.1 10139.5 10257.9 10309.8 9923.5 10041.3 10050.5 10059.8 10068.5 37422.4 37888.4 37924.2 38058.4 38086.0 2570.8 2593.0 2721.3 2811.6 3186.2 28730.3 28881.7 28971.7 29009.4 29190.6 3058.7 3117.4 3141.2 3211.3 3212.4 221617.0 221655.0 222518.0 222652.0 223007.0 51647.5 52845.7 57076.0 57200.7 63106.1 57619.1 57673.7 57846.4 57908.7 58065.1 12321.0 12335.1 12357.6 12410.5 12411.9 9436.2 9496.8 9529.0 9530.8 9537.5 19252.0 19419.3 19488.3 19500.9 19644.2 7267.6 7356.4 7395.0 7395.6 7455.3 808.4 809.5 815.0 946.9 949.5 26151.7 26804.7 27328.5 27560.4 27603.2 856.0 863.2 869.2 885.3 995.1 13339.4 14083.5 14658.6 14802.0 14874.8 263349.0 267548.0 267720.0 268924.0 269115.0 46716.5 46945.0 46949.5 47014.3 47092.1 1130.1 1142.3 1143.9 1146.1 1294.5 26739.0 27245.3 27662.3 27697.2 28198.3 40866.4 41404.0 41405.8 41433.0 41451.6 247956.0 251104.0 251355.0 254619.0 259521.0 26806.9 26857.7 26966.0 26966.5 27247.5 36328.6 37934.0 38788.4 38805.8 39617.4 31981.4 32282.4 32664.7 33385.3 33764.8 32299.0 33456.2 33570.2 33744.7 33951.3 30586.7 31055.0 31061.8 31067.4 31470.7 27288.5 28252.0 28340.7 28368.6 28409.1 21923.3 22069.7 22456.7 23098.8 23503.8 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24063.94 Median:214213.43 stddev:73309.52 (34.2%) stddev-sans-first:73493.46 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: Values: 305.3 306.8 309.5 311.1 313.7 12252.5 12631.9 14754.8 15221.3 15357.8 9743.9 10011.3 10018.3 14932.1 15401.8 4100.5 4230.3 4235.6 4236.3 4236.9 3138.7 3230.9 4068.6 4507.0 4687.9 4606.0 4609.8 4619.2 4619.6 4635.8 4594.9 4601.0 4609.9 6022.8 6295.8 5871.6 6033.0 6043.5 6044.9 6159.9 19305.1 19436.5 19723.1 20591.9 20657.5 930.6 1894.1 1959.0 1995.0 2073.8 13398.5 13497.3 13547.5 13748.0 13845.7 1896.5 1899.3 1915.1 1991.0 1995.8 54058.7 54409.0 54617.7 54937.0 59246.7 14570.6 15436.0 15526.9 15540.1 15630.3 22404.8 22505.5 22541.4 22648.4 22659.2 7628.2 7628.5 7709.5 7729.7 7832.4 6475.7 6583.3 6611.5 6621.2 6652.5 7565.2 7664.7 7670.5 7677.1 7707.6 1009.2 2021.7 2885.5 2934.9 2982.6 381.8 382.1 389.3 390.4 404.2 10003.1 10083.6 10128.7 10140.6 10284.8 396.7 396.9 400.2 409.8 425.6 5340.6 5520.6 5586.8 5665.2 5676.6 340771.0 424190.0 462756.0 497621.0 500709.0 53745.0 55951.7 56949.0 57019.1 57925.7 448.8 456.3 457.6 457.7 460.0 9291.2 9638.5 9691.9 10096.4 10326.4 30367.0 31266.4 31694.0 31866.5 31974.4 37943.2 38106.4 38791.8 39877.2 39994.8 6068.4 6108.2 6190.4 6201.6 6207.4 10816.2 10852.9 10899.6 10916.1 11225.3 9568.1 9772.4 9774.8 9919.1 10037.2 9380.4 9626.0 9696.1 9817.9 9995.6 9650.3 9697.0 9822.7 10126.6 10130.2 6084.5 6161.2 6161.8 6163.2 6169.0 9538.3 9557.3 9610.8 9882.3 9889.6 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4686.30 Median:6066.00 stddev:2438.38 (40.2%) stddev-sans-first:2430.88 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: Values: 1168.4 1361.6 1368.3 1462.6 1659.6 5431.3 6278.1 6476.7 6482.5 6491.7 6563.2 6582.9 6680.5 6690.8 6703.6 1942.8 1943.7 1959.0 1959.7 1960.1 1972.4 1986.1 1994.1 2012.6 2015.3 1910.2 1930.3 1939.4 1940.8 1941.2 1965.1 1971.3 1974.7 1983.4 1985.0 1965.4 1983.5 1986.8 1989.6 1993.8 5544.8 5685.9 6616.9 6674.8 6679.0 3741.3 3841.6 3842.9 3845.9 3848.2 2729.4 2732.1 2775.7 2779.0 2824.3 841.9 879.7 885.0 922.9 922.9 8930.2 8996.3 8997.4 9008.3 9011.6 3570.8 3590.7 3621.9 3641.9 3643.7 7940.4 7949.7 7954.8 7958.9 7977.1 4084.4 4085.4 4090.3 4094.8 4095.0 3717.3 3718.3 3718.5 3724.2 3728.2 3161.8 3171.3 3178.6 3212.2 3212.2 965.2 976.0 979.8 996.7 1002.7 878.8 889.6 902.0 903.8 1159.4 6471.8 6494.2 6494.3 6524.7 6528.0 383.2 385.3 385.7 385.8 386.1 4448.9 4795.5 4841.7 4845.4 4856.2 7055.1 7911.5 7976.0 8031.0 8057.0 7875.6 7901.7 7927.3 7928.3 7943.5 6095.1 6503.9 6510.6 6510.9 6521.3 6281.3 6300.9 6304.5 6310.2 6317.7 7042.9 7307.2 7317.2 7338.1 7351.7 6979.9 7141.9 7278.8 7310.0 7502.9 5845.7 5875.1 5910.5 5911.9 5918.1 6414.6 6446.3 6458.8 6459.7 6467.8 6154.5 6178.9 6284.5 6369.1 6398.1 6036.8 6203.8 6214.0 6222.4 6288.5 6136.6 6238.8 6271.9 6281.3 6287.2 5856.5 5893.2 5893.2 5898.9 5899.1 5613.1 5834.3 5864.7 5869.9 5912.6 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,471 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4655.51 Median:5373.87 stddev:1409.68 (26.2%) stddev-sans-first:1374.78 20:41:52 INFO - 2015-11-18 20:41:52,472 DEBUG : BROWSER_OUTPUT: Values: 276.1 283.2 283.5 286.1 287.2 5342.2 5400.0 5429.7 5455.8 5463.6 5094.5 5232.5 5241.9 5243.5 5347.8 3979.6 4000.6 4063.4 4075.9 4078.7 4043.1 4098.7 4115.4 4121.6 4125.2 3861.9 3943.9 3949.2 4067.3 4078.8 4032.7 4049.4 4083.2 4088.7 4089.0 3540.3 3540.6 3546.6 3549.9 3551.1 5147.4 5161.4 5169.8 5172.5 5172.6 4557.4 4712.0 4722.2 4723.3 4728.0 5668.0 5668.4 5671.3 5677.0 5685.6 3825.3 3826.8 3827.2 3828.1 3829.4 5899.4 5981.3 5982.0 5986.7 5986.8 3802.3 3831.5 3840.4 3852.8 3853.2 3983.0 3996.3 4000.4 4002.5 4013.3 4614.4 4635.5 4644.8 4646.0 4646.1 5665.8 5671.5 5674.4 5674.7 5678.5 1383.7 1393.2 1395.5 1397.7 1397.8 870.7 874.1 914.7 928.5 932.0 4883.3 4885.6 4900.9 4901.4 4901.9 5749.0 5750.2 5751.6 5752.1 5759.2 4803.3 4826.3 4879.9 4881.0 4891.5 3094.8 3103.2 3192.6 3192.9 3197.2 5604.7 5613.6 5614.2 5621.3 5624.4 6076.6 6084.0 6085.3 6087.7 6089.2 5486.6 5606.8 5634.3 5635.2 5639.0 5908.8 5911.6 5920.4 5923.9 5931.3 5742.9 5775.7 5783.2 5787.7 5793.5 5473.4 5580.8 5584.2 5630.3 5633.0 3921.7 3947.3 3955.2 3956.4 3960.9 5874.8 5884.9 5888.7 5889.8 5893.1 5607.6 5620.3 5649.5 5651.1 5658.7 5493.7 5621.9 5633.3 5635.4 5635.5 5562.6 5588.8 5591.6 5598.3 5598.6 5721.9 5724.1 5726.6 5731.9 5758.5 5410.1 5558.9 5559.4 5560.8 5571.1 20:41:52 INFO - 2015-11-18 20:41:52,473 DEBUG : BROWSER_OUTPUT: 20:41:52 INFO - 2015-11-18 20:41:52,473 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12349.42 Median:55704.22 stddev:15005.38 (26.9%) stddev-sans-first:15021.90 20:41:52 INFO - 2015-11-18 20:41:52,473 DEBUG : BROWSER_OUTPUT: Values: 683.4 698.5 727.8 763.4 785.6 12006.5 12336.8 12349.9 12356.7 12370.6 12237.0 12355.1 12361.1 12364.0 12368.9 607.7 620.7 621.0 779.3 796.2 795.2 796.2 798.9 801.5 801.5 823.9 831.2 831.7 831.8 831.8 641.2 650.1 800.4 816.6 821.2 609.2 609.5 609.7 609.8 610.7 12195.8 12333.0 12365.4 12378.8 12380.3 11435.7 11521.1 11810.2 12061.8 12148.9 8491.0 8702.7 9990.3 10102.3 10119.8 2904.5 2954.3 2984.9 2987.0 3024.8 35770.3 35966.0 35991.8 36012.5 36111.5 6828.6 6937.8 7036.2 7152.8 7169.8 10618.2 10934.8 10951.7 10957.9 10969.1 5432.9 5485.4 5703.2 5774.7 5780.6 3493.4 3498.9 3528.4 3540.5 3555.7 2368.8 2389.9 2390.2 2393.0 2398.2 379.1 383.2 548.2 551.7 570.6 518.3 561.0 571.7 603.4 603.8 7858.3 7871.2 7925.3 8163.4 8189.0 436.4 572.4 575.9 576.9 603.7 3267.3 3268.7 3363.8 3370.3 3432.8 55440.7 55967.7 56150.7 56162.0 56189.7 48853.8 49347.8 49370.3 49750.5 49896.3 44332.6 44409.1 44912.3 45386.1 45471.1 7166.1 7263.9 7489.1 7541.3 7561.2 33796.2 33942.0 34611.5 34632.8 34756.1 39583.4 40961.6 43657.0 44035.6 44189.8 8841.6 9632.7 9681.3 9752.4 9866.3 10250.5 10417.9 10452.3 10459.4 10582.6 9893.1 9915.7 9986.7 10168.5 10253.8 9242.4 9366.0 9457.0 9607.8 9700.7 9768.9 9906.7 10089.1 10098.5 10111.6 8338.8 8505.6 8578.5 8765.5 8826.0 7752.1 7870.8 7916.1 7983.3 8112.7 20:41:52 INFO - 2015-11-18 20:41:52,473 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:41:52 INFO - 2015-11-18 20:41:52,473 DEBUG : BROWSER_OUTPUT: 20:41:53 INFO - 2015-11-18 20:41:53,234 INFO : Browser exited with error code: 0 20:41:53 INFO - 2015-11-18 20:41:53,258 INFO : Completed test dromaeo_css (00:18:37) 20:41:53 INFO - 2015-11-18 20:41:53,258 INFO : Starting test kraken 20:41:53 INFO - 2015-11-18 20:41:53,258 DEBUG : operating with platform_type : linux_ 20:41:53 INFO - 2015-11-18 20:41:53,258 INFO : Initialising browser for kraken test... 20:41:53 INFO - 2015-11-18 20:41:53,264 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYOQ0a/profile http://localhost:37249/getInfo.html 20:41:57 INFO - 2015-11-18 20:41:57,804 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:41:57 INFO - 2015-11-18 20:41:57,805 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:41:57 INFO - 2015-11-18 20:41:57,805 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:41:57 INFO - 2015-11-18 20:41:57,805 DEBUG : BROWSER_OUTPUT: __metrics 20:41:57 INFO - 2015-11-18 20:41:57,907 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:41:59 INFO - 2015-11-18 20:41:59,333 INFO : Browser initialized. 20:41:59 INFO - 2015-11-18 20:41:59,334 INFO : Running cycle 1/1 for kraken test... 20:41:59 INFO - 2015-11-18 20:41:59,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYOQ0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:42:11 INFO - 2015-11-18 20:42:11,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 140136448 20:42:11 INFO - 2015-11-18 20:42:11,308 DEBUG : BROWSER_OUTPUT: 20:42:13 INFO - 2015-11-18 20:42:13,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-beat-detection) 20:42:14 INFO - 2015-11-18 20:42:14,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 178872320 20:42:14 INFO - 2015-11-18 20:42:14,494 DEBUG : BROWSER_OUTPUT: 20:42:17 INFO - 2015-11-18 20:42:17,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-dft) 20:42:17 INFO - 2015-11-18 20:42:17,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 168493056 20:42:17 INFO - 2015-11-18 20:42:17,819 DEBUG : BROWSER_OUTPUT: 20:42:20 INFO - 2015-11-18 20:42:20,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-fft) 20:42:21 INFO - 2015-11-18 20:42:21,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 152363008 20:42:21 INFO - 2015-11-18 20:42:21,393 DEBUG : BROWSER_OUTPUT: 20:42:23 INFO - 2015-11-18 20:42:23,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37249/tests/kraken/driver.html?testName=audio-oscillator) 20:42:24 INFO - 2015-11-18 20:42:24,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 153845760 20:42:24 INFO - 2015-11-18 20:42:24,005 DEBUG : BROWSER_OUTPUT: 20:42:26 INFO - 2015-11-18 20:42:26,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:26 INFO - 2015-11-18 20:42:26,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 157315072 20:42:26 INFO - 2015-11-18 20:42:26,804 DEBUG : BROWSER_OUTPUT: 20:42:29 INFO - 2015-11-18 20:42:29,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:30 INFO - 2015-11-18 20:42:30,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 155467776 20:42:30 INFO - 2015-11-18 20:42:30,384 DEBUG : BROWSER_OUTPUT: 20:42:33 INFO - 2015-11-18 20:42:33,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37249/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:34 INFO - 2015-11-18 20:42:34,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 158015488 20:42:34 INFO - 2015-11-18 20:42:34,352 DEBUG : BROWSER_OUTPUT: 20:42:37 INFO - 2015-11-18 20:42:37,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37249/tests/kraken/driver.html?testName=json-parse-financial) 20:42:37 INFO - 2015-11-18 20:42:37,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 156512256 20:42:37 INFO - 2015-11-18 20:42:37,751 DEBUG : BROWSER_OUTPUT: 20:42:39 INFO - 2015-11-18 20:42:39,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:40 INFO - 2015-11-18 20:42:40,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 165466112 20:42:40 INFO - 2015-11-18 20:42:40,060 DEBUG : BROWSER_OUTPUT: 20:42:41 INFO - 2015-11-18 20:42:41,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:42 INFO - 2015-11-18 20:42:42,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 166637568 20:42:42 INFO - 2015-11-18 20:42:42,524 DEBUG : BROWSER_OUTPUT: 20:42:44 INFO - 2015-11-18 20:42:44,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:45 INFO - 2015-11-18 20:42:45,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 173481984 20:42:45 INFO - 2015-11-18 20:42:45,265 DEBUG : BROWSER_OUTPUT: 20:42:47 INFO - 2015-11-18 20:42:47,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:42:48 INFO - 2015-11-18 20:42:48,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 181878784 20:42:48 INFO - 2015-11-18 20:42:48,428 DEBUG : BROWSER_OUTPUT: 20:42:51 INFO - 2015-11-18 20:42:51,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:42:51 INFO - 2015-11-18 20:42:51,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 179720192 20:42:51 INFO - 2015-11-18 20:42:51,696 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37249/tests/kraken/driver.html?testName=ai-astar) 20:42:53 INFO - 2015-11-18 20:42:53,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 238309376 20:42:53 INFO - 2015-11-18 20:42:53,696 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,699 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:42:53 INFO - 2015-11-18 20:42:53,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;111;114;113;114;121;112;112;113;115 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;155;169;130;153;161;131;171;131 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;159;161;160;161;162;162;163 20:42:53 INFO - 2015-11-18 20:42:53,700 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;85;91;72;72;73;119;89;73 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;129;92;92;92;128;92;92;126 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;111;109;110;110;109;110;110 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;149;148;148;147;148;148;147;148 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;96;95;96;96 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;72;72;74;73;82;71;70 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;70;71;70;71;70;69;70 20:42:53 INFO - 2015-11-18 20:42:53,701 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;82;83;83;82;84;84;83 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;127;137;123;129;133;140;126;124;124 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;153;153;161;152;143;155;152;153;158 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;70;69;70;70;70;68;70;70 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 20:42:53 INFO - 2015-11-18 20:42:53,702 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:42:53 INFO - 2015-11-18 20:42:53,703 DEBUG : BROWSER_OUTPUT: __startTimestamp1447908173697__endTimestamp 20:42:53 INFO - 2015-11-18 20:42:53,703 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,706 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:42:53 INFO - 2015-11-18 20:42:53,706 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:42:53 INFO - 2015-11-18 20:42:53,707 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,707 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:2.83 (2.5%) stddev-sans-first:2.93 20:42:53 INFO - 2015-11-18 20:42:53,707 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 114.0 113.0 114.0 121.0 112.0 112.0 113.0 115.0 20:42:53 INFO - 2015-11-18 20:42:53,707 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,707 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:16.59 (10.6%) stddev-sans-first:17.33 20:42:53 INFO - 2015-11-18 20:42:53,708 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 155.0 169.0 130.0 153.0 161.0 131.0 171.0 131.0 20:42:53 INFO - 2015-11-18 20:42:53,708 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,708 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 20:42:53 INFO - 2015-11-18 20:42:53,708 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 159.0 161.0 160.0 161.0 162.0 162.0 163.0 20:42:53 INFO - 2015-11-18 20:42:53,709 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,709 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.90 Median:73.00 stddev:15.10 (20.7%) stddev-sans-first:15.58 20:42:53 INFO - 2015-11-18 20:42:53,709 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 85.0 91.0 72.0 72.0 73.0 119.0 89.0 73.0 20:42:53 INFO - 2015-11-18 20:42:53,709 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:92.00 stddev:17.18 (18.7%) stddev-sans-first:17.85 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 129.0 92.0 92.0 92.0 128.0 92.0 92.0 126.0 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 111.0 109.0 110.0 110.0 109.0 110.0 110.0 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,710 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 149.0 148.0 148.0 147.0 148.0 148.0 147.0 148.0 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,711 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.30 Median:73.00 stddev:3.30 (4.5%) stddev-sans-first:3.49 20:42:53 INFO - 2015-11-18 20:42:53,712 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 72.0 72.0 74.0 73.0 82.0 71.0 70.0 20:42:53 INFO - 2015-11-18 20:42:53,712 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 71.0 70.0 71.0 70.0 69.0 70.0 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 82.0 83.0 83.0 82.0 84.0 84.0 83.0 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:129.00 stddev:5.77 (4.5%) stddev-sans-first:6.12 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: Values: 129.0 127.0 137.0 123.0 129.0 133.0 140.0 126.0 124.0 124.0 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:153.00 stddev:4.66 (3.0%) stddev-sans-first:4.92 20:42:53 INFO - 2015-11-18 20:42:53,713 DEBUG : BROWSER_OUTPUT: Values: 152.0 153.0 153.0 161.0 152.0 143.0 155.0 152.0 153.0 158.0 20:42:53 INFO - 2015-11-18 20:42:53,714 DEBUG : BROWSER_OUTPUT: 20:42:53 INFO - 2015-11-18 20:42:53,714 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 20:42:53 INFO - 2015-11-18 20:42:53,714 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 69.0 70.0 70.0 70.0 68.0 70.0 70.0 20:42:53 INFO - 2015-11-18 20:42:53,714 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:42:53 INFO - 2015-11-18 20:42:53,714 DEBUG : BROWSER_OUTPUT: 20:42:54 INFO - 2015-11-18 20:42:54,678 INFO : Browser exited with error code: 0 20:42:54 INFO - 2015-11-18 20:42:54,724 INFO : Completed test kraken (00:01:01) 20:42:54 INFO - 2015-11-18 20:42:54,724 INFO : Starting test v8_7 20:42:54 INFO - 2015-11-18 20:42:54,724 DEBUG : operating with platform_type : linux_ 20:42:54 INFO - 2015-11-18 20:42:54,725 INFO : Initialising browser for v8_7 test... 20:42:54 INFO - 2015-11-18 20:42:54,731 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplpKm9E/profile http://localhost:37249/getInfo.html 20:42:59 INFO - 2015-11-18 20:42:59,273 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:42:59 INFO - 2015-11-18 20:42:59,273 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:42:59 INFO - 2015-11-18 20:42:59,273 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:42:59 INFO - 2015-11-18 20:42:59,273 DEBUG : BROWSER_OUTPUT: __metrics 20:42:59 INFO - 2015-11-18 20:42:59,415 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:43:00 INFO - 2015-11-18 20:43:00,900 INFO : Browser initialized. 20:43:00 INFO - 2015-11-18 20:43:00,900 INFO : Running cycle 1/1 for v8_7 test... 20:43:00 INFO - 2015-11-18 20:43:00,901 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplpKm9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:43:12 INFO - 2015-11-18 20:43:12,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 139780096 20:43:12 INFO - 2015-11-18 20:43:12,837 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37249/tests/v8_7/run.html (next: http://localhost:37249/tests/v8_7/run.html) 20:43:34 INFO - 2015-11-18 20:43:34,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 439181312 20:43:34 INFO - 2015-11-18 20:43:34,549 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,549 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:43:34 INFO - 2015-11-18 20:43:34,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:43:34 INFO - 2015-11-18 20:43:34,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:43:34 INFO - 2015-11-18 20:43:34,550 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:43:34 INFO - 2015-11-18 20:43:34,550 DEBUG : BROWSER_OUTPUT: |0;Richards;163.71971185330713 20:43:34 INFO - 2015-11-18 20:43:34,550 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.88095683049897 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2024.2914979757086 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |5;Earley;800 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |6;Boyer;12365.853658536585 20:43:34 INFO - 2015-11-18 20:43:34,551 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: |8;Splay;620.9677419354839 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1447908214547__endTimestamp 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,552 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.72 Median:163.72 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: Values: 163.7 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,553 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.88 Median:186.88 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,554 DEBUG : BROWSER_OUTPUT: Values: 186.9 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: Values: 280.0 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,555 DEBUG : BROWSER_OUTPUT: Values: 5060.6 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: Values: 2024.3 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: Values: 800.0 20:43:34 INFO - 2015-11-18 20:43:34,556 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,557 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,557 DEBUG : BROWSER_OUTPUT: Values: 12365.9 20:43:34 INFO - 2015-11-18 20:43:34,557 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,557 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,557 DEBUG : BROWSER_OUTPUT: Values: 27027.0 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.97 Median:620.97 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: Values: 621.0 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: Values: 4850.2 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:43:34 INFO - 2015-11-18 20:43:34,558 DEBUG : BROWSER_OUTPUT: 20:43:35 INFO - 2015-11-18 20:43:35,454 INFO : Browser exited with error code: 0 20:43:35 INFO - 2015-11-18 20:43:35,471 INFO : Completed test v8_7 (00:00:40) 20:43:35 INFO - 2015-11-18 20:43:35,550 INFO : Completed test suite (00:20:19) 20:43:35 INFO - 2015-11-18 20:43:35,550 DEBUG : Working with test: dromaeo_css 20:43:35 INFO - 2015-11-18 20:43:35,550 DEBUG : Generating results file: dromaeo_css 20:43:35 INFO - 2015-11-18 20:43:35,552 DEBUG : Working with test: kraken 20:43:35 INFO - 2015-11-18 20:43:35,552 DEBUG : Generating results file: kraken 20:43:35 INFO - 2015-11-18 20:43:35,552 INFO : javascript benchmark 20:43:35 INFO - 2015-11-18 20:43:35,552 DEBUG : Working with test: v8_7 20:43:35 INFO - 2015-11-18 20:43:35,552 DEBUG : Generating results file: v8_7 20:43:35 INFO - 2015-11-18 20:43:35,553 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:35 INFO - 2015-11-18 20:43:35,627 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 20:43:35 INFO - 2015-11-18 20:43:35,627 DEBUG : process_Request line: dromaeo_css 6060.30 graph.html#tests=[[72,132,35]] 20:43:35 INFO - 2015-11-18 20:43:35,628 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:35 INFO - 2015-11-18 20:43:35,663 DEBUG : process_Request line: kraken 1540.20 graph.html#tests=[[232,132,35]] 20:43:35 INFO - 2015-11-18 20:43:35,663 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:43:35 INFO - 2015-11-18 20:43:35,699 DEBUG : process_Request line: v8_7 19701.51 graph.html#tests=[[230,132,35]] 20:43:35 INFO - 2015-11-18 20:43:35,700 INFO : javascript benchmark 20:43:35 INFO - 2015-11-18 20:43:35,704 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2665.5335316319647, 2742.3829638331367, 2763.2953596832804, 2777.2362600284905, 2788.3308006078546, 4464.687471876961, 4595.264757638778, 4660.62714982801, 4773.809047638095, 4831.637627177958, 4646.349511068444, 4693.812247510095, 4746.477887432388, 4747.76261186941, 4754.38193034905, 4280.914381712364, 4283.293256612656, 4359.651227901761, 4457.264551349023, 4488.259437192859, 4076.3070278052655, 4428.0, 4439.644828413735, 4476.37330773692, 4508.774561271924, 4233.153369326147, 4292.7424354538825, 4353.455818022747, 4363.040131171138, 4376.912461750747, 4296.484421869364, 4312.698111132222, 4314.439122914001, 4322.567743225683, 4362.781860906942, 4119.361498967664, 4250.511191213019, 4278.037441575651, 4289.1850548395705, 4338.089001309729, 4544.931826022579, 4615.976920115411, 4656.650751193674, 4658.114958157939, 4664.883377915546, 5092.541671249568, 5094.617903657204, 5098.260752190911, 5115.948840511622, 5135.152699804527, 4785.282207668843, 5106.157484015133, 5115.386153661584, 5119.488051194888, 5128.282040514331, 4636.466806317283, 4651.813927442899, 4700.271457924027, 4781.760911954389, 4820.879478013007, 5303.496167864047, 5312.282841816383, 5317.255584218213, 5327.067763141435, 5363.088274993261, 4659.277811939155, 5072.442031376546, 5093.694378337312, 5102.387713474407, 5131.461196574381, 4974.0, 5037.647364684511, 5053.191489361684, 5057.974710126426, 5116.386033675983, 5001.7499125043605, 5017.54842064216, 5018.799248030038, 5019.949800502021, 5067.467915868854, 4975.278584605212, 4978.800847966113, 4983.90032199354, 5007.974960125249, 5032.672876263031, 4071.572484889044, 4178.958210417918, 4181.038361176947, 4181.289180839264, 4186.853460128881, 3615.6565126312958, 3671.0455281626437, 3682.9263414731554, 3693.7229707772026, 3762.3415902217002, 4396.758178300161, 4414.09511050234, 4416.293393057095, 4424.181526417558, 4465.575770301816, 5140.845774626767, 5167.664101833444, 5183.922241166386, 5184.766685499161, 5221.295125158131, 4147.315692910696, 4254.404383386328, 4256.723312984646, 4275.166342563232, 4369.213541562485, 4512.774361281989, 4524.0951809637545, 4532.206863798822, 4535.4103966484145, 4570.200214962369, 4801.4718380977365, 4801.591864691541, 4814.807407703653, 4818.469968303484, 4843.418789745253, 4738.455077665974, 4840.7337596432535, 4851.660383773102, 5070.4676009019995, 5093.0577843099145, 4816.060868130821, 4887.047025829929, 4889.975550122226, 4905.705657660552, 4938.358013458227, 5009.298698182184, 5039.6220283479615, 5044.873878153076, 5047.091523525653, 5095.566876815364, 4801.375821143229, 4908.993656300521, 4914.631402644887, 5134.460881607378, 5135.075686376488, 4853.369062022056, 4898.779554919965, 4903.509649035068, 4910.7544622768, 4916.532929371704, 4827.106985207748, 4837.395325584302, 4844.709317440824, 4878.707277563358, 4886.560209581155, 4534.365188873627, 4615.792289347055, 4640.628749700083, 4749.643776716829, 4822.059698358927, 4777.522247775195, 4827.734474603931, 4836.758162091952, 4843.806247750051, 4878.682885612424, 4849.030193961151, 4912.901741965212, 4913.65604407688, 4918.95081049185, 4954.20732682769], "unit": "ms", "name": "dojo.html", "value": 4629.018778094891}, {"lowerIsBetter": false, "replicates": [545.4817922973176, 551.4099913092992, 578.846605649503, 580.5993864233678, 585.4789237578555, 25434.49131017381, 25981.350466238353, 37252.44121338182, 37941.24117517648, 37954.8102259489, 40927.38608920861, 41478.17043659125, 41522.37716434256, 41578.7921060395, 41584.79207603958, 6966.12923384577, 7826.139124696293, 8106.310963568104, 8107.554084525349, 8108.148644392342, 7094.184168820574, 10257.38455692657, 10513.632022879201, 10513.894861051369, 10534.894651053506, 10069.0, 10139.239557033252, 10169.796604067915, 10173.287869849113, 10176.135028522547, 7165.713371465135, 7356.117265928123, 10139.49302534874, 10257.948710256438, 10309.793804123876, 9923.503824808731, 10041.297109202358, 10050.497475126287, 10059.798804023952, 10068.546915388752, 37422.43866342007, 37888.43167352465, 37924.241515169815, 38058.42912356317, 38086.047848803726, 2570.768630823216, 2593.0, 2721.2788611018095, 2811.578263260507, 3186.1556687477837, 28730.281742956595, 28881.711182888113, 28971.71028289711, 29009.41981160386, 29190.56214156768, 3058.6788387219467, 3117.360941007111, 3141.1832923439842, 3211.277462570926, 3212.405704944593, 221617.0, 221655.0, 222518.0, 222652.0, 223007.0, 51647.483525164265, 52845.7357713209, 57076.0, 57200.71399642975, 63106.111736032995, 57619.13571296434, 57673.711631441576, 57846.421535784946, 57908.71045644745, 58065.129023064685, 12321.0, 12335.136540442083, 12357.629271121701, 12410.503579856886, 12411.875881241253, 9436.150746432853, 9496.762580935532, 9529.0, 9530.761730956781, 9537.47543885093, 19252.0, 19419.270390983347, 19488.31128806953, 19500.878103297095, 19644.187174142142, 7267.563946163247, 7356.427391462743, 7395.0, 7395.593242371721, 7455.254474552501, 808.421978285517, 809.4536188073145, 814.9551774652332, 946.9337146399686, 949.534727983297, 26151.73848261531, 26804.731952680613, 27328.45343093127, 27560.448791024068, 27603.171904842886, 856.0497847389393, 863.1559013052008, 869.2263885142229, 885.2740752582949, 995.1292618958412, 13339.399727012307, 14083.507077252247, 14658.560243192722, 14802.0, 14874.776878346833, 263349.0, 267548.0, 267720.0, 268924.0, 269115.0, 46716.532834671896, 46944.999999999316, 46949.530504694514, 47014.29478557824, 47092.05815883663, 1130.1015692524463, 1142.3374442823142, 1143.8798926112638, 1146.1117633833678, 1294.5404381444453, 26739.0, 27245.318867028484, 27662.308442289104, 27697.169084927486, 28198.295042624097, 40866.38700419437, 41404.0, 41405.79297103495, 41433.0, 41451.58548414477, 247956.0, 251104.0, 251355.0, 254619.0, 259521.0, 26806.865965670047, 26857.731422686305, 26966.0, 26966.460670786866, 27247.45505089927, 36328.63671363253, 37934.0, 38788.41817372798, 38805.80597096997, 39617.40573891452, 31981.360372791947, 32282.35435291234, 32664.673353267113, 33385.33229335351, 33764.83117584397, 32299.0, 33456.1635959103, 33570.16074598154, 33744.662553375136, 33951.320973580885, 30586.694133058383, 31055.0, 31061.8446907764, 31067.378652427276, 31470.685293146777, 27288.454230914875, 28252.0, 28340.716592834633, 28368.57447138336, 28409.147725568266, 21923.342299731034, 22069.668954965367, 22456.663150052435, 23098.769012310335, 23503.764962350157], "unit": "ms", "name": "ext.html", "value": 16962.563440845748}, {"lowerIsBetter": false, "replicates": [305.30999940135285, 306.75766144745654, 309.54342345041056, 311.1272879572798, 313.7364613724472, 12252.509899604027, 12631.936840315786, 14754.77867831982, 15221.315040823161, 15357.769633455508, 9743.853842192355, 10011.349262297945, 10018.348807327518, 14932.104073755583, 15401.768973465407, 4100.507939047318, 4230.259704551707, 4235.6187943085115, 4236.322188449833, 4236.8560488668045, 3138.6861313868544, 3230.91922701932, 4068.5524592294823, 4506.954930450703, 4687.92968105477, 4605.9769701151445, 4609.792559334821, 4619.16854966106, 4619.607333376667, 4635.8145674173165, 4594.885127871813, 4601.033782905593, 4609.907801843961, 6022.8494287642725, 6295.779647712308, 5871.566966939933, 6032.9698351508405, 6043.516518678539, 6044.939550604482, 6159.938400616026, 19305.131269092926, 19436.514087147934, 19723.112459939337, 20591.89704051485, 20657.483562910897, 930.5579849571467, 1894.1287007976348, 1958.99020504898, 1994.9900250498654, 2073.751149862011, 13398.464061437531, 13497.2576508292, 13547.525836595672, 13748.0, 13845.723085538233, 1896.5258685328668, 1899.278274255774, 1915.0999030455664, 1990.950226244341, 1995.7804641489424, 54058.72970635161, 54409.0, 54617.726911365586, 54937.0, 59246.703766481325, 14570.635734106732, 15436.0, 15526.922365388327, 15540.06759594428, 15630.296636651377, 22404.77595224027, 22505.54988900213, 22541.4364640882, 22648.433789155402, 22659.20692775745, 7628.160902300742, 7628.504147230412, 7709.460337776414, 7729.690812367442, 7832.412569057344, 6475.7085931133215, 6583.341665833378, 6611.537192396486, 6621.238557565845, 6652.467802575782, 7565.243475652501, 7664.697001509757, 7670.539767613961, 7677.117131529834, 7707.576083315359, 1009.2027298434301, 2021.7263124231933, 2885.4806134895503, 2934.9266268343035, 2982.6453378068263, 381.75186129015805, 382.1344654357826, 389.31674910531837, 390.40853107542097, 404.1956506551941, 10003.14973227284, 10083.596656133672, 10128.746781330527, 10140.594376224868, 10284.794304113875, 396.73815281914375, 396.9325214713506, 400.155671533065, 409.81763115413355, 425.63182846837265, 5340.626156169031, 5520.613557050968, 5586.804461843816, 5665.1502274658305, 5676.574256930747, 340771.0, 424190.0, 462756.0, 497621.0, 500709.0, 53745.0, 55951.720241398536, 56949.0, 57019.144712829344, 57925.71037144872, 448.79804088159807, 456.3497016751183, 457.5835989249767, 457.7299393357868, 460.0477012583986, 9291.21024712907, 9638.469884156159, 9691.903080969381, 10096.444695541815, 10326.432046237529, 30367.0, 31266.37467250597, 31694.0, 31866.522002170448, 31974.401279936374, 37943.24113517659, 38106.42840357452, 38791.80604096961, 39877.2024559513, 39994.800025999684, 6068.393160683896, 6108.17539632144, 6190.350013248544, 6201.627902325875, 6207.379262073757, 10816.188785840935, 10852.891471085504, 10899.618513351994, 10916.126709863032, 11225.326480411202, 9568.09103135201, 9772.364796288219, 9774.804503910023, 9919.057689519484, 10037.197024237897, 9380.437173769596, 9625.951870240604, 9696.127348538665, 9817.901820981699, 9995.550200240861, 9650.324477286522, 9697.0, 9822.656207033006, 10126.59493620247, 10130.189584833048, 6084.482818960438, 6161.229846269216, 6161.815145545641, 6163.229596300463, 6169.0, 9538.28462865274, 9557.330986830855, 9610.807783844144, 9882.308238423242, 9889.604415823287], "unit": "ms", "name": "jquery.html", "value": 7255.4309563732995}, {"lowerIsBetter": false, "replicates": [1168.4216312925103, 1361.5506882728698, 1368.2543014057342, 1462.6416527950646, 1659.6265840185952, 5431.348238211415, 6278.1210630511705, 6476.74093036278, 6482.481401487881, 6491.707873145714, 6563.212414510253, 6582.934170658292, 6680.498962577814, 6690.832729181773, 6703.597784132955, 1942.766867975845, 1943.7375954246208, 1958.9706154407695, 1959.6766533521952, 1960.0787629813965, 1972.3589833304234, 1986.1261045140163, 1994.1225860621353, 2012.6276638821791, 2015.2745011795741, 1910.2072639854443, 1930.3436831477295, 1939.350317643591, 1940.796216397279, 1941.2235105957589, 1965.0764140853776, 1971.3297478857185, 1974.7037944308324, 1983.3851506033031, 1985.0273366050676, 1965.4496740912568, 1983.4942089767162, 1986.7715212750575, 1989.6219718253485, 1993.8404927605757, 5544.833654990357, 5685.914711279334, 6616.900746488806, 6674.833129171761, 6678.964760462136, 3741.2517496500536, 3841.635044670752, 3842.9423558646645, 3845.942310865339, 3848.230353929225, 2729.3586007288272, 2732.098407525512, 2775.680796708384, 2779.027340430853, 2824.308044529083, 841.9494830310201, 879.6789171952255, 884.9601767920459, 922.8569571716395, 922.9030951750104, 8930.196282334557, 8996.280297576179, 8997.415168014059, 9008.324375671851, 9011.63953441868, 3570.8251756591853, 3590.6768390844427, 3621.9275614487565, 3641.9089522761615, 3643.7267204959735, 7940.364770818321, 7949.7217597383815, 7954.761357159295, 7958.920410795934, 7977.122516523178, 4084.36692312692, 4085.3667681509414, 4090.284200264942, 4094.7747873867224, 4095.037666148453, 3717.3494638438165, 3718.330700473941, 3718.4980027696456, 3724.236531511088, 3728.1611637381916, 3161.810291382478, 3171.2864605463587, 3178.5867837181017, 3212.16483714236, 3212.180893872048, 965.1940629574244, 976.0, 979.8432250839974, 996.6810620601483, 1002.6691191906654, 878.8242351529719, 889.5596679643618, 901.9503927283931, 903.8192361527721, 1159.4029075026367, 6471.805845824632, 6494.1557597512965, 6494.318096599789, 6524.739010439529, 6528.0, 383.1933779394335, 385.3026022898563, 385.74926297906586, 385.849518687712, 386.05994403627255, 4448.933266001012, 4795.520447955177, 4841.661083724105, 4845.370101886802, 4856.17445034345, 7055.082839230867, 7911.485753426009, 7975.960120199478, 8031.036275646959, 8056.959715201504, 7875.6062196889925, 7901.68393264263, 7927.326177274881, 7928.3260922821055, 7943.4836735612, 6095.1466794647895, 6503.8699226015215, 6510.609363438209, 6510.934890651033, 6521.250056243498, 6281.277653069773, 6300.936990630218, 6304.495640348669, 6310.242770867525, 6317.747290108344, 7042.859142817218, 7307.2327405621645, 7317.15852676949, 7338.11942566874, 7351.742689005859, 6979.8604027918145, 7141.85716285661, 7278.7989981654555, 7310.0, 7502.887456688263, 5845.707714614337, 5875.059990401515, 5910.468057874812, 5911.881762364643, 5918.141869428822, 6414.61512309263, 6446.258680251643, 6458.806235812933, 6459.6770161490795, 6467.838304042249, 6154.5384096192065, 6178.907316390168, 6284.465820405134, 6369.1401660777055, 6398.104265402941, 6036.849078773066, 6203.782867599793, 6214.036824292242, 6222.408871157233, 6288.496920246461, 6136.631802091889, 6238.844028899314, 6271.937280627135, 6281.340459251713, 6287.151234583455, 5856.531477481706, 5893.204417403767, 5893.233879595625, 5898.852528686817, 5899.115132729953, 5613.12996485529, 5834.299884013945, 5864.706764661664, 5869.853253668693, 5912.615679980788], "unit": "ms", "name": "mootools.html", "value": 3775.1219919427103}, {"lowerIsBetter": false, "replicates": [276.12468474934457, 283.2310277596326, 283.5293412934529, 286.1002148243772, 287.1643517364469, 5342.198670199472, 5399.9730001350035, 5429.701366424845, 5455.781768729256, 5463.617546771728, 5094.46508116648, 5232.45059268777, 5241.86895327617, 5243.475652434764, 5347.759350829212, 3979.582143874895, 4000.6199411055977, 4063.4108054332105, 4075.8981025474304, 4078.6737061035046, 4043.1105156865588, 4098.7130900836955, 4115.444415003981, 4121.649659778923, 4125.23683118624, 3861.864834730785, 3943.881683549498, 3949.19041596472, 4067.2678917794783, 4078.7552746835136, 4032.6773858091283, 4049.372347286146, 4083.203775263825, 4088.672906167529, 4088.9795551022203, 3540.291941611688, 3540.6459354064646, 3546.5744110706883, 3549.893503194908, 3551.076720052779, 5147.433782283946, 5161.4322424533275, 5169.793208271664, 5172.456892026321, 5172.612054095958, 4557.361969324297, 4711.95288047122, 4722.150012997659, 4723.315119307681, 4728.0, 5668.0, 5668.404817494145, 5671.319441666985, 5677.0, 5685.602007859451, 3825.330567150765, 3826.8469261229516, 3827.2154208387215, 3828.0812604974885, 3829.4064420014665, 5899.439553242435, 5981.342052374235, 5982.04287314032, 5986.742784015362, 5986.790462333841, 3802.2775672622115, 3831.4635950966886, 3840.3663395539425, 3852.845886164578, 3853.2293541291856, 3982.980085099614, 3996.3406038003986, 4000.3799411091327, 4002.5397079335667, 4013.2776100302226, 4614.377059096979, 4635.490096089427, 4644.790984405709, 4646.047560250141, 4646.1172377248895, 5665.830025099253, 5671.517920976763, 5674.404187560329, 5674.659520428788, 5678.488935995781, 1383.7163381506766, 1393.226759148662, 1395.490645914234, 1397.7414178377032, 1397.7973193887033, 870.6996086350199, 874.0953113527469, 914.6524320758069, 928.5078908178676, 932.0446542294068, 4883.34074899891, 4885.560299572984, 4900.852974410774, 4901.387326584177, 4901.852944411673, 5748.9712551437815, 5750.223719797774, 5751.568632352591, 5752.137179423036, 5759.222504961776, 4803.327534145223, 4826.276058591239, 4879.926801097987, 4881.048195601895, 4891.51084891508, 3094.798838075518, 3103.239706271978, 3192.632847222599, 3192.8563214654932, 3197.1527545200543, 5604.719764011783, 5613.550915926716, 5614.214010038598, 5621.269234999506, 5624.3813180550105, 6076.605020673642, 6084.0265557511475, 6085.330613632497, 6087.6956152192215, 6089.1779609753, 5486.615936884459, 5606.831795046155, 5634.32388113429, 5635.154726791015, 5639.0, 5908.763649453974, 5911.586188966903, 5920.407959204045, 5923.911141332969, 5931.288245410578, 5742.856428589152, 5775.653460792366, 5783.248177736868, 5787.7395517200985, 5793.478586927196, 5473.425290344616, 5580.832575022756, 5584.162375643686, 5630.324361076697, 5632.971835140798, 3921.6666583339593, 3947.282931924622, 3955.2089582084272, 3956.3669812829808, 3960.861369852041, 5874.823755287348, 5884.911726324023, 5888.735006924784, 5889.823305300848, 5893.057110862242, 5607.579431542569, 5620.26936498269, 5649.519790817826, 5651.067573850269, 5658.688772117573, 5493.670379777226, 5621.8594535136945, 5633.267675202362, 5635.436456354496, 5635.492805647511, 5562.582806289463, 5588.832335029955, 5591.580631452739, 5598.272224610774, 5598.608097433141, 5721.8569535761935, 5724.112762521816, 5726.599138060295, 5731.939591175646, 5758.539316854725, 5410.053240682943, 5558.888822223452, 5559.4162612926675, 5560.777568897199, 5571.1086226203615], "unit": "ms", "name": "prototype.html", "value": 4189.856468332099}, {"lowerIsBetter": false, "replicates": [683.3644710419308, 698.5110422704107, 727.7671145233521, 763.4236151705463, 785.6111224943654, 12006.519739210433, 12336.81494777579, 12349.876501234996, 12356.691082722937, 12370.567030153947, 12237.0, 12355.135140540144, 12361.134720569564, 12364.0, 12368.876311236885, 607.7417097733456, 620.7361871204743, 621.0466933257451, 779.3453499060788, 796.2077732655987, 795.1889073145388, 796.2037962037933, 798.9081255655616, 801.4710291207804, 801.5110782422718, 823.9052508961456, 831.1854382704953, 831.6590198018813, 831.7754206364278, 831.7837362285788, 641.172886975803, 650.1418128070949, 800.4396922154457, 816.603947085663, 821.2198411509031, 609.20194545146, 609.4788955443121, 609.7317180440592, 609.7743834781115, 610.7129649064976, 12195.817062744067, 12333.0, 12365.443555039954, 12378.81431778524, 12380.257184568954, 11435.714107147305, 11521.135914806338, 11810.232334898204, 12061.819072713917, 12148.939255303756, 8490.957545212295, 8702.651893924236, 9990.300678952477, 10102.33311503601, 10119.848202276971, 2904.4626744052416, 2954.290970167144, 2984.940301193964, 2986.9850650746607, 3024.833634150121, 35770.28459430797, 35966.0, 35991.82004089963, 36012.459813102825, 36111.458328124834, 6828.624425656537, 6937.826554336182, 7036.155661320572, 7152.821179470451, 7169.820754481179, 10618.203634727426, 10934.781304373868, 10951.671449856518, 10957.890421095846, 10969.067629251444, 5432.891342173134, 5485.396606373296, 5703.201551782754, 5774.740136693775, 5780.5953583248765, 3493.4410494320787, 3498.8600455981987, 3528.435450327935, 3540.46892966052, 3555.715542756573, 2368.7868091871815, 2389.928302150938, 2390.175389490623, 2392.952140957171, 2398.2205783120207, 379.14502796194404, 383.1666126175557, 548.2297372192077, 551.7268951868771, 570.5948776368741, 518.2713015970916, 560.9775608975677, 571.6598623818821, 603.4418163199024, 603.8449103434519, 7858.292753652085, 7871.173526779606, 7925.326347260548, 8163.428560000862, 8189.0, 436.3541957902322, 572.390404219505, 575.925129733132, 576.881739243454, 603.6951339573487, 3267.3465306938706, 3268.6894744999186, 3363.83180840957, 3370.325934812998, 3432.7940323580665, 55440.72279638576, 55967.72016139893, 56150.7192464035, 56162.0, 56189.71905140448, 48853.755731221114, 49347.75326123346, 49370.259446108335, 49750.502494974586, 49896.251556226685, 44332.55667443349, 44409.11181776346, 44912.32631510595, 45386.092278154254, 45471.090578188254, 7166.140063192451, 7263.854722905407, 7489.101307843093, 7541.321281084729, 7561.243875612395, 33796.15509612279, 33942.0, 34611.4808277871, 34632.82683586566, 34756.13109672177, 39583.40624890571, 40961.590384095776, 43657.0, 44035.55964440315, 44189.77905110583, 8841.646334146562, 9632.711018669452, 9681.322307438411, 9752.414855108716, 9866.260030497884, 10250.53872575721, 10417.871746285211, 10452.32059916103, 10459.372437653765, 10582.629607963992, 9893.139443374726, 9915.65295214664, 9986.700398988041, 10168.49157542105, 10253.846192306972, 9242.399244049115, 9366.0, 9457.007014263403, 9607.807843842944, 9700.660476883275, 9768.853467197856, 9906.653267135904, 10089.142422893843, 10098.54556544972, 10111.595536178766, 8338.79153021155, 8505.617247223767, 8578.485290882567, 8765.517896515752, 8826.0, 7752.1472638008645, 7870.763877083697, 7916.129225785274, 7983.281504664608, 8112.675492980215], "unit": "ms", "name": "yui.html", "value": 5497.215831068988}], "name": "dromaeo_css", "value": 6060.297246789749}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 114.0, 113.0, 114.0, 121.0, 112.0, 112.0, 113.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 155.0, 169.0, 130.0, 153.0, 161.0, 131.0, 171.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 159.0, 161.0, 160.0, 161.0, 162.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 91.0, 72.0, 72.0, 73.0, 119.0, 89.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 129.0, 92.0, 92.0, 92.0, 128.0, 92.0, 92.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 72.0, 72.0, 74.0, 73.0, 82.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 71.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 82.0, 84.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 137.0, 123.0, 129.0, 133.0, 140.0, 126.0, 124.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [152.0, 153.0, 153.0, 161.0, 152.0, 143.0, 155.0, 152.0, 153.0, 158.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 68.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1540.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.71971185330713], "unit": "score", "name": "Richards", "value": 215.62461599999997}, {"lowerIsBetter": false, "replicates": [186.88095683049897], "unit": "score", "name": "DeltaBlue", "value": 353.79741800000016}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5060.606060606061], "unit": "score", "name": "Decrypt", "value": 52.59864071856286}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [620.9677419354839], "unit": "score", "name": "Splay", "value": 131.23225974025976}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19701.508071656186}]} 20:43:35 INFO - RETURN: dromaeo_css: 6060.30 20:43:35 INFO - RETURN: kraken: 1540.20 20:43:35 INFO - RETURN: v8_7: 19701.51 20:43:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19701.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1540.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6060.30"}}} 20:43:35 INFO - Return code: 0 20:43:35 INFO - # TBPL SUCCESS # 20:43:35 INFO - Running post-action listener: _resource_record_post_action 20:43:35 INFO - Running post-run listener: _resource_record_post_run 20:43:36 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514744320; Read time: 64; Write time: 552916 20:43:36 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 239783936; Read time: 0; Write time: 314344 20:43:36 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 274960384; Read time: 0; Write time: 238572 20:43:36 INFO - Running post-run listener: _upload_blobber_files 20:43:36 INFO - Blob upload gear active. 20:43:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:43:36 INFO - Copying logs to upload dir... 20:43:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.042000 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-18 20:43:36.383977) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 20:43:36.387136) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009939 build_url: 'https://queue.taskcluster.net/v1/task/l8VVvdn7QVmCgovEew2W1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 20:43:36.437434) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:43:36.437731) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1447905964.685369-208261492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 20:43:36.487429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 20:43:36.487716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 20:43:36.487994) ========= ========= Total master_lag: 0.26 =========