builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1448308164.08 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.081426) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.081802) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.082111) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.103242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.103518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.219914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.220174) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.306707) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.307168) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.307529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.307875) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 11:49:24-- 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% 43.4M=0s 2015-11-23 11:49:24 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.525907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.526228) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016336 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.583026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.583331) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 11:49:25,086 truncating revision to first 12 chars 2015-11-23 11:49:25,086 Setting DEBUG logging. 2015-11-23 11:49:25,086 attempt 1/10 2015-11-23 11:49:25,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:49:25,324 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.507523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.110143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.110642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.120197) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.120488) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.120874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 11:49:25.121333) ========= /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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:25 INFO - MultiFileLogger online at 20151123 11:49:25 in /builds/slave/test 11:49:25 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 11:49:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:25 INFO - {'append_to_log': False, 11:49:25 INFO - 'base_work_dir': '/builds/slave/test', 11:49:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:25 INFO - 'branch': 'Fx-Team-Non-PGO', 11:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:25 INFO - 'config_files': ('talos/linux_config.py',), 11:49:25 INFO - 'default_actions': ('clobber', 11:49:25 INFO - 'read-buildbot-config', 11:49:25 INFO - 'download-and-extract', 11:49:25 INFO - 'populate-webroot', 11:49:25 INFO - 'create-virtualenv', 11:49:25 INFO - 'install', 11:49:25 INFO - 'run-tests'), 11:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:25 INFO - 'download_minidump_stackwalk': True, 11:49:25 INFO - 'download_symbols': 'ondemand', 11:49:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:25 INFO - 'installer_path': 'installer.exe', 11:49:25 INFO - 'log_level': 'info', 11:49:25 INFO - 'log_name': 'talos', 11:49:25 INFO - 'log_to_console': True, 11:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:25 INFO - 'opt_config_files': (), 11:49:25 INFO - 'pip_index': False, 11:49:25 INFO - 'sps_profile': False, 11:49:25 INFO - 'sps_profile_interval': 0, 11:49:25 INFO - 'suite': 'dromaeojs', 11:49:25 INFO - 'system_bits': '64', 11:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:25 INFO - 'title': 'talos-linux64-ix-015', 11:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:25 INFO - 'use_talos_json': True, 11:49:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:25 INFO - 'work_dir': 'build'} 11:49:25 INFO - ##### 11:49:25 INFO - ##### Running clobber step. 11:49:25 INFO - ##### 11:49:25 INFO - Running pre-action listener: _resource_record_pre_action 11:49:25 INFO - Running main action method: clobber 11:49:25 INFO - rmtree: /builds/slave/test/build 11:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:26 INFO - Running post-action listener: _resource_record_post_action 11:49:26 INFO - ##### 11:49:26 INFO - ##### Running read-buildbot-config step. 11:49:26 INFO - ##### 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: read_buildbot_config 11:49:26 INFO - Using buildbot properties: 11:49:26 INFO - { 11:49:26 INFO - "properties": { 11:49:26 INFO - "buildnumber": 1121, 11:49:26 INFO - "product": "firefox", 11:49:26 INFO - "script_repo_revision": "production", 11:49:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:49:26 INFO - "repository": "", 11:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:49:26 INFO - "buildid": "20151123050554", 11:49:26 INFO - "slavename": "talos-linux64-ix-015", 11:49:26 INFO - "pgo_build": "False", 11:49:26 INFO - "basedir": "/builds/slave/test", 11:49:26 INFO - "project": "", 11:49:26 INFO - "platform": "ubuntu64_hw", 11:49:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:49:26 INFO - "slavebuilddir": "test", 11:49:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:49:26 INFO - "branch": "fx-team", 11:49:26 INFO - "repo_path": "integration/fx-team", 11:49:26 INFO - "stage_platform": "linux64", 11:49:26 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - }, 11:49:26 INFO - "sourcestamp": { 11:49:26 INFO - "repository": "", 11:49:26 INFO - "hasPatch": false, 11:49:26 INFO - "project": "", 11:49:26 INFO - "branch": "fx-team-linux64-talos", 11:49:26 INFO - "changes": [ 11:49:26 INFO - { 11:49:26 INFO - "category": null, 11:49:26 INFO - "files": [ 11:49:26 INFO - { 11:49:26 INFO - "url": null, 11:49:26 INFO - "name": "https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:49:26 INFO - } 11:49:26 INFO - ], 11:49:26 INFO - "repository": "", 11:49:26 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:49:26 INFO - "who": "pbrosset@mozilla.com", 11:49:26 INFO - "when": 1448285946, 11:49:26 INFO - "number": 6694867, 11:49:26 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:49:26 INFO - "project": "", 11:49:26 INFO - "at": "Mon 23 Nov 2015 05:39:06", 11:49:26 INFO - "branch": "fx-team-linux64-talos", 11:49:26 INFO - "revlink": "", 11:49:26 INFO - "properties": [ 11:49:26 INFO - [ 11:49:26 INFO - "buildid", 11:49:26 INFO - "20151123050554", 11:49:26 INFO - "Change" 11:49:26 INFO - ], 11:49:26 INFO - [ 11:49:26 INFO - "builduid", 11:49:26 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:26 INFO - "Change" 11:49:26 INFO - ], 11:49:26 INFO - [ 11:49:26 INFO - "pgo_build", 11:49:26 INFO - "False", 11:49:26 INFO - "Change" 11:49:26 INFO - ] 11:49:26 INFO - ], 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - } 11:49:26 INFO - ], 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - } 11:49:26 INFO - } 11:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:49:26 INFO - Running post-action listener: _resource_record_post_action 11:49:26 INFO - ##### 11:49:26 INFO - ##### Running download-and-extract step. 11:49:26 INFO - ##### 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: download_and_extract 11:49:26 INFO - mkdir: /builds/slave/test/build/tests 11:49:26 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')]} 11:49:26 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:49:26 INFO - Downloaded 1302 bytes. 11:49:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:49:26 INFO - Using the following test package requirements: 11:49:26 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'jsshell-linux-x86_64.zip'], 11:49:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:26 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:26 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49:26 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')]} 11:49:26 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:27 INFO - Downloaded 21339409 bytes. 11:49:27 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 11:49:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:27 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 11:49:28 INFO - Return code: 0 11:49:28 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 11:49:28 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')]} 11:49:28 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:30 INFO - Downloaded 21339409 bytes. 11:49:30 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 11:49:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:30 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 11:49:32 INFO - Return code: 0 11:49:32 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')]} 11:49:32 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:33 INFO - Downloaded 11130997 bytes. 11:49:33 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 11:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:33 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 11:49:33 INFO - Return code: 0 11:49:33 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')]} 11:49:33 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:34 INFO - Downloaded 55911868 bytes. 11:49:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - mkdir: /builds/slave/test/properties 11:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:34 INFO - Contents: 11:49:34 INFO - build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - Running post-action listener: _resource_record_post_action 11:49:34 INFO - Running post-action listener: set_extra_try_arguments 11:49:34 INFO - ##### 11:49:34 INFO - ##### Running populate-webroot step. 11:49:34 INFO - ##### 11:49:34 INFO - Running pre-action listener: _resource_record_pre_action 11:49:34 INFO - Running main action method: populate_webroot 11:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:49:34 INFO - '../fennec_ids.txt'], 11:49:34 INFO - 'tests': ['tcheck2']}, 11:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:34 INFO - '--tppagecycles', 11:49:34 INFO - '7'], 11:49:34 INFO - 'tests': ['tsvgm']}}, 11:49:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:49:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'tests': ['damp', 'tps']}, 11:49:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['damp', 'tps']}, 11:49:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:34 INFO - 'other': {'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'other_l64': {'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'other_nol64': {'tests': ['a11yr', 11:49:34 INFO - 'ts_paint', 11:49:34 INFO - 'tpaint', 11:49:34 INFO - 'sessionrestore', 11:49:34 INFO - 'sessionrestore_no_auto_restore']}, 11:49:34 INFO - 'svgr': {'tests': ['tsvgx', 11:49:34 INFO - 'tsvgr_opacity', 11:49:34 INFO - 'tart', 11:49:34 INFO - 'tscrollx', 11:49:34 INFO - 'cart']}, 11:49:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['tsvgx', 11:49:34 INFO - 'tsvgr_opacity', 11:49:34 INFO - 'tart', 11:49:34 INFO - 'tscrollx', 11:49:34 INFO - 'cart']}, 11:49:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'tests': ['tp5o']}, 11:49:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'talos_options': ['--e10s'], 11:49:34 INFO - 'tests': ['tp5o']}, 11:49:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'talos_options': ['--xperf_path', 11:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:34 INFO - 'tests': ['tp5n']}, 11:49:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:34 INFO - 'talos_options': ['--e10s', 11:49:34 INFO - '--xperf_path', 11:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:34 INFO - 'tests': ['tp5n']}}, 11:49:34 INFO - 'talos.zip': {'path': '', 11:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:34 INFO - Running post-action listener: _resource_record_post_action 11:49:34 INFO - ##### 11:49:34 INFO - ##### Running create-virtualenv step. 11:49:34 INFO - ##### 11:49:34 INFO - Running pre-action listener: _resource_record_pre_action 11:49:34 INFO - Running main action method: create_virtualenv 11:49:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:34 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 11:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:34 INFO - Using real prefix '/usr' 11:49:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:37 INFO - Installing pip.................done. 11:49:37 INFO - Return code: 0 11:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:37 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')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:37 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 11:49:37 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 11:49:37 INFO - Using env: {'DISPLAY': ':0', 11:49:37 INFO - 'HOME': '/home/cltbld', 11:49:37 INFO - 'LANG': 'en_US.UTF-8', 11:49:37 INFO - 'LANGUAGE': 'en_US:en', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MAIL': '/var/mail/cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SHLVL': '1', 11:49:37 INFO - 'TERM': 'linux', 11:49:37 INFO - 'TMOUT': '86400', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - '_': '/tools/buildbot/bin/python'} 11:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:37 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 11:49:37 INFO - Cleaning up... 11:49:37 INFO - Return code: 0 11:49:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:37 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')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:37 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 11:49:37 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 11:49:37 INFO - Using env: {'DISPLAY': ':0', 11:49:37 INFO - 'HOME': '/home/cltbld', 11:49:37 INFO - 'LANG': 'en_US.UTF-8', 11:49:37 INFO - 'LANGUAGE': 'en_US:en', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MAIL': '/var/mail/cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SHLVL': '1', 11:49:37 INFO - 'TERM': 'linux', 11:49:37 INFO - 'TMOUT': '86400', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - '_': '/tools/buildbot/bin/python'} 11:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:37 INFO - Downloading/unpacking psutil>=0.7.1 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:39 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:49:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:39 INFO - Installing collected packages: psutil 11:49:39 INFO - Running setup.py install for psutil 11:49:39 INFO - building 'psutil._psutil_linux' extension 11:49:39 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 11:49:39 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 11:49:40 INFO - building 'psutil._psutil_posix' extension 11:49:40 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 11:49:40 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 11:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:40 INFO - Successfully installed psutil 11:49:40 INFO - Cleaning up... 11:49:40 INFO - Return code: 0 11:49:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:40 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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:40 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 11:49:40 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 11:49:40 INFO - Using env: {'DISPLAY': ':0', 11:49:40 INFO - 'HOME': '/home/cltbld', 11:49:40 INFO - 'LANG': 'en_US.UTF-8', 11:49:40 INFO - 'LANGUAGE': 'en_US:en', 11:49:40 INFO - 'LOGNAME': 'cltbld', 11:49:40 INFO - 'MAIL': '/var/mail/cltbld', 11:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:40 INFO - 'MOZ_NO_REMOTE': '1', 11:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:40 INFO - 'NO_EM_RESTART': '1', 11:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:40 INFO - 'PWD': '/builds/slave/test', 11:49:40 INFO - 'SHELL': '/bin/bash', 11:49:40 INFO - 'SHLVL': '1', 11:49:40 INFO - 'TERM': 'linux', 11:49:40 INFO - 'TMOUT': '86400', 11:49:40 INFO - 'USER': 'cltbld', 11:49:40 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:40 INFO - '_': '/tools/buildbot/bin/python'} 11:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:40 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 11:49:40 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 11:49:40 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 11:49:40 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 11:49:40 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 11:49:40 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 11:49:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:42 INFO - Installing collected packages: mozsystemmonitor 11:49:42 INFO - Running setup.py install for mozsystemmonitor 11:49:42 INFO - Successfully installed mozsystemmonitor 11:49:42 INFO - Cleaning up... 11:49:42 INFO - Return code: 0 11:49:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:42 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 11:49:42 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 11:49:42 INFO - Using env: {'DISPLAY': ':0', 11:49:42 INFO - 'HOME': '/home/cltbld', 11:49:42 INFO - 'LANG': 'en_US.UTF-8', 11:49:42 INFO - 'LANGUAGE': 'en_US:en', 11:49:42 INFO - 'LOGNAME': 'cltbld', 11:49:42 INFO - 'MAIL': '/var/mail/cltbld', 11:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:42 INFO - 'MOZ_NO_REMOTE': '1', 11:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:42 INFO - 'NO_EM_RESTART': '1', 11:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:42 INFO - 'PWD': '/builds/slave/test', 11:49:42 INFO - 'SHELL': '/bin/bash', 11:49:42 INFO - 'SHLVL': '1', 11:49:42 INFO - 'TERM': 'linux', 11:49:42 INFO - 'TMOUT': '86400', 11:49:42 INFO - 'USER': 'cltbld', 11:49:42 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:42 INFO - '_': '/tools/buildbot/bin/python'} 11:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:42 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 11:49:42 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 11:49:42 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 11:49:42 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 11:49:42 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 11:49:42 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 11:49:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - Downloading docopt-0.6.1.tar.gz 11:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:44 INFO - Running setup.py install for blobuploader 11:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:45 INFO - Running setup.py install for requests 11:49:45 INFO - Running setup.py install for docopt 11:49:45 INFO - Successfully installed blobuploader requests docopt 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:45 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 11:49:45 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 11:49:45 INFO - Using env: {'DISPLAY': ':0', 11:49:45 INFO - 'HOME': '/home/cltbld', 11:49:45 INFO - 'LANG': 'en_US.UTF-8', 11:49:45 INFO - 'LANGUAGE': 'en_US:en', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MAIL': '/var/mail/cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SHLVL': '1', 11:49:45 INFO - 'TERM': 'linux', 11:49:45 INFO - 'TMOUT': '86400', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - '_': '/tools/buildbot/bin/python'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:45 INFO - Running setup.py (path:/tmp/pip-esHqdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:45 INFO - Running setup.py (path:/tmp/pip-YdtgZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:45 INFO - Running setup.py (path:/tmp/pip-tHHhJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:45 INFO - Running setup.py (path:/tmp/pip-iA4Dhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:46 INFO - Running setup.py (path:/tmp/pip-KFMvKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:46 INFO - Running setup.py (path:/tmp/pip-aNkkVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:46 INFO - Running setup.py (path:/tmp/pip-LVD4WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:46 INFO - Running setup.py (path:/tmp/pip-r6ylQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:46 INFO - Running setup.py (path:/tmp/pip-KhnEa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:46 INFO - Running setup.py (path:/tmp/pip-aIj6Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:46 INFO - Running setup.py (path:/tmp/pip-je5RoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:46 INFO - Running setup.py (path:/tmp/pip-8j8fA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:46 INFO - Running setup.py (path:/tmp/pip-l_OVuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:46 INFO - Running setup.py (path:/tmp/pip-z7hAuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:46 INFO - Running setup.py (path:/tmp/pip-U4EHhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:46 INFO - Running setup.py (path:/tmp/pip-c_BdaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:46 INFO - Running setup.py (path:/tmp/pip-dRdFZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:46 INFO - Running setup.py install for manifestparser 11:49:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Running setup.py install for mozcrash 11:49:47 INFO - Running setup.py install for mozdebug 11:49:47 INFO - Running setup.py install for mozdevice 11:49:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Running setup.py install for mozfile 11:49:47 INFO - Running setup.py install for mozhttpd 11:49:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Running setup.py install for mozinfo 11:49:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Running setup.py install for mozInstall 11:49:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:47 INFO - Running setup.py install for mozleak 11:49:47 INFO - Running setup.py install for mozlog 11:49:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for moznetwork 11:49:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozprocess 11:49:48 INFO - Running setup.py install for mozprofile 11:49:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozrunner 11:49:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozscreenshot 11:49:48 INFO - Running setup.py install for moztest 11:49:48 INFO - Running setup.py install for mozversion 11:49:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:48 INFO - Cleaning up... 11:49:48 INFO - Return code: 0 11:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:48 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')]} 11:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:48 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')]} 11:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:48 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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:48 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 11:49:48 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 11:49:48 INFO - Using env: {'DISPLAY': ':0', 11:49:48 INFO - 'HOME': '/home/cltbld', 11:49:48 INFO - 'LANG': 'en_US.UTF-8', 11:49:48 INFO - 'LANGUAGE': 'en_US:en', 11:49:48 INFO - 'LOGNAME': 'cltbld', 11:49:48 INFO - 'MAIL': '/var/mail/cltbld', 11:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:48 INFO - 'MOZ_NO_REMOTE': '1', 11:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:48 INFO - 'NO_EM_RESTART': '1', 11:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:48 INFO - 'PWD': '/builds/slave/test', 11:49:48 INFO - 'SHELL': '/bin/bash', 11:49:48 INFO - 'SHLVL': '1', 11:49:48 INFO - 'TERM': 'linux', 11:49:48 INFO - 'TMOUT': '86400', 11:49:48 INFO - 'USER': 'cltbld', 11:49:48 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:48 INFO - '_': '/tools/buildbot/bin/python'} 11:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:49 INFO - Running setup.py (path:/tmp/pip-m_8vIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:49 INFO - Running setup.py (path:/tmp/pip-W5FHTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:49 INFO - Running setup.py (path:/tmp/pip-tiKSI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:49 INFO - Running setup.py (path:/tmp/pip-mHZc4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:49 INFO - Running setup.py (path:/tmp/pip-gP3Uuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:49 INFO - Running setup.py (path:/tmp/pip-4PUrM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:49 INFO - Running setup.py (path:/tmp/pip-Bmzey9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:49 INFO - Running setup.py (path:/tmp/pip-HGnwwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:49 INFO - Running setup.py (path:/tmp/pip-hTbb_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:49 INFO - Running setup.py (path:/tmp/pip-WlIrHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:49 INFO - Running setup.py (path:/tmp/pip-XM4w8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:49 INFO - Running setup.py (path:/tmp/pip-3I9Ipe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:49 INFO - Running setup.py (path:/tmp/pip-6mnJ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:49 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)) 11:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:49 INFO - Running setup.py (path:/tmp/pip-vW_OCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:50 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)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:50 INFO - Running setup.py (path:/tmp/pip-BzjRaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:50 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)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:50 INFO - Running setup.py (path:/tmp/pip-NudvWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:50 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)) 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:50 INFO - Running setup.py (path:/tmp/pip-EYVJGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:50 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)) 11:49:50 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)) 11:49:50 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)) 11:49:50 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)) 11:49:50 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)) 11:49:50 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)) 11:49:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:50 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 11:49:51 INFO - Downloading blessings-1.5.1.tar.gz 11:49:51 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 11:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:51 INFO - Installing collected packages: blessings 11:49:51 INFO - Running setup.py install for blessings 11:49:52 INFO - Successfully installed blessings 11:49:52 INFO - Cleaning up... 11:49:52 INFO - Return code: 0 11:49:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:52 INFO - Reading from file tmpfile_stdout 11:49:52 INFO - Current package versions: 11:49:52 INFO - argparse == 1.2.1 11:49:52 INFO - blessings == 1.5.1 11:49:52 INFO - blobuploader == 1.2.4 11:49:52 INFO - docopt == 0.6.1 11:49:52 INFO - manifestparser == 1.1 11:49:52 INFO - mozInstall == 1.12 11:49:52 INFO - mozcrash == 0.16 11:49:52 INFO - mozdebug == 0.1 11:49:52 INFO - mozdevice == 0.47 11:49:52 INFO - mozfile == 1.2 11:49:52 INFO - mozhttpd == 0.7 11:49:52 INFO - mozinfo == 0.9 11:49:52 INFO - mozleak == 0.1 11:49:52 INFO - mozlog == 3.0 11:49:52 INFO - moznetwork == 0.27 11:49:52 INFO - mozprocess == 0.22 11:49:52 INFO - mozprofile == 0.27 11:49:52 INFO - mozrunner == 6.11 11:49:52 INFO - mozscreenshot == 0.1 11:49:52 INFO - mozsystemmonitor == 0.0 11:49:52 INFO - moztest == 0.7 11:49:52 INFO - mozversion == 1.4 11:49:52 INFO - psutil == 3.1.1 11:49:52 INFO - requests == 1.2.3 11:49:52 INFO - wsgiref == 0.1.2 11:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe6ff0fac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, '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': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', '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 11:49:52 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 11:49:52 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 11:49:52 INFO - Using env: {'DISPLAY': ':0', 11:49:52 INFO - 'HOME': '/home/cltbld', 11:49:52 INFO - 'LANG': 'en_US.UTF-8', 11:49:52 INFO - 'LANGUAGE': 'en_US:en', 11:49:52 INFO - 'LOGNAME': 'cltbld', 11:49:52 INFO - 'MAIL': '/var/mail/cltbld', 11:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:52 INFO - 'MOZ_NO_REMOTE': '1', 11:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:52 INFO - 'NO_EM_RESTART': '1', 11:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:52 INFO - 'PWD': '/builds/slave/test', 11:49:52 INFO - 'SHELL': '/bin/bash', 11:49:52 INFO - 'SHLVL': '1', 11:49:52 INFO - 'TERM': 'linux', 11:49:52 INFO - 'TMOUT': '86400', 11:49:52 INFO - 'USER': 'cltbld', 11:49:52 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:52 INFO - '_': '/tools/buildbot/bin/python'} 11:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 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)) 11:49:52 INFO - Cleaning up... 11:49:52 INFO - Return code: 0 11:49:52 INFO - Running post-action listener: _resource_record_post_action 11:49:52 INFO - Running post-action listener: _start_resource_monitoring 11:49:52 INFO - Starting resource monitoring. 11:49:52 INFO - ##### 11:49:52 INFO - ##### Running install step. 11:49:52 INFO - ##### 11:49:52 INFO - Running pre-action listener: _resource_record_pre_action 11:49:52 INFO - Running main action method: install 11:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:52 INFO - Reading from file tmpfile_stdout 11:49:52 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:52 INFO - Reading from file tmpfile_stdout 11:49:52 INFO - Output received: 11:49:52 INFO - Usage: mozinstall [options] installer 11:49:52 INFO - Options: 11:49:52 INFO - -h, --help show this help message and exit 11:49:52 INFO - -d DEST, --destination=DEST 11:49:52 INFO - Directory to install application into. [default: 11:49:52 INFO - "/builds/slave/test"] 11:49:52 INFO - --app=APP Application being installed. [default: firefox] 11:49:52 INFO - mkdir: /builds/slave/test/build/application 11:49:52 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'] 11:49:52 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 11:50:07 INFO - Reading from file tmpfile_stdout 11:50:07 INFO - Output received: 11:50:07 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:07 INFO - Running post-action listener: _resource_record_post_action 11:50:07 INFO - ##### 11:50:07 INFO - ##### Running run-tests step. 11:50:07 INFO - ##### 11:50:07 INFO - Running pre-action listener: _resource_record_pre_action 11:50:07 INFO - Running main action method: run_tests 11:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:07 INFO - Python 2.7.3 11:50:07 INFO - Return code: 0 11:50:07 INFO - grabbing minidump binary from tooltool 11:50:07 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')]} 11:50:07 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 0x2162b70>, '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 0x21b3dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b4250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:07 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 11:50:07 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 11:50:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:07 INFO - Return code: 0 11:50:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:07 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 11:50:07 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 11:50:07 INFO - Using env: {'DISPLAY': ':0', 11:50:07 INFO - 'HOME': '/home/cltbld', 11:50:07 INFO - 'LANG': 'en_US.UTF-8', 11:50:07 INFO - 'LANGUAGE': 'en_US:en', 11:50:07 INFO - 'LOGNAME': 'cltbld', 11:50:07 INFO - 'MAIL': '/var/mail/cltbld', 11:50:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:07 INFO - 'MOZ_NO_REMOTE': '1', 11:50:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:07 INFO - 'NO_EM_RESTART': '1', 11:50:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:07 INFO - 'PWD': '/builds/slave/test', 11:50:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:07 INFO - 'SHELL': '/bin/bash', 11:50:07 INFO - 'SHLVL': '1', 11:50:07 INFO - 'TERM': 'linux', 11:50:07 INFO - 'TMOUT': '86400', 11:50:07 INFO - 'USER': 'cltbld', 11:50:07 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818', 11:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:07 INFO - '_': '/tools/buildbot/bin/python'} 11:50:07 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 11:50:07 INFO - mozversion INFO | application_buildid: 20151123050554 11:50:07 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:07 INFO - mozversion INFO | application_display_name: Nightly 11:50:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:07 INFO - mozversion INFO | application_name: Firefox 11:50:07 INFO - mozversion INFO | application_remotingname: firefox 11:50:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:50:07 INFO - mozversion INFO | application_vendor: Mozilla 11:50:07 INFO - mozversion INFO | application_version: 45.0a1 11:50:07 INFO - mozversion INFO | platform_buildid: 20151123050554 11:50:07 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:07 INFO - mozversion INFO | platform_version: 45.0a1 11:50:07 INFO - 2015-11-23 11:50:07,570 DEBUG : using testdate: 1448308207 11:50:07 INFO - 2015-11-23 11:50:07,571 DEBUG : actual date: 1448308207 11:50:07 INFO - 2015-11-23 11:50:07,618 INFO : starting webserver on 'localhost:49980' 11:50:07 INFO - 2015-11-23 11:50:07,619 INFO : Starting test suite talos-linux64-ix-015 11:50:07 INFO - 2015-11-23 11:50:07,619 INFO : Starting test dromaeo_css 11:50:07 INFO - 2015-11-23 11:50:07,619 DEBUG : operating with platform_type : linux_ 11:50:07 INFO - 2015-11-23 11:50:07,620 INFO : Initialising browser for dromaeo_css test... 11:50:07 INFO - 2015-11-23 11:50:07,636 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtSCoL/profile http://localhost:49980/getInfo.html 11:50:12 INFO - 2015-11-23 11:50:12,203 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:50:12 INFO - 2015-11-23 11:50:12,203 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:50:12 INFO - 2015-11-23 11:50:12,203 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:50:12 INFO - 2015-11-23 11:50:12,203 DEBUG : BROWSER_OUTPUT: __metrics 11:50:12 INFO - 2015-11-23 11:50:12,372 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:13 INFO - 2015-11-23 11:50:13,705 INFO : Browser initialized. 11:50:13 INFO - 2015-11-23 11:50:13,705 INFO : Running cycle 1/1 for dromaeo_css test... 11:50:13 INFO - 2015-11-23 11:50:13,705 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtSCoL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:50:25 INFO - 2015-11-23 11:50:25,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 140189696 11:50:25 INFO - 2015-11-23 11:50:25,585 DEBUG : BROWSER_OUTPUT: 11:51:17 INFO - 2015-11-23 11:51:17,024 DEBUG : BROWSER_OUTPUT: 1448308277023 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] 11:53:29 INFO - 2015-11-23 11:53:29,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49980/tests/dromaeo/cssquery-ext.html) 11:53:30 INFO - 2015-11-23 11:53:30,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 252698624 11:53:30 INFO - 2015-11-23 11:53:30,611 DEBUG : BROWSER_OUTPUT: 11:56:33 INFO - 2015-11-23 11:56:33,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-ext.html (next: http://localhost:49980/tests/dromaeo/cssquery-jquery.html) 11:56:33 INFO - 2015-11-23 11:56:33,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 219119616 11:56:33 INFO - 2015-11-23 11:56:33,668 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2015-11-23 11:59:35,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49980/tests/dromaeo/cssquery-mootools.html) 11:59:36 INFO - 2015-11-23 11:59:36,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 219459584 11:59:36 INFO - 2015-11-23 11:59:36,190 DEBUG : BROWSER_OUTPUT: 12:02:38 INFO - 2015-11-23 12:02:38,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49980/tests/dromaeo/cssquery-prototype.html) 12:02:38 INFO - 2015-11-23 12:02:38,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 201146368 12:02:38 INFO - 2015-11-23 12:02:38,758 DEBUG : BROWSER_OUTPUT: 12:05:41 INFO - 2015-11-23 12:05:41,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49980/tests/dromaeo/cssquery-yui.html) 12:05:42 INFO - 2015-11-23 12:05:42,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 204623872 12:05:42 INFO - 2015-11-23 12:05:42,145 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/dromaeo/cssquery-yui.html (next: http://localhost:49980/tests/dromaeo/cssquery-dojo.html) 12:08:44 INFO - 2015-11-23 12:08:44,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 277348352 12:08:44 INFO - 2015-11-23 12:08:44,967 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,969 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:08:44 INFO - 2015-11-23 12:08:44,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:08:44 INFO - 2015-11-23 12:08:44,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:08:44 INFO - 2015-11-23 12:08:44,969 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:08:44 INFO - 2015-11-23 12:08:44,969 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.697699764527;2723.8093333466663;2731.4946734854043;2739.150863232398;2751.8211316264446;4530.773461326937;4663.2305669564485;4686.742229177394;4710.434747830257;4732.668713190078;4562.7718614069245;4615.723056616605;4673.626109911207;4678.53214678532;4681.344611754357;4335.284678028122;4366.6506679465565;4419.779011049451;4476.9776151119195;4516.728996260234;4175.331946888498;4401.295792673157;4440.622547083502;4486.842960496383;4521.073179998109;4240.851570195028;4281.614654681078;4318.395424640553;4326.502452217972;4328.199283132599;4339.06710057336;4340.8480703175555;4354.912901741979;4361.672874534423;4395.120975804852;4322.308430651081;4332.848350307724;4347.413099231595;4364.716293440948;4367.650587952956;4470.195364834329;4534.773261336953;4588;4594.1271158479785;4679.15775160471;5031.748412579356;5032.798688052473;5034.144195486776;5037.345145131109;5074.923876141861;5052.242163675442;5062.645614806965;5063.696178229281;5066.822661206877;5121.103806833789;4528.411306530163;4622.237330840441;4628.722276663344;4632.119897219518;4723.7638118093955;5210.869728256824;5270.262163297065;5270.552003079704;5273.050850846885;5326.866828329323;5040.647154699209;5041.697498150123;5062.417821950449;5069.036882992294;5106.565941894981;4835.6131509479865;4888.2178851384315;4955.578775804097;4956.776945037482;5004.124278251365;5032.144535428986;5047.9495205048215;5049.26785616091;5050.141475949097;5092.745362731923;4996.050750357421;4999.42506611737;5000.374953130859;5004.949950500449;5010.649254552146;4055.0673345130785;4121.4848143982;4158.189153115113;4216.451861258017;4221.915561688749;3680.1167719747605;3689.538807649044;3698.3712768829364;3728.198437335986;3728.9813550932613;4344.044310251739;4344.869653910388;4346.717463364871;4354.042110735696;4383.7588932609015;4846.248831431134;4959.727215003138;5025.974870125626;5027.396712394536;5084.6440749147205;4385.758783266887;4401.383806267125;4403.207422663887;4404.1411924674385;4423.845165419195;4530.29780384041;4538.954610453853;4539.500654927955;4542.068875880436;4577.679562430598;4566.748828814513;4685.367475390915;4686.203345431217;4686.390769199982;4809.687370320918;5063.468335824686;5122.334096567422;5122.590192784643;5127.6410651254055;5170.043541944752;4848.12733707936;4856.68431551948;4858.125537403302;4861.295112208781;4902.828401005948;4762.476127626028;4782.856514304576;4899.265110233494;4900.14247506692;4931.2849636803185;5053.216751403538;5084.5932325414615;5085;5096.592272618108;5128.692278463304;4903.730294833818;4906.0433215522635;4909.4354149273295;4909.877253068702;4960.156773348467;4703.388559487382;4825.179719447772;4825.831095911767;4880.389951256093;4982.10322142018;4793.760311984456;4807;4809.062232864558;4817.205161148371;4846.079244943449;4924.433690125538;4924.679895806761;4928.630352723489;4930.383702037246;4976.5023497649945;4609.124266389375;4687.953120468752;4734.195186818318;4740.265258884879;4855.684380515255 12:08:44 INFO - 2015-11-23 12:08:44,973 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.6804121650661;563.4787821265331;569.8888716700243;582.592185470171;584.3630442817329;27197.184084477474;27759.444811103793;27775.5833662495;36974.445383319275;37885.81057094718;41524.16951660965;42021.57978420215;42087.78956105215;42092.368614470804;42101.7894910525;7789.532628042307;7953.801154971115;7954.761357159266;7961.044674639023;7963.960180199091;7028;7186.748463803768;9918.05778451046;10165.644202452915;10170.288079834414;10058.849117263248;10206.64276750314;10207.081362677358;10211.183105351554;10240.129588984944;7201.6039117848495;7394;9971.650992215275;10026.69919902404;10115.039071288216;7099.716011359539;7214.170370407418;7217.206107328189;10090;10363.533640986174;37210.25579488422;37634.43548346777;37654.81172594147;37693;37792;2771.9722802771917;2854.9714502854913;3246.902592922216;3476.4959080933377;3519.914259771063;27343.316417089733;27555.17334479969;27648.861755691294;27728;28229.717702822913;3434.227298857762;3448.1552019755068;3463;3481.390756617607;3599.838007289652;229143;231390;231587;231986;231997;57010;57190;57190;57215.71392143096;57282.713586432634;55417.722911385186;56408.71795641078;58600.706996464745;60537;62199;13719.1082579632;13824.170549767046;13914.860851391559;13924.094933829268;13928.791068133985;10542.42016689074;10616.469176541143;10617.469126543641;10623.097036751962;10630;19244.71132933007;19420.708689369672;19461.610767784565;19475.415737527896;19491.805081949282;7456.925430745623;7821.6089195541135;7837.529748215012;7849.725259615886;7900.091489478668;782.3037496628006;852.1648784191403;897.3045889435609;1018.8930162332997;1046.6755305855208;26589.3352666181;26619.733802662115;26649.733502664723;26821.329466763098;26850.462990740074;970.3644113105927;983.3460748602242;1016.537475448669;1018.5671089786811;1066.4880857188439;13758.793618095737;14061.648458788612;14062.929685351508;14108.224047677477;14160.929195353958;276705;278804;280724;281385;282027;45536;46111.76944115258;46148.30777538339;46168.3074753879;46199.5380046202;1169.8069818480026;1197.0483465644834;1213.7269114449177;1217.4825699077855;1222.4498975461079;24489.38776530601;25487.74512254928;26229.606555902057;26313;26329.473410532064;39766.60233397745;39939;40160;40181.79909100436;40292;221351;226097;336526;344002.87969763816;345770;29907.85046074843;29928;29950.10648615666;29979.70020299769;30436.695633044274;38704.22591548097;39791.40312895251;39852.800735996134;40140.38385585578;40278.19443611053;33638.66361336453;34067.318653627284;34086.31827363488;34395.31209375848;34541.65458345485;34007.82996085004;34324.48513272353;34402.65597343994;34634.65365346415;35362.646373535936;33150.171245718084;33676.158096047795;33837.492437613946;33853.66146338505;34087.147821304665;30652.386952261277;31426.68573314329;31669;31681.20796980094;31811.20471988219;23748.050077996686;24018.879905601058;24311.27066188017;24508.632370514813;24576.50846983086 12:08:44 INFO - 2015-11-23 12:08:44,974 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.85054650680456;339.6823969588434;339.81649909049116;340.3057762165182;344.9793012419253;11855.46650400732;12177;15456.149911754863;16029.679406411864;16358.91820540897;12527.37363131842;12535.686607834808;12694.3652817359;14408.063475874087;14937.775933361008;4952.108620448336;4956.62825288104;5062.569681577071;5107.208382700669;5110.207917772733;4992.350994370745;4994.1260279451135;5034.546890779848;5041.596672266228;5043.722595257259;4972.8508144755715;4978.55193032627;4987.950120498803;5001.524855138756;5057.5701065409485;5065.620078494109;5098.082345177866;5104.4640312767;5109.744512774365;5112.054269960069;4530.252508336121;4533.410656614652;4542.341360502709;4544.045750392422;4545.11370282795;19699.901500492404;19880.105395257247;20080.39758807238;20215.797842021686;20370.96290370966;1926.422073377981;1945.9416217513497;1954.4039068084228;2005.568802707425;2048.8668236564577;12679.239245645198;12681.809772853323;12751.10742248043;12851.935740321333;12996.480140794356;1621.0840874905641;1657.0968821992044;1736.3401907275281;1769.3807167491404;1822.7539282197;51887.74056129733;54208.45791542113;54277;55328;55548.44451555514;9295.67465138717;9472.147506724428;9645.855312170183;9675.951620241995;9750.26872984529;11123.55505779776;11213;11580.6525804226;12327.753444931051;12365.567205147776;6912.205096413876;6951.131108611424;7000.544964577286;7021.508494405342;7114.39527640146;6823.317668233236;6875;6876.381125698711;6901.102856628707;6929.133858267716;5753.626014309057;5771.365149833515;5810.7966221182905;5811.970940145272;5896.056630939115;1665.5170000699661;1690.3576640876388;1693.9497511542677;1702.1999660159704;1712.6489069740674;407.81852075826566;828.2380210206625;840.6133178737849;868.2793281576277;884.5975081337975;9765.609375624896;9838.754031149136;9970.950145249373;10045.598176073021;10183.694489165337;388.99027524311555;405.7829061452109;418.2033226703135;420.12613763372724;438.3402978517311;4939.3084968104495;5907.7046147692445;5972.432618901197;9274.721758347261;9581.473018984023;497976;498978;502154;510970;523654;58992.41007589869;62984.68507657432;63257;70570.64714676393;74567.62716186384;1071.7213524483534;1074.5862842805577;1081.983770243447;1082.6860210538855;1086.266769930294;13847.653808654864;13922.651933701738;14352.712945740817;14528.346224419714;14618.707625847212;29420;29459;31053.223669408446;31776;34176.82911585426;40706;41378.1724365505;42320.5767942329;43172.13655726931;45777.54222457733;8779.209871111376;8965.731028069169;9145.085491450802;9181.49501777382;9190.126937940884;16710;16758.748618770485;16946.237419315912;17158.48524544266;17213.967161970322;13721.519746808814;14128.152310861382;14171.433142674177;14220.004599677923;14371.065880718139;13618.931905340807;13780.586582402544;13870.583882483541;14113.858861411665;14249.572512824632;13969.511067112602;14296.57110286693;14380.712385752016;14745.557633271019;14862.554123376316;8799.34004949644;8951.641934322553;9033.187013168847;9061.864072039056;9066.682666106655;9403.247740180906;10335.449682547678;14130;14345;14373.64065898361 12:08:44 INFO - 2015-11-23 12:08:44,977 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1209.1294268126946;1580.1072394097334;1599.1604407685963;1620.7892973913392;1629.0551480141519;5769.567282453817;6489.415952564268;6652.86694266115;6660.700268487917;6664.600123992564;6641.269460359356;6733.02371156182;6755.155605549294;6766.4925130615275;6774.661266936658;1764.444200076978;1800.3878681248373;2049.661805802041;2059.4233614587865;2075.1595603780493;2082.5106100066473;2086.1968142265187;2087.5929193807215;2089.3418573149484;2089.414963810128;2032.3699653107583;2041.214132558968;2080.43828166395;2080.4798800299927;2083.8437117216195;2040.7959204079548;2043.4993426610426;2070.1512379924234;2074.968875466869;2083.593699228651;2067.24545540878;2079.2099002379;2081.552466219755;2084.3121769816075;2085.9269925552535;6780.898286525706;6817.69320380584;6819.181698196198;6820.829479263009;6834.384905358492;4025.4163146343617;4135.421041054255;4141.813618387149;4145.709800313979;4149.232392007489;2351.165336305604;2770.9584356234673;2908.43285559316;2920.985395073032;2939.470895238856;803.9035315762087;838.8364268967554;897.3942588752566;931.1433481197247;942.7595963029383;8982.146696063863;8985.101489851028;8988.10118988096;8989.146031127033;8994.41536300145;3942.664873485786;3949.921001579952;4014.7791871447353;4103.425520427142;4131.29767939451;7820.061592608809;7855.214478552099;7872.803179920548;7882.330001949784;7906.841863162705;4176.0603864130935;4179.6029377209115;4191.371294305817;4199.265128602482;4201;3800.4869342638945;3816.5229346331707;3818.7326887117633;3826.1391186982705;3829.80850957451;3016.2308611304416;3092.6752690967573;3244.6755324467836;3255.9837200813845;3426.777259478126;1100.5212732461405;1126.52122847791;1131.7623299107279;1135.795556799784;1136.023020202625;954.7994921066654;1043.8695163104612;1140.105017561227;1172.3493461128985;1172.472387425662;6408.967955160194;6475.352464753581;6481.837954051092;6497.18785151856;6507.674616269168;979.6228452045871;995.2038369304528;1000.9449480278508;1009.7778488732467;1016.5425558498705;4961.454240033593;5015.14742493777;5053.797848086109;5059.671121377099;5064.4935506449065;8034.196580341919;8275.50346979183;8281.875771863426;8290.668373265002;8294.917050829536;7854.4894581851995;8076.111627720946;8083.070446898564;8107.55408452529;8110.797230069295;6413.358664133642;6471.514636402195;6471.773487927994;6500.447461965691;6514.999999999905;6111.816645500642;6198.101275315144;6209.813705588659;6222.28443728977;6234.719437625408;7284.817879553054;7397.445191610758;7404.481686281909;7416.6291685414435;7423.665935032828;7334;7505.924940750522;7530.134034586093;7566.735164269224;7601.581912994839;6045.21412216409;6102.7253773579405;6107.9083813741945;6112.908306375319;6119.44924956756;5621.213030175861;5711.457411545896;5968.671723055274;6354.904676429765;6611.867762644816;6181.752729890754;6220.284667263322;6274.874502510015;6341.112244285711;6341.8097457076365;5949.286085669747;6008;6011.7595296187665;6132.386761323832;6151.077338399097;6205.5345849062405;6215.347388524321;6270.7805226816845;6336.9049464259;6353.523485738496;5737.426257374229;5761.596688231783;5764.481196692318;5771.7402716877;5780.248567686174;5848.766049358148;5864.06175011996;5884.411558844081;5892.469677729025;5893.44012318829 12:08:44 INFO - 2015-11-23 12:08:44,978 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.8701588840631;318.8351096057768;319.0969556156077;322.1511317677918;323.3290921338223;5259.211118332252;5278.5513231375335;5383.730813459326;5393.4336894626085;5419.26839876617;5185.766640501177;5312.548433383167;5332.760025798839;5334.359876814778;5335.466453354663;3948.7433316834313;4078.5105787305565;4216.367544868263;4223.049813791895;4225.978870105645;4087.1621317629965;4161.3549899765585;4162.583741625844;4163.729357591762;4174.91650166998;4187.937180942288;4188.916221675565;4190.161967606476;4192.601702838226;4194.517630472505;4181.038361176931;4191.161767646483;4198.118395137025;4200.558941311179;4205.474315710536;3711.795851228181;3712.257548490286;3712.480252764615;3713.721470889694;3724.0503671563847;5013.598912087061;5167.819126330598;5196.402413722432;5207.765650545697;5217.47825217479;4768;4772;4772.880677983044;4774.570288674036;4775.307580400857;5346.679199248058;5465.699386533779;5680.460356266148;5691.430856914317;5692.6299790513895;3837.2325534893134;3924.6075392460525;3930.6462418382484;3949.782761948092;3955.307821131319;5849.502792262663;5929.762809487615;5929.792457263975;5935.465808077293;5938.970305148447;4055.8174882130374;4057.3711074783455;4057.756534607933;4060.5127384713433;4069.593040695966;4035.7376770509823;4123.4021066945725;4126.8761937141935;4127.504699436087;4135.545090040093;4705.670603057753;4713.410823647044;4722.362481065013;4726.976365118152;4730.432348118248;5624.156376543469;5629.240052592848;5634.690092044977;5637.295338082739;5642.351129620064;1438.1946110178333;1444.7471692453778;1454.461849115834;1454.70178613384;1456.6576854439197;980.7057882635181;982.7788747531891;983.9458878811758;997.6059456514636;1006.864073350103;4951.7276549789385;4957.281194226817;4958.033183529177;4968.627352948543;4971.279164521125;5849.853753656107;5853.1220316952795;5863.29640443141;5864.266966629171;5866.472017518358;4962.652614316963;4966.925496117561;4970.428400733962;4971.254311853251;4973.403191617029;3082.969170308313;3142.5443310719816;3164.6677098904743;3164.8892288769784;3166.509191075387;5525.557955363562;5539.390667026624;5548.250986116904;5550.333959924835;5556.083246264402;6012.7895523657335;6016.819495415145;6022.5784195105925;6023.216981792339;6025.246844144394;5487.122060470386;5514.91727624078;5519.751611177587;5539.307586551681;5545.500904918576;5632.690202038763;5698.145278208136;5906.527477801851;5921;5924.259467566554;5562.388137304974;5666.716664166857;5759.193712880284;5761;5767.279090113736;5544;5546.334439867242;5555.138953462219;5560.138178582326;5572.387037425961;4042.6967977401223;4078.938815917823;4080.6735461162443;4081.3265811140827;4082.6121518455698;5717.714114294352;5869.383714710065;5869.442402971711;5899;5905.025670764276;5658.321001479849;5658.660480371191;5660.29246344207;5664.0371136906;5673.58160459885;5654.378018418053;5656.2929633795775;5665.291838520185;5668.631538949955;5672.716364181857;5412.296401467784;5538.446155384429;5548.667079975215;5555;5555.111182210827;5712.428757124254;5725.398833122462;5725.452173782627;5727.36998930109;5727.997600419993;5574.303212098488;5579.553635709052;5580.190872323409;5589.413111623221;5593.580481463825 12:08:44 INFO - 2015-11-23 12:08:44,980 DEBUG : BROWSER_OUTPUT: |5;yui.html;673.1484671890059;768.8347005393841;777.114089937471;777.9105402878671;804.9436539442238;10848.511816968236;11006.724831879206;11024.393658348788;11063;11086.944565277163;11529.077673786098;11701.414929253524;11877.821832672516;11934.104942129332;11953.163278570482;622.1476577089394;627.3820287017285;628.6353914729469;785.8310463250415;804.1476035402463;631.6399652198248;632.905064240363;638.3648269971385;779.5634444710952;802.3621221129187;837.7109897085496;838.1618381618382;840.2647683277132;844.9281811046069;845.2561745663838;645.7642960319449;840.7603832907622;842.5534466732641;843.6498852976039;844.252836239929;484.49370407923806;602.9698515074228;610.7495926670044;611.1443978430189;614.3764079459353;11080.722981925435;11089.33463992163;11096.778064438748;11151.219414640897;11154.888451115467;10867.728306792393;11528.365939873303;11659.417029148593;11836.46735896878;12004;9021;9096.63613455461;9209.079092090804;9303.58133883977;9322.533873306307;3211.4379983503027;3271.247613049012;3271.5910511186103;3274.263290759584;3279.8524066417067;38530.807345963374;38826;38870.22259554821;38911.805440972894;39005.60994390048;9087.273018158532;9381.249500039981;9563.378380405251;9659.32384733076;9659.420434773936;16280;16315.83684163167;16343.711880336525;16359.672806543802;16365.590860228589;5906.114082887515;6180.381961803873;6579.407853293226;6596.901046484307;6623.4701223901975;3728.2729867675544;3738.056210770384;3762.3415902217002;3767.547894252707;3782.6028267032116;2790.4279622677304;2826.745592896649;2829.5048366535775;2830.900918467844;2831.929201769972;494.65621393131426;503.6273157863228;505.23709199109607;512.0169274992024;516.612540594554;520.9583233341324;568.1364326224116;585.6076428792719;610.1732152932801;613.362103412455;7558;7640.197779233212;7740.535567865946;7915.841683166304;7955.24425179607;502.5125628140698;584.1763114009227;600.2616781358865;604.5224272824507;615.4768446820257;3633.800140992218;3825.4261860720558;3887.3002859485564;3911.5892831252877;4250.978745106255;49138;49191.754041229564;49199;49225.26162107571;52144;44400.3339949901;44558.77720611376;45375.54624453779;45402;48895;43854.561454385046;44026.33960490595;45658.54341456543;46307.53692463032;47001.29498057463;8221.17788221173;8252.327918563959;8495.447795893248;8525.74422767318;8710.782230444289;31717.682823172396;31960.200994975312;32164.678353217103;32198.83900580576;32913.34173316568;36958.8152059238;37855.35012549095;39870;40421.59578404296;40432;10608.522616482123;10644.89355106439;10678.252522323362;10732.624358147428;10833.241673083125;11327.830082548604;11467.942660286979;11547.480363383836;11991.100667450151;12392.217774857163;10434.530446129791;10661.253712240068;10692.518836652525;10850.891491084989;11076.944615276872;10711.89288107109;10858.34849909008;11153.163512736415;11535.480903359201;11604.593839215588;10516.842247366143;10903.383603830247;11014.118870490502;11185.888141118485;11283.153763467608;9281.953590232006;9365.29760267969;9475.575886293122;9582.137607615348;9847.950760246153;8817.647294108421;9156.496392698466;9306.813863722824;9365.391249568756;9455.101765332283 12:08:44 INFO - 2015-11-23 12:08:44,980 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:08:44 INFO - 2015-11-23 12:08:44,980 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:08:44 INFO - 2015-11-23 12:08:44,980 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 12:08:44 INFO - 2015-11-23 12:08:44,981 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:08:44 INFO - 2015-11-23 12:08:44,981 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309324968__endTimestamp 12:08:44 INFO - 2015-11-23 12:08:44,981 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,981 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:08:44 INFO - 2015-11-23 12:08:44,982 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:08:44 INFO - 2015-11-23 12:08:44,982 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,982 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4651.48 Median:4734.20 stddev:482.74 (10.2%) stddev-sans-first:457.40 12:08:44 INFO - 2015-11-23 12:08:44,982 DEBUG : BROWSER_OUTPUT: Values: 2628.7 2723.8 2731.5 2739.2 2751.8 4530.8 4663.2 4686.7 4710.4 4732.7 4562.8 4615.7 4673.6 4678.5 4681.3 4335.3 4366.7 4419.8 4477.0 4516.7 4175.3 4401.3 4440.6 4486.8 4521.1 4240.9 4281.6 4318.4 4326.5 4328.2 4339.1 4340.8 4354.9 4361.7 4395.1 4322.3 4332.8 4347.4 4364.7 4367.7 4470.2 4534.8 4588.0 4594.1 4679.2 5031.7 5032.8 5034.1 5037.3 5074.9 5052.2 5062.6 5063.7 5066.8 5121.1 4528.4 4622.2 4628.7 4632.1 4723.8 5210.9 5270.3 5270.6 5273.1 5326.9 5040.6 5041.7 5062.4 5069.0 5106.6 4835.6 4888.2 4955.6 4956.8 5004.1 5032.1 5047.9 5049.3 5050.1 5092.7 4996.1 4999.4 5000.4 5004.9 5010.6 4055.1 4121.5 4158.2 4216.5 4221.9 3680.1 3689.5 3698.4 3728.2 3729.0 4344.0 4344.9 4346.7 4354.0 4383.8 4846.2 4959.7 5026.0 5027.4 5084.6 4385.8 4401.4 4403.2 4404.1 4423.8 4530.3 4539.0 4539.5 4542.1 4577.7 4566.7 4685.4 4686.2 4686.4 4809.7 5063.5 5122.3 5122.6 5127.6 5170.0 4848.1 4856.7 4858.1 4861.3 4902.8 4762.5 4782.9 4899.3 4900.1 4931.3 5053.2 5084.6 5085.0 5096.6 5128.7 4903.7 4906.0 4909.4 4909.9 4960.2 4703.4 4825.2 4825.8 4880.4 4982.1 4793.8 4807.0 4809.1 4817.2 4846.1 4924.4 4924.7 4928.6 4930.4 4976.5 4609.1 4688.0 4734.2 4740.3 4855.7 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42982.07 Median:185082.33 stddev:71157.70 (38.4%) stddev-sans-first:71286.03 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: Values: 560.7 563.5 569.9 582.6 584.4 27197.2 27759.4 27775.6 36974.4 37885.8 41524.2 42021.6 42087.8 42092.4 42101.8 7789.5 7953.8 7954.8 7961.0 7964.0 7028.0 7186.7 9918.1 10165.6 10170.3 10058.8 10206.6 10207.1 10211.2 10240.1 7201.6 7394.0 9971.7 10026.7 10115.0 7099.7 7214.2 7217.2 10090.0 10363.5 37210.3 37634.4 37654.8 37693.0 37792.0 2772.0 2855.0 3246.9 3476.5 3519.9 27343.3 27555.2 27648.9 27728.0 28229.7 3434.2 3448.2 3463.0 3481.4 3599.8 229143.0 231390.0 231587.0 231986.0 231997.0 57010.0 57190.0 57190.0 57215.7 57282.7 55417.7 56408.7 58600.7 60537.0 62199.0 13719.1 13824.2 13914.9 13924.1 13928.8 10542.4 10616.5 10617.5 10623.1 10630.0 19244.7 19420.7 19461.6 19475.4 19491.8 7456.9 7821.6 7837.5 7849.7 7900.1 782.3 852.2 897.3 1018.9 1046.7 26589.3 26619.7 26649.7 26821.3 26850.5 970.4 983.3 1016.5 1018.6 1066.5 13758.8 14061.6 14062.9 14108.2 14160.9 276705.0 278804.0 280724.0 281385.0 282027.0 45536.0 46111.8 46148.3 46168.3 46199.5 1169.8 1197.0 1213.7 1217.5 1222.4 24489.4 25487.7 26229.6 26313.0 26329.5 39766.6 39939.0 40160.0 40181.8 40292.0 221351.0 226097.0 336526.0 344002.9 345770.0 29907.9 29928.0 29950.1 29979.7 30436.7 38704.2 39791.4 39852.8 40140.4 40278.2 33638.7 34067.3 34086.3 34395.3 34541.7 34007.8 34324.5 34402.7 34634.7 35362.6 33150.2 33676.2 33837.5 33853.7 34087.1 30652.4 31426.7 31669.0 31681.2 31811.2 23748.1 24018.9 24311.3 24508.6 24576.5 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26571.73 Median:20898.19 stddev:82663.38 (395.6%) stddev-sans-first:82871.80 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: Values: 335.9 339.7 339.8 340.3 345.0 11855.5 12177.0 15456.1 16029.7 16358.9 12527.4 12535.7 12694.4 14408.1 14937.8 4952.1 4956.6 5062.6 5107.2 5110.2 4992.4 4994.1 5034.5 5041.6 5043.7 4972.9 4978.6 4988.0 5001.5 5057.6 5065.6 5098.1 5104.5 5109.7 5112.1 4530.3 4533.4 4542.3 4544.0 4545.1 19699.9 19880.1 20080.4 20215.8 20371.0 1926.4 1945.9 1954.4 2005.6 2048.9 12679.2 12681.8 12751.1 12851.9 12996.5 1621.1 1657.1 1736.3 1769.4 1822.8 51887.7 54208.5 54277.0 55328.0 55548.4 9295.7 9472.1 9645.9 9676.0 9750.3 11123.6 11213.0 11580.7 12327.8 12365.6 6912.2 6951.1 7000.5 7021.5 7114.4 6823.3 6875.0 6876.4 6901.1 6929.1 5753.6 5771.4 5810.8 5812.0 5896.1 1665.5 1690.4 1693.9 1702.2 1712.6 407.8 828.2 840.6 868.3 884.6 9765.6 9838.8 9971.0 10045.6 10183.7 389.0 405.8 418.2 420.1 438.3 4939.3 5907.7 5972.4 9274.7 9581.5 497976.0 498978.0 502154.0 510970.0 523654.0 58992.4 62984.7 63257.0 70570.6 74567.6 1071.7 1074.6 1082.0 1082.7 1086.3 13847.7 13922.7 14352.7 14528.3 14618.7 29420.0 29459.0 31053.2 31776.0 34176.8 40706.0 41378.2 42320.6 43172.1 45777.5 8779.2 8965.7 9145.1 9181.5 9190.1 16710.0 16758.7 16946.2 17158.5 17214.0 13721.5 14128.2 14171.4 14220.0 14371.1 13618.9 13780.6 13870.6 14113.9 14249.6 13969.5 14296.6 14380.7 14745.6 14862.6 8799.3 8951.6 9033.2 9061.9 9066.7 9403.2 10335.4 14130.0 14345.0 14373.6 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,983 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4794.69 Median:5958.98 stddev:2408.74 (40.4%) stddev-sans-first:2400.41 12:08:44 INFO - 2015-11-23 12:08:44,984 DEBUG : BROWSER_OUTPUT: Values: 1209.1 1580.1 1599.2 1620.8 1629.1 5769.6 6489.4 6652.9 6660.7 6664.6 6641.3 6733.0 6755.2 6766.5 6774.7 1764.4 1800.4 2049.7 2059.4 2075.2 2082.5 2086.2 2087.6 2089.3 2089.4 2032.4 2041.2 2080.4 2080.5 2083.8 2040.8 2043.5 2070.2 2075.0 2083.6 2067.2 2079.2 2081.6 2084.3 2085.9 6780.9 6817.7 6819.2 6820.8 6834.4 4025.4 4135.4 4141.8 4145.7 4149.2 2351.2 2771.0 2908.4 2921.0 2939.5 803.9 838.8 897.4 931.1 942.8 8982.1 8985.1 8988.1 8989.1 8994.4 3942.7 3949.9 4014.8 4103.4 4131.3 7820.1 7855.2 7872.8 7882.3 7906.8 4176.1 4179.6 4191.4 4199.3 4201.0 3800.5 3816.5 3818.7 3826.1 3829.8 3016.2 3092.7 3244.7 3256.0 3426.8 1100.5 1126.5 1131.8 1135.8 1136.0 954.8 1043.9 1140.1 1172.3 1172.5 6409.0 6475.4 6481.8 6497.2 6507.7 979.6 995.2 1000.9 1009.8 1016.5 4961.5 5015.1 5053.8 5059.7 5064.5 8034.2 8275.5 8281.9 8290.7 8294.9 7854.5 8076.1 8083.1 8107.6 8110.8 6413.4 6471.5 6471.8 6500.4 6515.0 6111.8 6198.1 6209.8 6222.3 6234.7 7284.8 7397.4 7404.5 7416.6 7423.7 7334.0 7505.9 7530.1 7566.7 7601.6 6045.2 6102.7 6107.9 6112.9 6119.4 5621.2 5711.5 5968.7 6354.9 6611.9 6181.8 6220.3 6274.9 6341.1 6341.8 5949.3 6008.0 6011.8 6132.4 6151.1 6205.5 6215.3 6270.8 6336.9 6353.5 5737.4 5761.6 5764.5 5771.7 5780.2 5848.8 5864.1 5884.4 5892.5 5893.4 12:08:44 INFO - 2015-11-23 12:08:44,984 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,985 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4689.99 Median:5333.56 stddev:1370.88 (25.7%) stddev-sans-first:1334.78 12:08:44 INFO - 2015-11-23 12:08:44,986 DEBUG : BROWSER_OUTPUT: Values: 312.9 318.8 319.1 322.2 323.3 5259.2 5278.6 5383.7 5393.4 5419.3 5185.8 5312.5 5332.8 5334.4 5335.5 3948.7 4078.5 4216.4 4223.0 4226.0 4087.2 4161.4 4162.6 4163.7 4174.9 4187.9 4188.9 4190.2 4192.6 4194.5 4181.0 4191.2 4198.1 4200.6 4205.5 3711.8 3712.3 3712.5 3713.7 3724.1 5013.6 5167.8 5196.4 5207.8 5217.5 4768.0 4772.0 4772.9 4774.6 4775.3 5346.7 5465.7 5680.5 5691.4 5692.6 3837.2 3924.6 3930.6 3949.8 3955.3 5849.5 5929.8 5929.8 5935.5 5939.0 4055.8 4057.4 4057.8 4060.5 4069.6 4035.7 4123.4 4126.9 4127.5 4135.5 4705.7 4713.4 4722.4 4727.0 4730.4 5624.2 5629.2 5634.7 5637.3 5642.4 1438.2 1444.7 1454.5 1454.7 1456.7 980.7 982.8 983.9 997.6 1006.9 4951.7 4957.3 4958.0 4968.6 4971.3 5849.9 5853.1 5863.3 5864.3 5866.5 4962.7 4966.9 4970.4 4971.3 4973.4 3083.0 3142.5 3164.7 3164.9 3166.5 5525.6 5539.4 5548.3 5550.3 5556.1 6012.8 6016.8 6022.6 6023.2 6025.2 5487.1 5514.9 5519.8 5539.3 5545.5 5632.7 5698.1 5906.5 5921.0 5924.3 5562.4 5666.7 5759.2 5761.0 5767.3 5544.0 5546.3 5555.1 5560.1 5572.4 4042.7 4078.9 4080.7 4081.3 4082.6 5717.7 5869.4 5869.4 5899.0 5905.0 5658.3 5658.7 5660.3 5664.0 5673.6 5654.4 5656.3 5665.3 5668.6 5672.7 5412.3 5538.4 5548.7 5555.0 5555.1 5712.4 5725.4 5725.5 5727.4 5728.0 5574.3 5579.6 5580.2 5589.4 5593.6 12:08:44 INFO - 2015-11-23 12:08:44,986 DEBUG : BROWSER_OUTPUT: 12:08:44 INFO - 2015-11-23 12:08:44,986 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12442.70 Median:45530.27 stddev:14090.47 (30.9%) stddev-sans-first:14102.27 12:08:44 INFO - 2015-11-23 12:08:44,987 DEBUG : BROWSER_OUTPUT: Values: 673.1 768.8 777.1 777.9 804.9 10848.5 11006.7 11024.4 11063.0 11086.9 11529.1 11701.4 11877.8 11934.1 11953.2 622.1 627.4 628.6 785.8 804.1 631.6 632.9 638.4 779.6 802.4 837.7 838.2 840.3 844.9 845.3 645.8 840.8 842.6 843.6 844.3 484.5 603.0 610.7 611.1 614.4 11080.7 11089.3 11096.8 11151.2 11154.9 10867.7 11528.4 11659.4 11836.5 12004.0 9021.0 9096.6 9209.1 9303.6 9322.5 3211.4 3271.2 3271.6 3274.3 3279.9 38530.8 38826.0 38870.2 38911.8 39005.6 9087.3 9381.2 9563.4 9659.3 9659.4 16280.0 16315.8 16343.7 16359.7 16365.6 5906.1 6180.4 6579.4 6596.9 6623.5 3728.3 3738.1 3762.3 3767.5 3782.6 2790.4 2826.7 2829.5 2830.9 2831.9 494.7 503.6 505.2 512.0 516.6 521.0 568.1 585.6 610.2 613.4 7558.0 7640.2 7740.5 7915.8 7955.2 502.5 584.2 600.3 604.5 615.5 3633.8 3825.4 3887.3 3911.6 4251.0 49138.0 49191.8 49199.0 49225.3 52144.0 44400.3 44558.8 45375.5 45402.0 48895.0 43854.6 44026.3 45658.5 46307.5 47001.3 8221.2 8252.3 8495.4 8525.7 8710.8 31717.7 31960.2 32164.7 32198.8 32913.3 36958.8 37855.4 39870.0 40421.6 40432.0 10608.5 10644.9 10678.3 10732.6 10833.2 11327.8 11467.9 11547.5 11991.1 12392.2 10434.5 10661.3 10692.5 10850.9 11076.9 10711.9 10858.3 11153.2 11535.5 11604.6 10516.8 10903.4 11014.1 11185.9 11283.2 9282.0 9365.3 9475.6 9582.1 9848.0 8817.6 9156.5 9306.8 9365.4 9455.1 12:08:44 INFO - 2015-11-23 12:08:44,987 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:08:44 INFO - 2015-11-23 12:08:44,987 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,690 INFO : Browser exited with error code: 0 12:08:45 INFO - 2015-11-23 12:08:45,708 INFO : Completed test dromaeo_css (00:18:38) 12:08:45 INFO - 2015-11-23 12:08:45,708 INFO : Starting test kraken 12:08:45 INFO - 2015-11-23 12:08:45,708 DEBUG : operating with platform_type : linux_ 12:08:45 INFO - 2015-11-23 12:08:45,708 INFO : Initialising browser for kraken test... 12:08:45 INFO - 2015-11-23 12:08:45,714 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAQx8O/profile http://localhost:49980/getInfo.html 12:08:49 INFO - 2015-11-23 12:08:49,993 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:08:49 INFO - 2015-11-23 12:08:49,993 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:08:49 INFO - 2015-11-23 12:08:49,993 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:08:49 INFO - 2015-11-23 12:08:49,993 DEBUG : BROWSER_OUTPUT: __metrics 12:08:50 INFO - 2015-11-23 12:08:50,049 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:08:51 INFO - 2015-11-23 12:08:51,485 INFO : Browser initialized. 12:08:51 INFO - 2015-11-23 12:08:51,485 INFO : Running cycle 1/1 for kraken test... 12:08:51 INFO - 2015-11-23 12:08:51,485 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAQx8O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:03 INFO - 2015-11-23 12:09:03,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 12:09:03 INFO - 2015-11-23 12:09:03,458 DEBUG : BROWSER_OUTPUT: 12:09:06 INFO - 2015-11-23 12:09:06,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49980/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:06 INFO - 2015-11-23 12:09:06,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 174362624 12:09:06 INFO - 2015-11-23 12:09:06,666 DEBUG : BROWSER_OUTPUT: 12:09:09 INFO - 2015-11-23 12:09:09,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49980/tests/kraken/driver.html?testName=audio-dft) 12:09:09 INFO - 2015-11-23 12:09:09,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 166825984 12:09:09 INFO - 2015-11-23 12:09:09,970 DEBUG : BROWSER_OUTPUT: 12:09:12 INFO - 2015-11-23 12:09:12,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49980/tests/kraken/driver.html?testName=audio-fft) 12:09:13 INFO - 2015-11-23 12:09:13,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 150880256 12:09:13 INFO - 2015-11-23 12:09:13,538 DEBUG : BROWSER_OUTPUT: 12:09:15 INFO - 2015-11-23 12:09:15,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49980/tests/kraken/driver.html?testName=audio-oscillator) 12:09:16 INFO - 2015-11-23 12:09:16,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 155373568 12:09:16 INFO - 2015-11-23 12:09:16,130 DEBUG : BROWSER_OUTPUT: 12:09:18 INFO - 2015-11-23 12:09:18,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:18 INFO - 2015-11-23 12:09:18,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 155029504 12:09:18 INFO - 2015-11-23 12:09:18,905 DEBUG : BROWSER_OUTPUT: 12:09:21 INFO - 2015-11-23 12:09:21,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49980/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:22 INFO - 2015-11-23 12:09:22,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 154664960 12:09:22 INFO - 2015-11-23 12:09:22,472 DEBUG : BROWSER_OUTPUT: 12:09:25 INFO - 2015-11-23 12:09:25,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49980/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:26 INFO - 2015-11-23 12:09:26,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 157106176 12:09:26 INFO - 2015-11-23 12:09:26,468 DEBUG : BROWSER_OUTPUT: 12:09:29 INFO - 2015-11-23 12:09:29,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49980/tests/kraken/driver.html?testName=json-parse-financial) 12:09:29 INFO - 2015-11-23 12:09:29,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 156823552 12:09:29 INFO - 2015-11-23 12:09:29,912 DEBUG : BROWSER_OUTPUT: 12:09:31 INFO - 2015-11-23 12:09:31,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:32 INFO - 2015-11-23 12:09:32,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 162844672 12:09:32 INFO - 2015-11-23 12:09:32,222 DEBUG : BROWSER_OUTPUT: 12:09:34 INFO - 2015-11-23 12:09:34,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:34 INFO - 2015-11-23 12:09:34,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 162365440 12:09:34 INFO - 2015-11-23 12:09:34,716 DEBUG : BROWSER_OUTPUT: 12:09:36 INFO - 2015-11-23 12:09:36,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:37 INFO - 2015-11-23 12:09:37,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 167161856 12:09:37 INFO - 2015-11-23 12:09:37,460 DEBUG : BROWSER_OUTPUT: 12:09:40 INFO - 2015-11-23 12:09:40,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:40 INFO - 2015-11-23 12:09:40,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 179806208 12:09:40 INFO - 2015-11-23 12:09:40,597 DEBUG : BROWSER_OUTPUT: 12:09:43 INFO - 2015-11-23 12:09:43,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:43 INFO - 2015-11-23 12:09:43,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 176377856 12:09:43 INFO - 2015-11-23 12:09:43,740 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49980/tests/kraken/driver.html?testName=ai-astar) 12:09:45 INFO - 2015-11-23 12:09:45,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 235835392 12:09:45 INFO - 2015-11-23 12:09:45,759 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;105;112;112;112;101;113;104;113 12:09:45 INFO - 2015-11-23 12:09:45,763 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;131;151;166;131;167;152;131;177;131 12:09:45 INFO - 2015-11-23 12:09:45,764 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;160;161;161;161;161;163;163;163;162 12:09:45 INFO - 2015-11-23 12:09:45,764 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;79;90;71;72;72;104;87;73 12:09:45 INFO - 2015-11-23 12:09:45,764 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;125;90;91;93;139;92;92;128 12:09:45 INFO - 2015-11-23 12:09:45,764 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;109;110;110;109;109 12:09:45 INFO - 2015-11-23 12:09:45,764 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;148;146;148;146;148;146;147;146 12:09:45 INFO - 2015-11-23 12:09:45,765 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 12:09:45 INFO - 2015-11-23 12:09:45,765 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;72;70;70;69;70;77;67;68 12:09:45 INFO - 2015-11-23 12:09:45,765 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;69;69;69;70;69;69;69 12:09:45 INFO - 2015-11-23 12:09:45,765 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;91;84;83;90;88;81;83;85;82 12:09:45 INFO - 2015-11-23 12:09:45,765 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;122;132;127;119;117;124;120;121;121 12:09:45 INFO - 2015-11-23 12:09:45,766 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;138;137;147;155;138;147;145;145;142 12:09:45 INFO - 2015-11-23 12:09:45,766 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;70;70;68;69;71;70;69;68 12:09:45 INFO - 2015-11-23 12:09:45,766 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:45 INFO - 2015-11-23 12:09:45,766 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:09:45 INFO - 2015-11-23 12:09:45,766 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,969 12:09:45 INFO - 2015-11-23 12:09:45,767 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:09:45 INFO - 2015-11-23 12:09:45,767 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309385761__endTimestamp 12:09:45 INFO - 2015-11-23 12:09:45,767 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,770 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:45 INFO - 2015-11-23 12:09:45,771 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:09:45 INFO - 2015-11-23 12:09:45,771 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,771 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:112.00 stddev:4.45 (4.0%) stddev-sans-first:4.72 12:09:45 INFO - 2015-11-23 12:09:45,771 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 105.0 112.0 112.0 112.0 101.0 113.0 104.0 113.0 12:09:45 INFO - 2015-11-23 12:09:45,771 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:158.00 stddev:18.01 (11.4%) stddev-sans-first:18.39 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: Values: 164.0 131.0 151.0 166.0 131.0 167.0 152.0 131.0 177.0 131.0 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: Values: 163.0 160.0 161.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,772 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:73.00 stddev:11.02 (15.1%) stddev-sans-first:11.45 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 79.0 90.0 71.0 72.0 72.0 104.0 87.0 73.0 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:91.00 stddev:19.29 (21.2%) stddev-sans-first:19.94 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 125.0 90.0 91.0 93.0 139.0 92.0 92.0 128.0 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,773 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 146.0 148.0 146.0 148.0 146.0 147.0 146.0 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:2.74 (3.9%) stddev-sans-first:2.87 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 72.0 70.0 70.0 69.0 70.0 77.0 67.0 68.0 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 12:09:45 INFO - 2015-11-23 12:09:45,774 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.50 stddev:3.77 (4.5%) stddev-sans-first:3.60 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: Values: 80.0 91.0 84.0 83.0 90.0 88.0 81.0 83.0 85.0 82.0 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:121.50 stddev:4.44 (3.7%) stddev-sans-first:4.56 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: Values: 119.0 122.0 132.0 127.0 119.0 117.0 124.0 120.0 121.0 121.0 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:146.00 stddev:5.89 (4.0%) stddev-sans-first:5.76 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: Values: 151.0 138.0 137.0 147.0 155.0 138.0 147.0 145.0 145.0 142.0 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 70.0 68.0 69.0 71.0 70.0 69.0 68.0 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:45 INFO - 2015-11-23 12:09:45,775 DEBUG : BROWSER_OUTPUT: 12:09:46 INFO - 2015-11-23 12:09:46,713 INFO : Browser exited with error code: 0 12:09:46 INFO - 2015-11-23 12:09:46,769 INFO : Completed test kraken (00:01:01) 12:09:46 INFO - 2015-11-23 12:09:46,769 INFO : Starting test v8_7 12:09:46 INFO - 2015-11-23 12:09:46,769 DEBUG : operating with platform_type : linux_ 12:09:46 INFO - 2015-11-23 12:09:46,770 INFO : Initialising browser for v8_7 test... 12:09:46 INFO - 2015-11-23 12:09:46,776 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX84oDE/profile http://localhost:49980/getInfo.html 12:09:51 INFO - 2015-11-23 12:09:51,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:51 INFO - 2015-11-23 12:09:51,079 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:51 INFO - 2015-11-23 12:09:51,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:09:51 INFO - 2015-11-23 12:09:51,079 DEBUG : BROWSER_OUTPUT: __metrics 12:09:51 INFO - 2015-11-23 12:09:51,261 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:52 INFO - 2015-11-23 12:09:52,596 INFO : Browser initialized. 12:09:52 INFO - 2015-11-23 12:09:52,597 INFO : Running cycle 1/1 for v8_7 test... 12:09:52 INFO - 2015-11-23 12:09:52,597 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX84oDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:04 INFO - 2015-11-23 12:10:04,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 139968512 12:10:04 INFO - 2015-11-23 12:10:04,534 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49980/tests/v8_7/run.html (next: http://localhost:49980/tests/v8_7/run.html) 12:10:26 INFO - 2015-11-23 12:10:26,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 444727296 12:10:26 INFO - 2015-11-23 12:10:26,202 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,202 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:26 INFO - 2015-11-23 12:10:26,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:26 INFO - 2015-11-23 12:10:26,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:26 INFO - 2015-11-23 12:10:26,203 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |0;Richards;164.20361247947454 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.42555164101614 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |5;Earley;780.0312012480499 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |7;RegExp;28885.714285714286 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |8;Splay;605.3268765133172 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309426202__endTimestamp 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,204 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.20 Median:164.20 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: Values: 164.2 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.43 Median:185.43 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,205 DEBUG : BROWSER_OUTPUT: Values: 185.4 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: Values: 281.4 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,206 DEBUG : BROWSER_OUTPUT: Values: 5040.2 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: Values: 1986.1 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,207 DEBUG : BROWSER_OUTPUT: Values: 780.0 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: Values: 12011.9 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28885.71 Median:28885.71 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: Values: 28885.7 12:10:26 INFO - 2015-11-23 12:10:26,208 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.33 Median:605.33 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: Values: 605.3 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: Values: 4835.7 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:26 INFO - 2015-11-23 12:10:26,209 DEBUG : BROWSER_OUTPUT: 12:10:27 INFO - 2015-11-23 12:10:27,085 INFO : Browser exited with error code: 0 12:10:27 INFO - 2015-11-23 12:10:27,102 INFO : Completed test v8_7 (00:00:40) 12:10:27 INFO - 2015-11-23 12:10:27,220 INFO : Completed test suite (00:20:19) 12:10:27 INFO - 2015-11-23 12:10:27,220 DEBUG : Working with test: dromaeo_css 12:10:27 INFO - 2015-11-23 12:10:27,220 DEBUG : Generating results file: dromaeo_css 12:10:27 INFO - 2015-11-23 12:10:27,221 DEBUG : Working with test: kraken 12:10:27 INFO - 2015-11-23 12:10:27,221 DEBUG : Generating results file: kraken 12:10:27 INFO - 2015-11-23 12:10:27,221 INFO : javascript benchmark 12:10:27 INFO - 2015-11-23 12:10:27,222 DEBUG : Working with test: v8_7 12:10:27 INFO - 2015-11-23 12:10:27,222 DEBUG : Generating results file: v8_7 12:10:27 INFO - 2015-11-23 12:10:27,222 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:27 INFO - 2015-11-23 12:10:27,362 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:10:27 INFO - 2015-11-23 12:10:27,362 DEBUG : process_Request line: dromaeo_css 6312.23 graph.html#tests=[[72,132,35]] 12:10:27 INFO - 2015-11-23 12:10:27,362 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:27 INFO - 2015-11-23 12:10:27,474 DEBUG : process_Request line: kraken 1515.20 graph.html#tests=[[232,132,35]] 12:10:27 INFO - 2015-11-23 12:10:27,474 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:27 INFO - 2015-11-23 12:10:27,508 DEBUG : process_Request line: v8_7 19782.04 graph.html#tests=[[230,132,35]] 12:10:27 INFO - 2015-11-23 12:10:27,510 INFO : javascript benchmark 12:10:27 INFO - 2015-11-23 12:10:27,513 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.697699764527, 2723.8093333466663, 2731.4946734854043, 2739.150863232398, 2751.8211316264446, 4530.773461326937, 4663.2305669564485, 4686.742229177394, 4710.434747830257, 4732.668713190078, 4562.7718614069245, 4615.723056616605, 4673.626109911207, 4678.53214678532, 4681.344611754357, 4335.284678028122, 4366.6506679465565, 4419.779011049451, 4476.9776151119195, 4516.728996260234, 4175.331946888498, 4401.295792673157, 4440.622547083502, 4486.842960496383, 4521.073179998109, 4240.851570195028, 4281.614654681078, 4318.395424640553, 4326.502452217972, 4328.199283132599, 4339.06710057336, 4340.8480703175555, 4354.912901741979, 4361.672874534423, 4395.120975804852, 4322.308430651081, 4332.848350307724, 4347.413099231595, 4364.716293440948, 4367.650587952956, 4470.195364834329, 4534.773261336953, 4588.0, 4594.1271158479785, 4679.15775160471, 5031.748412579356, 5032.798688052473, 5034.144195486776, 5037.345145131109, 5074.923876141861, 5052.242163675442, 5062.645614806965, 5063.696178229281, 5066.822661206877, 5121.103806833789, 4528.411306530163, 4622.237330840441, 4628.722276663344, 4632.119897219518, 4723.7638118093955, 5210.869728256824, 5270.262163297065, 5270.552003079704, 5273.050850846885, 5326.866828329323, 5040.647154699209, 5041.697498150123, 5062.417821950449, 5069.036882992294, 5106.565941894981, 4835.6131509479865, 4888.2178851384315, 4955.578775804097, 4956.776945037482, 5004.124278251365, 5032.144535428986, 5047.9495205048215, 5049.26785616091, 5050.141475949097, 5092.745362731923, 4996.050750357421, 4999.42506611737, 5000.374953130859, 5004.949950500449, 5010.649254552146, 4055.0673345130785, 4121.4848143982, 4158.189153115113, 4216.451861258017, 4221.915561688749, 3680.1167719747605, 3689.538807649044, 3698.3712768829364, 3728.198437335986, 3728.9813550932613, 4344.044310251739, 4344.869653910388, 4346.717463364871, 4354.042110735696, 4383.7588932609015, 4846.248831431134, 4959.727215003138, 5025.974870125626, 5027.396712394536, 5084.6440749147205, 4385.758783266887, 4401.383806267125, 4403.207422663887, 4404.1411924674385, 4423.845165419195, 4530.29780384041, 4538.954610453853, 4539.500654927955, 4542.068875880436, 4577.679562430598, 4566.748828814513, 4685.367475390915, 4686.203345431217, 4686.390769199982, 4809.687370320918, 5063.468335824686, 5122.334096567422, 5122.590192784643, 5127.6410651254055, 5170.043541944752, 4848.12733707936, 4856.68431551948, 4858.125537403302, 4861.295112208781, 4902.828401005948, 4762.476127626028, 4782.856514304576, 4899.265110233494, 4900.14247506692, 4931.2849636803185, 5053.216751403538, 5084.5932325414615, 5085.0, 5096.592272618108, 5128.692278463304, 4903.730294833818, 4906.0433215522635, 4909.4354149273295, 4909.877253068702, 4960.156773348467, 4703.388559487382, 4825.179719447772, 4825.831095911767, 4880.389951256093, 4982.10322142018, 4793.760311984456, 4807.0, 4809.062232864558, 4817.205161148371, 4846.079244943449, 4924.433690125538, 4924.679895806761, 4928.630352723489, 4930.383702037246, 4976.5023497649945, 4609.124266389375, 4687.953120468752, 4734.195186818318, 4740.265258884879, 4855.684380515255], "unit": "ms", "name": "dojo.html", "value": 4621.736196710215}, {"lowerIsBetter": false, "replicates": [560.6804121650661, 563.4787821265331, 569.8888716700243, 582.592185470171, 584.3630442817329, 27197.184084477474, 27759.444811103793, 27775.5833662495, 36974.445383319275, 37885.81057094718, 41524.16951660965, 42021.57978420215, 42087.78956105215, 42092.368614470804, 42101.7894910525, 7789.532628042307, 7953.801154971115, 7954.761357159266, 7961.044674639023, 7963.960180199091, 7028.0, 7186.748463803768, 9918.05778451046, 10165.644202452915, 10170.288079834414, 10058.849117263248, 10206.64276750314, 10207.081362677358, 10211.183105351554, 10240.129588984944, 7201.6039117848495, 7394.0, 9971.650992215275, 10026.69919902404, 10115.039071288216, 7099.716011359539, 7214.170370407418, 7217.206107328189, 10090.0, 10363.533640986174, 37210.25579488422, 37634.43548346777, 37654.81172594147, 37693.0, 37792.0, 2771.9722802771917, 2854.9714502854913, 3246.902592922216, 3476.4959080933377, 3519.914259771063, 27343.316417089733, 27555.17334479969, 27648.861755691294, 27728.0, 28229.717702822913, 3434.227298857762, 3448.1552019755068, 3463.0, 3481.390756617607, 3599.838007289652, 229143.0, 231390.0, 231587.0, 231986.0, 231997.0, 57010.0, 57190.0, 57190.0, 57215.71392143096, 57282.713586432634, 55417.722911385186, 56408.71795641078, 58600.706996464745, 60537.0, 62199.0, 13719.1082579632, 13824.170549767046, 13914.860851391559, 13924.094933829268, 13928.791068133985, 10542.42016689074, 10616.469176541143, 10617.469126543641, 10623.097036751962, 10630.0, 19244.71132933007, 19420.708689369672, 19461.610767784565, 19475.415737527896, 19491.805081949282, 7456.925430745623, 7821.6089195541135, 7837.529748215012, 7849.725259615886, 7900.091489478668, 782.3037496628006, 852.1648784191403, 897.3045889435609, 1018.8930162332997, 1046.6755305855208, 26589.3352666181, 26619.733802662115, 26649.733502664723, 26821.329466763098, 26850.462990740074, 970.3644113105927, 983.3460748602242, 1016.537475448669, 1018.5671089786811, 1066.4880857188439, 13758.793618095737, 14061.648458788612, 14062.929685351508, 14108.224047677477, 14160.929195353958, 276705.0, 278804.0, 280724.0, 281385.0, 282027.0, 45536.0, 46111.76944115258, 46148.30777538339, 46168.3074753879, 46199.5380046202, 1169.8069818480026, 1197.0483465644834, 1213.7269114449177, 1217.4825699077855, 1222.4498975461079, 24489.38776530601, 25487.74512254928, 26229.606555902057, 26313.0, 26329.473410532064, 39766.60233397745, 39939.0, 40160.0, 40181.79909100436, 40292.0, 221351.0, 226097.0, 336526.0, 344002.87969763816, 345770.0, 29907.85046074843, 29928.0, 29950.10648615666, 29979.70020299769, 30436.695633044274, 38704.22591548097, 39791.40312895251, 39852.800735996134, 40140.38385585578, 40278.19443611053, 33638.66361336453, 34067.318653627284, 34086.31827363488, 34395.31209375848, 34541.65458345485, 34007.82996085004, 34324.48513272353, 34402.65597343994, 34634.65365346415, 35362.646373535936, 33150.171245718084, 33676.158096047795, 33837.492437613946, 33853.66146338505, 34087.147821304665, 30652.386952261277, 31426.68573314329, 31669.0, 31681.20796980094, 31811.20471988219, 23748.050077996686, 24018.879905601058, 24311.27066188017, 24508.632370514813, 24576.50846983086], "unit": "ms", "name": "ext.html", "value": 17427.600084736925}, {"lowerIsBetter": false, "replicates": [335.85054650680456, 339.6823969588434, 339.81649909049116, 340.3057762165182, 344.9793012419253, 11855.46650400732, 12177.0, 15456.149911754863, 16029.679406411864, 16358.91820540897, 12527.37363131842, 12535.686607834808, 12694.3652817359, 14408.063475874087, 14937.775933361008, 4952.108620448336, 4956.62825288104, 5062.569681577071, 5107.208382700669, 5110.207917772733, 4992.350994370745, 4994.1260279451135, 5034.546890779848, 5041.596672266228, 5043.722595257259, 4972.8508144755715, 4978.55193032627, 4987.950120498803, 5001.524855138756, 5057.5701065409485, 5065.620078494109, 5098.082345177866, 5104.4640312767, 5109.744512774365, 5112.054269960069, 4530.252508336121, 4533.410656614652, 4542.341360502709, 4544.045750392422, 4545.11370282795, 19699.901500492404, 19880.105395257247, 20080.39758807238, 20215.797842021686, 20370.96290370966, 1926.422073377981, 1945.9416217513497, 1954.4039068084228, 2005.568802707425, 2048.8668236564577, 12679.239245645198, 12681.809772853323, 12751.10742248043, 12851.935740321333, 12996.480140794356, 1621.0840874905641, 1657.0968821992044, 1736.3401907275281, 1769.3807167491404, 1822.7539282197, 51887.74056129733, 54208.45791542113, 54277.0, 55328.0, 55548.44451555514, 9295.67465138717, 9472.147506724428, 9645.855312170183, 9675.951620241995, 9750.26872984529, 11123.55505779776, 11213.0, 11580.6525804226, 12327.753444931051, 12365.567205147776, 6912.205096413876, 6951.131108611424, 7000.544964577286, 7021.508494405342, 7114.39527640146, 6823.317668233236, 6875.0, 6876.381125698711, 6901.102856628707, 6929.133858267716, 5753.626014309057, 5771.365149833515, 5810.7966221182905, 5811.970940145272, 5896.056630939115, 1665.5170000699661, 1690.3576640876388, 1693.9497511542677, 1702.1999660159704, 1712.6489069740674, 407.81852075826566, 828.2380210206625, 840.6133178737849, 868.2793281576277, 884.5975081337975, 9765.609375624896, 9838.754031149136, 9970.950145249373, 10045.598176073021, 10183.694489165337, 388.99027524311555, 405.7829061452109, 418.2033226703135, 420.12613763372724, 438.3402978517311, 4939.3084968104495, 5907.7046147692445, 5972.432618901197, 9274.721758347261, 9581.473018984023, 497976.0, 498978.0, 502154.0, 510970.0, 523654.0, 58992.41007589869, 62984.68507657432, 63257.0, 70570.64714676393, 74567.62716186384, 1071.7213524483534, 1074.5862842805577, 1081.983770243447, 1082.6860210538855, 1086.266769930294, 13847.653808654864, 13922.651933701738, 14352.712945740817, 14528.346224419714, 14618.707625847212, 29420.0, 29459.0, 31053.223669408446, 31776.0, 34176.82911585426, 40706.0, 41378.1724365505, 42320.5767942329, 43172.13655726931, 45777.54222457733, 8779.209871111376, 8965.731028069169, 9145.085491450802, 9181.49501777382, 9190.126937940884, 16710.0, 16758.748618770485, 16946.237419315912, 17158.48524544266, 17213.967161970322, 13721.519746808814, 14128.152310861382, 14171.433142674177, 14220.004599677923, 14371.065880718139, 13618.931905340807, 13780.586582402544, 13870.583882483541, 14113.858861411665, 14249.572512824632, 13969.511067112602, 14296.57110286693, 14380.712385752016, 14745.557633271019, 14862.554123376316, 8799.34004949644, 8951.641934322553, 9033.187013168847, 9061.864072039056, 9066.682666106655, 9403.247740180906, 10335.449682547678, 14130.0, 14345.0, 14373.64065898361], "unit": "ms", "name": "jquery.html", "value": 8028.569992478991}, {"lowerIsBetter": false, "replicates": [1209.1294268126946, 1580.1072394097334, 1599.1604407685963, 1620.7892973913392, 1629.0551480141519, 5769.567282453817, 6489.415952564268, 6652.86694266115, 6660.700268487917, 6664.600123992564, 6641.269460359356, 6733.02371156182, 6755.155605549294, 6766.4925130615275, 6774.661266936658, 1764.444200076978, 1800.3878681248373, 2049.661805802041, 2059.4233614587865, 2075.1595603780493, 2082.5106100066473, 2086.1968142265187, 2087.5929193807215, 2089.3418573149484, 2089.414963810128, 2032.3699653107583, 2041.214132558968, 2080.43828166395, 2080.4798800299927, 2083.8437117216195, 2040.7959204079548, 2043.4993426610426, 2070.1512379924234, 2074.968875466869, 2083.593699228651, 2067.24545540878, 2079.2099002379, 2081.552466219755, 2084.3121769816075, 2085.9269925552535, 6780.898286525706, 6817.69320380584, 6819.181698196198, 6820.829479263009, 6834.384905358492, 4025.4163146343617, 4135.421041054255, 4141.813618387149, 4145.709800313979, 4149.232392007489, 2351.165336305604, 2770.9584356234673, 2908.43285559316, 2920.985395073032, 2939.470895238856, 803.9035315762087, 838.8364268967554, 897.3942588752566, 931.1433481197247, 942.7595963029383, 8982.146696063863, 8985.101489851028, 8988.10118988096, 8989.146031127033, 8994.41536300145, 3942.664873485786, 3949.921001579952, 4014.7791871447353, 4103.425520427142, 4131.29767939451, 7820.061592608809, 7855.214478552099, 7872.803179920548, 7882.330001949784, 7906.841863162705, 4176.0603864130935, 4179.6029377209115, 4191.371294305817, 4199.265128602482, 4201.0, 3800.4869342638945, 3816.5229346331707, 3818.7326887117633, 3826.1391186982705, 3829.80850957451, 3016.2308611304416, 3092.6752690967573, 3244.6755324467836, 3255.9837200813845, 3426.777259478126, 1100.5212732461405, 1126.52122847791, 1131.7623299107279, 1135.795556799784, 1136.023020202625, 954.7994921066654, 1043.8695163104612, 1140.105017561227, 1172.3493461128985, 1172.472387425662, 6408.967955160194, 6475.352464753581, 6481.837954051092, 6497.18785151856, 6507.674616269168, 979.6228452045871, 995.2038369304528, 1000.9449480278508, 1009.7778488732467, 1016.5425558498705, 4961.454240033593, 5015.14742493777, 5053.797848086109, 5059.671121377099, 5064.4935506449065, 8034.196580341919, 8275.50346979183, 8281.875771863426, 8290.668373265002, 8294.917050829536, 7854.4894581851995, 8076.111627720946, 8083.070446898564, 8107.55408452529, 8110.797230069295, 6413.358664133642, 6471.514636402195, 6471.773487927994, 6500.447461965691, 6514.999999999905, 6111.816645500642, 6198.101275315144, 6209.813705588659, 6222.28443728977, 6234.719437625408, 7284.817879553054, 7397.445191610758, 7404.481686281909, 7416.6291685414435, 7423.665935032828, 7334.0, 7505.924940750522, 7530.134034586093, 7566.735164269224, 7601.581912994839, 6045.21412216409, 6102.7253773579405, 6107.9083813741945, 6112.908306375319, 6119.44924956756, 5621.213030175861, 5711.457411545896, 5968.671723055274, 6354.904676429765, 6611.867762644816, 6181.752729890754, 6220.284667263322, 6274.874502510015, 6341.112244285711, 6341.8097457076365, 5949.286085669747, 6008.0, 6011.7595296187665, 6132.386761323832, 6151.077338399097, 6205.5345849062405, 6215.347388524321, 6270.7805226816845, 6336.9049464259, 6353.523485738496, 5737.426257374229, 5761.596688231783, 5764.481196692318, 5771.7402716877, 5780.248567686174, 5848.766049358148, 5864.06175011996, 5884.411558844081, 5892.469677729025, 5893.44012318829], "unit": "ms", "name": "mootools.html", "value": 3988.4960323983696}, {"lowerIsBetter": false, "replicates": [312.8701588840631, 318.8351096057768, 319.0969556156077, 322.1511317677918, 323.3290921338223, 5259.211118332252, 5278.5513231375335, 5383.730813459326, 5393.4336894626085, 5419.26839876617, 5185.766640501177, 5312.548433383167, 5332.760025798839, 5334.359876814778, 5335.466453354663, 3948.7433316834313, 4078.5105787305565, 4216.367544868263, 4223.049813791895, 4225.978870105645, 4087.1621317629965, 4161.3549899765585, 4162.583741625844, 4163.729357591762, 4174.91650166998, 4187.937180942288, 4188.916221675565, 4190.161967606476, 4192.601702838226, 4194.517630472505, 4181.038361176931, 4191.161767646483, 4198.118395137025, 4200.558941311179, 4205.474315710536, 3711.795851228181, 3712.257548490286, 3712.480252764615, 3713.721470889694, 3724.0503671563847, 5013.598912087061, 5167.819126330598, 5196.402413722432, 5207.765650545697, 5217.47825217479, 4768.0, 4772.0, 4772.880677983044, 4774.570288674036, 4775.307580400857, 5346.679199248058, 5465.699386533779, 5680.460356266148, 5691.430856914317, 5692.6299790513895, 3837.2325534893134, 3924.6075392460525, 3930.6462418382484, 3949.782761948092, 3955.307821131319, 5849.502792262663, 5929.762809487615, 5929.792457263975, 5935.465808077293, 5938.970305148447, 4055.8174882130374, 4057.3711074783455, 4057.756534607933, 4060.5127384713433, 4069.593040695966, 4035.7376770509823, 4123.4021066945725, 4126.8761937141935, 4127.504699436087, 4135.545090040093, 4705.670603057753, 4713.410823647044, 4722.362481065013, 4726.976365118152, 4730.432348118248, 5624.156376543469, 5629.240052592848, 5634.690092044977, 5637.295338082739, 5642.351129620064, 1438.1946110178333, 1444.7471692453778, 1454.461849115834, 1454.70178613384, 1456.6576854439197, 980.7057882635181, 982.7788747531891, 983.9458878811758, 997.6059456514636, 1006.864073350103, 4951.7276549789385, 4957.281194226817, 4958.033183529177, 4968.627352948543, 4971.279164521125, 5849.853753656107, 5853.1220316952795, 5863.29640443141, 5864.266966629171, 5866.472017518358, 4962.652614316963, 4966.925496117561, 4970.428400733962, 4971.254311853251, 4973.403191617029, 3082.969170308313, 3142.5443310719816, 3164.6677098904743, 3164.8892288769784, 3166.509191075387, 5525.557955363562, 5539.390667026624, 5548.250986116904, 5550.333959924835, 5556.083246264402, 6012.7895523657335, 6016.819495415145, 6022.5784195105925, 6023.216981792339, 6025.246844144394, 5487.122060470386, 5514.91727624078, 5519.751611177587, 5539.307586551681, 5545.500904918576, 5632.690202038763, 5698.145278208136, 5906.527477801851, 5921.0, 5924.259467566554, 5562.388137304974, 5666.716664166857, 5759.193712880284, 5761.0, 5767.279090113736, 5544.0, 5546.334439867242, 5555.138953462219, 5560.138178582326, 5572.387037425961, 4042.6967977401223, 4078.938815917823, 4080.6735461162443, 4081.3265811140827, 4082.6121518455698, 5717.714114294352, 5869.383714710065, 5869.442402971711, 5899.0, 5905.025670764276, 5658.321001479849, 5658.660480371191, 5660.29246344207, 5664.0371136906, 5673.58160459885, 5654.378018418053, 5656.2929633795775, 5665.291838520185, 5668.631538949955, 5672.716364181857, 5412.296401467784, 5538.446155384429, 5548.667079975215, 5555.0, 5555.111182210827, 5712.428757124254, 5725.398833122462, 5725.452173782627, 5727.36998930109, 5727.997600419993, 5574.303212098488, 5579.553635709052, 5580.190872323409, 5589.413111623221, 5593.580481463825], "unit": "ms", "name": "prototype.html", "value": 4253.060332495004}, {"lowerIsBetter": false, "replicates": [673.1484671890059, 768.8347005393841, 777.114089937471, 777.9105402878671, 804.9436539442238, 10848.511816968236, 11006.724831879206, 11024.393658348788, 11063.0, 11086.944565277163, 11529.077673786098, 11701.414929253524, 11877.821832672516, 11934.104942129332, 11953.163278570482, 622.1476577089394, 627.3820287017285, 628.6353914729469, 785.8310463250415, 804.1476035402463, 631.6399652198248, 632.905064240363, 638.3648269971385, 779.5634444710952, 802.3621221129187, 837.7109897085496, 838.1618381618382, 840.2647683277132, 844.9281811046069, 845.2561745663838, 645.7642960319449, 840.7603832907622, 842.5534466732641, 843.6498852976039, 844.252836239929, 484.49370407923806, 602.9698515074228, 610.7495926670044, 611.1443978430189, 614.3764079459353, 11080.722981925435, 11089.33463992163, 11096.778064438748, 11151.219414640897, 11154.888451115467, 10867.728306792393, 11528.365939873303, 11659.417029148593, 11836.46735896878, 12004.0, 9021.0, 9096.63613455461, 9209.079092090804, 9303.58133883977, 9322.533873306307, 3211.4379983503027, 3271.247613049012, 3271.5910511186103, 3274.263290759584, 3279.8524066417067, 38530.807345963374, 38826.0, 38870.22259554821, 38911.805440972894, 39005.60994390048, 9087.273018158532, 9381.249500039981, 9563.378380405251, 9659.32384733076, 9659.420434773936, 16280.0, 16315.83684163167, 16343.711880336525, 16359.672806543802, 16365.590860228589, 5906.114082887515, 6180.381961803873, 6579.407853293226, 6596.901046484307, 6623.4701223901975, 3728.2729867675544, 3738.056210770384, 3762.3415902217002, 3767.547894252707, 3782.6028267032116, 2790.4279622677304, 2826.745592896649, 2829.5048366535775, 2830.900918467844, 2831.929201769972, 494.65621393131426, 503.6273157863228, 505.23709199109607, 512.0169274992024, 516.612540594554, 520.9583233341324, 568.1364326224116, 585.6076428792719, 610.1732152932801, 613.362103412455, 7558.0, 7640.197779233212, 7740.535567865946, 7915.841683166304, 7955.24425179607, 502.5125628140698, 584.1763114009227, 600.2616781358865, 604.5224272824507, 615.4768446820257, 3633.800140992218, 3825.4261860720558, 3887.3002859485564, 3911.5892831252877, 4250.978745106255, 49138.0, 49191.754041229564, 49199.0, 49225.26162107571, 52144.0, 44400.3339949901, 44558.77720611376, 45375.54624453779, 45402.0, 48895.0, 43854.561454385046, 44026.33960490595, 45658.54341456543, 46307.53692463032, 47001.29498057463, 8221.17788221173, 8252.327918563959, 8495.447795893248, 8525.74422767318, 8710.782230444289, 31717.682823172396, 31960.200994975312, 32164.678353217103, 32198.83900580576, 32913.34173316568, 36958.8152059238, 37855.35012549095, 39870.0, 40421.59578404296, 40432.0, 10608.522616482123, 10644.89355106439, 10678.252522323362, 10732.624358147428, 10833.241673083125, 11327.830082548604, 11467.942660286979, 11547.480363383836, 11991.100667450151, 12392.217774857163, 10434.530446129791, 10661.253712240068, 10692.518836652525, 10850.891491084989, 11076.944615276872, 10711.89288107109, 10858.34849909008, 11153.163512736415, 11535.480903359201, 11604.593839215588, 10516.842247366143, 10903.383603830247, 11014.118870490502, 11185.888141118485, 11283.153763467608, 9281.953590232006, 9365.29760267969, 9475.575886293122, 9582.137607615348, 9847.950760246153, 8817.647294108421, 9156.496392698466, 9306.813863722824, 9365.391249568756, 9455.101765332283], "unit": "ms", "name": "yui.html", "value": 5765.793584623267}], "name": "dromaeo_css", "value": 6312.230782323084}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 105.0, 112.0, 112.0, 112.0, 101.0, 113.0, 104.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [164.0, 131.0, 151.0, 166.0, 131.0, 167.0, 152.0, 131.0, 177.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 79.0, 90.0, 71.0, 72.0, 72.0, 104.0, 87.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 125.0, 90.0, 91.0, 93.0, 139.0, 92.0, 92.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 148.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 72.0, 70.0, 70.0, 69.0, 70.0, 77.0, 67.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [80.0, 91.0, 84.0, 83.0, 90.0, 88.0, 81.0, 83.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 132.0, 127.0, 119.0, 117.0, 124.0, 120.0, 121.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 137.0, 147.0, 155.0, 138.0, 147.0, 145.0, 145.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 70.0, 68.0, 69.0, 71.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1515.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.20361247947454], "unit": "score", "name": "Richards", "value": 214.98917999999992}, {"lowerIsBetter": false, "replicates": [185.42555164101614], "unit": "score", "name": "DeltaBlue", "value": 356.5743740000001}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [28885.714285714286], "unit": "score", "name": "RegExp", "value": 31.537561819980194}, {"lowerIsBetter": false, "replicates": [605.3268765133172], "unit": "score", "name": "Splay", "value": 134.62313200000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19782.038408638164}]} 12:10:27 INFO - RETURN: dromaeo_css: 6312.23 12:10:27 INFO - RETURN: kraken: 1515.20 12:10:27 INFO - RETURN: v8_7: 19782.04 12:10:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19782.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6312.23"}}} 12:10:27 INFO - Return code: 0 12:10:27 INFO - # TBPL SUCCESS # 12:10:27 INFO - Running post-action listener: _resource_record_post_action 12:10:27 INFO - Running post-run listener: _resource_record_post_run 12:10:28 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508944384; Read time: 20; Write time: 501772 12:10:28 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 197099520; Read time: 0; Write time: 233548 12:10:28 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271831040; Read time: 20; Write time: 166616 12:10:28 INFO - Running post-run listener: _upload_blobber_files 12:10:28 INFO - Blob upload gear active. 12:10:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:10:28 INFO - Copying logs to upload dir... 12:10:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.108980 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 12:10:28.272419) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:28.279643) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009995 build_url: 'https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:28.335439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:28.335844) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448306595.572876-2100497818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:28.389263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:28.389643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:28.390005) ========= ========= Total master_lag: 0.32 =========