builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1448308117.71 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.710683) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.711073) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.711362) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006501 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.751582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.751842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.772118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.772367) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.828551) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.828835) ========= 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:48:37.829158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:37.829421) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 11:48:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-23 11:48:39 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172080 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.014926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.015218) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.066728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.067079) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 11:48:39,624 truncating revision to first 12 chars 2015-11-23 11:48:39,624 Setting DEBUG logging. 2015-11-23 11:48:39,624 attempt 1/10 2015-11-23 11:48:39,624 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:48:39,880 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.653897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.654189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.666249) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:48:38.666510) ========= 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:48:38.666889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-23 11:48:38.667193) ========= /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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:40 INFO - MultiFileLogger online at 20151123 11:48:40 in /builds/slave/test 11:48:40 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:48:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:40 INFO - {'append_to_log': False, 11:48:40 INFO - 'base_work_dir': '/builds/slave/test', 11:48:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:48:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:40 INFO - 'branch': 'Fx-Team-Non-PGO', 11:48:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:40 INFO - 'config_files': ('talos/linux_config.py',), 11:48:40 INFO - 'default_actions': ('clobber', 11:48:40 INFO - 'read-buildbot-config', 11:48:40 INFO - 'download-and-extract', 11:48:40 INFO - 'populate-webroot', 11:48:40 INFO - 'create-virtualenv', 11:48:40 INFO - 'install', 11:48:40 INFO - 'run-tests'), 11:48:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:40 INFO - 'download_minidump_stackwalk': True, 11:48:40 INFO - 'download_symbols': 'ondemand', 11:48:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:40 INFO - 'installer_path': 'installer.exe', 11:48:40 INFO - 'log_level': 'info', 11:48:40 INFO - 'log_name': 'talos', 11:48:40 INFO - 'log_to_console': True, 11:48:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:40 INFO - 'opt_config_files': (), 11:48:40 INFO - 'pip_index': False, 11:48:40 INFO - 'sps_profile': False, 11:48:40 INFO - 'sps_profile_interval': 0, 11:48:40 INFO - 'suite': 'dromaeojs', 11:48:40 INFO - 'system_bits': '64', 11:48:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:40 INFO - 'title': 'talos-linux64-ix-023', 11:48:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:40 INFO - 'use_talos_json': True, 11:48:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:40 INFO - 'work_dir': 'build'} 11:48:40 INFO - ##### 11:48:40 INFO - ##### Running clobber step. 11:48:40 INFO - ##### 11:48:40 INFO - Running pre-action listener: _resource_record_pre_action 11:48:40 INFO - Running main action method: clobber 11:48:40 INFO - rmtree: /builds/slave/test/build 11:48:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:40 INFO - Running post-action listener: _resource_record_post_action 11:48:40 INFO - ##### 11:48:40 INFO - ##### Running read-buildbot-config step. 11:48:40 INFO - ##### 11:48:40 INFO - Running pre-action listener: _resource_record_pre_action 11:48:40 INFO - Running main action method: read_buildbot_config 11:48:40 INFO - Using buildbot properties: 11:48:40 INFO - { 11:48:40 INFO - "properties": { 11:48:40 INFO - "buildnumber": 2105, 11:48:40 INFO - "product": "firefox", 11:48:40 INFO - "script_repo_revision": "production", 11:48:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:48:40 INFO - "repository": "", 11:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:48:40 INFO - "buildid": "20151123050554", 11:48:40 INFO - "slavename": "talos-linux64-ix-023", 11:48:40 INFO - "pgo_build": "False", 11:48:40 INFO - "basedir": "/builds/slave/test", 11:48:40 INFO - "project": "", 11:48:40 INFO - "platform": "ubuntu64_hw", 11:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:48:40 INFO - "slavebuilddir": "test", 11:48:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:48:40 INFO - "branch": "fx-team", 11:48:40 INFO - "repo_path": "integration/fx-team", 11:48:40 INFO - "stage_platform": "linux64", 11:48:40 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:48:40 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:48:40 INFO - }, 11:48:40 INFO - "sourcestamp": { 11:48:40 INFO - "repository": "", 11:48:40 INFO - "hasPatch": false, 11:48:40 INFO - "project": "", 11:48:40 INFO - "branch": "fx-team-linux64-talos", 11:48:40 INFO - "changes": [ 11:48:40 INFO - { 11:48:40 INFO - "category": null, 11:48:40 INFO - "files": [ 11:48:40 INFO - { 11:48:40 INFO - "url": null, 11:48:40 INFO - "name": "https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:48:40 INFO - } 11:48:40 INFO - ], 11:48:40 INFO - "repository": "", 11:48:40 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:48:40 INFO - "who": "pbrosset@mozilla.com", 11:48:40 INFO - "when": 1448285946, 11:48:40 INFO - "number": 6694867, 11:48:40 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:48:40 INFO - "project": "", 11:48:40 INFO - "at": "Mon 23 Nov 2015 05:39:06", 11:48:40 INFO - "branch": "fx-team-linux64-talos", 11:48:40 INFO - "revlink": "", 11:48:40 INFO - "properties": [ 11:48:40 INFO - [ 11:48:40 INFO - "buildid", 11:48:40 INFO - "20151123050554", 11:48:40 INFO - "Change" 11:48:40 INFO - ], 11:48:40 INFO - [ 11:48:40 INFO - "builduid", 11:48:40 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:48:40 INFO - "Change" 11:48:40 INFO - ], 11:48:40 INFO - [ 11:48:40 INFO - "pgo_build", 11:48:40 INFO - "False", 11:48:40 INFO - "Change" 11:48:40 INFO - ] 11:48:40 INFO - ], 11:48:40 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:48:40 INFO - } 11:48:40 INFO - ], 11:48:40 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:48:40 INFO - } 11:48:40 INFO - } 11:48:40 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:48:40 INFO - Running post-action listener: _resource_record_post_action 11:48:40 INFO - ##### 11:48:40 INFO - ##### Running download-and-extract step. 11:48:40 INFO - ##### 11:48:40 INFO - Running pre-action listener: _resource_record_pre_action 11:48:40 INFO - Running main action method: download_and_extract 11:48:40 INFO - mkdir: /builds/slave/test/build/tests 11:48: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:48:40 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:48:40 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:48:40 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:48:43 INFO - Downloaded 1302 bytes. 11:48:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:48:43 INFO - Using the following test package requirements: 11:48:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:48:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'jsshell-linux-x86_64.zip'], 11:48:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:48:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:48:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:48:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:48:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:48:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:43 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:48:43 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:48:43 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:48:43 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:48:43 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:48:45 INFO - Downloaded 21339409 bytes. 11:48:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:48:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:48:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:48:46 INFO - Return code: 0 11:48:46 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:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:46 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:48:46 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:48:46 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:48:46 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:48:46 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:48:51 INFO - Downloaded 21339409 bytes. 11:48:51 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:48:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:48:51 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:48:52 INFO - Return code: 0 11:48: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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:54 INFO - Downloaded 11130997 bytes. 11:48:54 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:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:54 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:48:54 INFO - Return code: 0 11:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:54 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:48:54 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:48:54 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:48:54 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:48:54 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:48:56 INFO - Downloaded 55911868 bytes. 11:48:56 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:48:56 INFO - mkdir: /builds/slave/test/properties 11:48:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:56 INFO - Contents: 11:48:56 INFO - build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:48:56 INFO - Running post-action listener: _resource_record_post_action 11:48:56 INFO - Running post-action listener: set_extra_try_arguments 11:48:56 INFO - ##### 11:48:56 INFO - ##### Running populate-webroot step. 11:48:56 INFO - ##### 11:48:56 INFO - Running pre-action listener: _resource_record_pre_action 11:48:56 INFO - Running main action method: populate_webroot 11:48:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:48:56 INFO - '../fennec_ids.txt'], 11:48:56 INFO - 'tests': ['tcheck2']}, 11:48:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:56 INFO - '--tppagecycles', 11:48:56 INFO - '7'], 11:48:56 INFO - 'tests': ['tsvgm']}}, 11:48:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:48:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:48:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:48:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'tests': ['damp', 'tps']}, 11:48:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['damp', 'tps']}, 11:48:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:48:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:56 INFO - 'other': {'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'other_l64': {'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'other_nol64': {'tests': ['a11yr', 11:48:56 INFO - 'ts_paint', 11:48:56 INFO - 'tpaint', 11:48:56 INFO - 'sessionrestore', 11:48:56 INFO - 'sessionrestore_no_auto_restore']}, 11:48:56 INFO - 'svgr': {'tests': ['tsvgx', 11:48:56 INFO - 'tsvgr_opacity', 11:48:56 INFO - 'tart', 11:48:56 INFO - 'tscrollx', 11:48:56 INFO - 'cart']}, 11:48:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['tsvgx', 11:48:56 INFO - 'tsvgr_opacity', 11:48:56 INFO - 'tart', 11:48:56 INFO - 'tscrollx', 11:48:56 INFO - 'cart']}, 11:48:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'tests': ['tp5o']}, 11:48:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'talos_options': ['--e10s'], 11:48:56 INFO - 'tests': ['tp5o']}, 11:48:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'talos_options': ['--xperf_path', 11:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:56 INFO - 'tests': ['tp5n']}, 11:48:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:56 INFO - 'talos_options': ['--e10s', 11:48:56 INFO - '--xperf_path', 11:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:56 INFO - 'tests': ['tp5n']}}, 11:48:56 INFO - 'talos.zip': {'path': '', 11:48:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:56 INFO - Running post-action listener: _resource_record_post_action 11:48:56 INFO - ##### 11:48:56 INFO - ##### Running create-virtualenv step. 11:48:56 INFO - ##### 11:48:56 INFO - Running pre-action listener: _resource_record_pre_action 11:48:56 INFO - Running main action method: create_virtualenv 11:48:56 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:48:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:56 INFO - Using real prefix '/usr' 11:48:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:59 INFO - Installing pip.................done. 11:48:59 INFO - Return code: 0 11:48:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:48:59 INFO - Using env: {'DISPLAY': ':0', 11:48:59 INFO - 'HOME': '/home/cltbld', 11:48:59 INFO - 'LANG': 'en_US.UTF-8', 11:48:59 INFO - 'LANGUAGE': 'en_US:en', 11:48:59 INFO - 'LOGNAME': 'cltbld', 11:48:59 INFO - 'MAIL': '/var/mail/cltbld', 11:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:59 INFO - 'MOZ_NO_REMOTE': '1', 11:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:59 INFO - 'NO_EM_RESTART': '1', 11:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:59 INFO - 'PWD': '/builds/slave/test', 11:48:59 INFO - 'SHELL': '/bin/bash', 11:48:59 INFO - 'SHLVL': '1', 11:48:59 INFO - 'TERM': 'linux', 11:48:59 INFO - 'TMOUT': '86400', 11:48:59 INFO - 'USER': 'cltbld', 11:48:59 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:59 INFO - '_': '/tools/buildbot/bin/python'} 11:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:48:59 INFO - Cleaning up... 11:48:59 INFO - Return code: 0 11:48:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:48:59 INFO - Using env: {'DISPLAY': ':0', 11:48:59 INFO - 'HOME': '/home/cltbld', 11:48:59 INFO - 'LANG': 'en_US.UTF-8', 11:48:59 INFO - 'LANGUAGE': 'en_US:en', 11:48:59 INFO - 'LOGNAME': 'cltbld', 11:48:59 INFO - 'MAIL': '/var/mail/cltbld', 11:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:59 INFO - 'MOZ_NO_REMOTE': '1', 11:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:59 INFO - 'NO_EM_RESTART': '1', 11:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:59 INFO - 'PWD': '/builds/slave/test', 11:48:59 INFO - 'SHELL': '/bin/bash', 11:48:59 INFO - 'SHLVL': '1', 11:48:59 INFO - 'TERM': 'linux', 11:48:59 INFO - 'TMOUT': '86400', 11:48:59 INFO - 'USER': 'cltbld', 11:48:59 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:59 INFO - '_': '/tools/buildbot/bin/python'} 11:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:59 INFO - Downloading/unpacking psutil>=0.7.1 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:49:01 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:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:01 INFO - Installing collected packages: psutil 11:49:01 INFO - Running setup.py install for psutil 11:49:01 INFO - building 'psutil._psutil_linux' extension 11:49:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:49:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:49:01 INFO - building 'psutil._psutil_posix' extension 11:49:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:49:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:01 INFO - Successfully installed psutil 11:49:01 INFO - Cleaning up... 11:49:01 INFO - Return code: 0 11:49:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 11:49:01 INFO - 'HOME': '/home/cltbld', 11:49:01 INFO - 'LANG': 'en_US.UTF-8', 11:49:01 INFO - 'LANGUAGE': 'en_US:en', 11:49:01 INFO - 'LOGNAME': 'cltbld', 11:49:01 INFO - 'MAIL': '/var/mail/cltbld', 11:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:01 INFO - 'MOZ_NO_REMOTE': '1', 11:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:01 INFO - 'NO_EM_RESTART': '1', 11:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:01 INFO - 'PWD': '/builds/slave/test', 11:49:01 INFO - 'SHELL': '/bin/bash', 11:49:01 INFO - 'SHLVL': '1', 11:49:01 INFO - 'TERM': 'linux', 11:49:01 INFO - 'TMOUT': '86400', 11:49:01 INFO - 'USER': 'cltbld', 11:49:01 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:01 INFO - '_': '/tools/buildbot/bin/python'} 11:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:03 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:03 INFO - Installing collected packages: mozsystemmonitor 11:49:03 INFO - Running setup.py install for mozsystemmonitor 11:49:03 INFO - Successfully installed mozsystemmonitor 11:49:03 INFO - Cleaning up... 11:49:04 INFO - Return code: 0 11:49:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 11:49:04 INFO - 'HOME': '/home/cltbld', 11:49:04 INFO - 'LANG': 'en_US.UTF-8', 11:49:04 INFO - 'LANGUAGE': 'en_US:en', 11:49:04 INFO - 'LOGNAME': 'cltbld', 11:49:04 INFO - 'MAIL': '/var/mail/cltbld', 11:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:04 INFO - 'MOZ_NO_REMOTE': '1', 11:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:04 INFO - 'NO_EM_RESTART': '1', 11:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:04 INFO - 'PWD': '/builds/slave/test', 11:49:04 INFO - 'SHELL': '/bin/bash', 11:49:04 INFO - 'SHLVL': '1', 11:49:04 INFO - 'TERM': 'linux', 11:49:04 INFO - 'TMOUT': '86400', 11:49:04 INFO - 'USER': 'cltbld', 11:49:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:04 INFO - '_': '/tools/buildbot/bin/python'} 11:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:05 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:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:05 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:05 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:05 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:05 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:05 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:05 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:06 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:06 INFO - Downloading docopt-0.6.1.tar.gz 11:49:06 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:06 INFO - Running setup.py install for blobuploader 11:49:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:06 INFO - Running setup.py install for requests 11:49:07 INFO - Running setup.py install for docopt 11:49:07 INFO - Successfully installed blobuploader requests docopt 11:49:07 INFO - Cleaning up... 11:49:07 INFO - Return code: 0 11:49:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49: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:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:07 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 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 11:49:07 INFO - 'HOME': '/home/cltbld', 11:49:07 INFO - 'LANG': 'en_US.UTF-8', 11:49:07 INFO - 'LANGUAGE': 'en_US:en', 11:49:07 INFO - 'LOGNAME': 'cltbld', 11:49:07 INFO - 'MAIL': '/var/mail/cltbld', 11:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:07 INFO - 'MOZ_NO_REMOTE': '1', 11:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:07 INFO - 'NO_EM_RESTART': '1', 11:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:07 INFO - 'PWD': '/builds/slave/test', 11:49:07 INFO - 'SHELL': '/bin/bash', 11:49:07 INFO - 'SHLVL': '1', 11:49:07 INFO - 'TERM': 'linux', 11:49:07 INFO - 'TMOUT': '86400', 11:49:07 INFO - 'USER': 'cltbld', 11:49:07 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:07 INFO - '_': '/tools/buildbot/bin/python'} 11:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:07 INFO - Running setup.py (path:/tmp/pip-zK1qd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:07 INFO - Running setup.py (path:/tmp/pip-BK57EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:07 INFO - Running setup.py (path:/tmp/pip-oMHH0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:07 INFO - Running setup.py (path:/tmp/pip-1kjn_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:07 INFO - Running setup.py (path:/tmp/pip-vvQ29S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:07 INFO - Running setup.py (path:/tmp/pip-O16oMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:07 INFO - Running setup.py (path:/tmp/pip-E4l4nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:07 INFO - Running setup.py (path:/tmp/pip-Won9sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:07 INFO - Running setup.py (path:/tmp/pip-0EeR4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:08 INFO - Running setup.py (path:/tmp/pip-mDXHWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:08 INFO - Running setup.py (path:/tmp/pip-wNX4Z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:08 INFO - Running setup.py (path:/tmp/pip-hy0sQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:08 INFO - Running setup.py (path:/tmp/pip-6svIYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:08 INFO - Running setup.py (path:/tmp/pip-iaRUNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:08 INFO - Running setup.py (path:/tmp/pip-S1DQzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:08 INFO - Running setup.py (path:/tmp/pip-X_I9uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:08 INFO - Running setup.py (path:/tmp/pip-n5ofKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:08 INFO - Running setup.py install for manifestparser 11:49:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:08 INFO - Running setup.py install for mozcrash 11:49:08 INFO - Running setup.py install for mozdebug 11:49:08 INFO - Running setup.py install for mozdevice 11:49:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozfile 11:49:09 INFO - Running setup.py install for mozhttpd 11:49:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozinfo 11:49:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozInstall 11:49:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozleak 11:49:09 INFO - Running setup.py install for mozlog 11:49:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for moznetwork 11:49:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozprocess 11:49:09 INFO - Running setup.py install for mozprofile 11:49:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:09 INFO - Running setup.py install for mozrunner 11:49:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:10 INFO - Running setup.py install for mozscreenshot 11:49:10 INFO - Running setup.py install for moztest 11:49:10 INFO - Running setup.py install for mozversion 11:49:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:10 INFO - Cleaning up... 11:49:10 INFO - Return code: 0 11:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:10 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 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 11:49:10 INFO - 'HOME': '/home/cltbld', 11:49:10 INFO - 'LANG': 'en_US.UTF-8', 11:49:10 INFO - 'LANGUAGE': 'en_US:en', 11:49:10 INFO - 'LOGNAME': 'cltbld', 11:49:10 INFO - 'MAIL': '/var/mail/cltbld', 11:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:10 INFO - 'MOZ_NO_REMOTE': '1', 11:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:10 INFO - 'NO_EM_RESTART': '1', 11:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:10 INFO - 'PWD': '/builds/slave/test', 11:49:10 INFO - 'SHELL': '/bin/bash', 11:49:10 INFO - 'SHLVL': '1', 11:49:10 INFO - 'TERM': 'linux', 11:49:10 INFO - 'TMOUT': '86400', 11:49:10 INFO - 'USER': 'cltbld', 11:49:10 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:10 INFO - '_': '/tools/buildbot/bin/python'} 11:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:10 INFO - Running setup.py (path:/tmp/pip-bLd_3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:10 INFO - Running setup.py (path:/tmp/pip-2CURQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:10 INFO - Running setup.py (path:/tmp/pip-QKT8H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:10 INFO - Running setup.py (path:/tmp/pip-ERgDmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:10 INFO - Running setup.py (path:/tmp/pip-3PiEEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:10 INFO - Running setup.py (path:/tmp/pip-uLgMfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:11 INFO - Running setup.py (path:/tmp/pip-ucueY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:11 INFO - Running setup.py (path:/tmp/pip-fuR8px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:11 INFO - Running setup.py (path:/tmp/pip-liUmbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:11 INFO - Running setup.py (path:/tmp/pip-FpV62w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:11 INFO - Running setup.py (path:/tmp/pip-BmBZjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:11 INFO - Running setup.py (path:/tmp/pip-yWbq9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:11 INFO - Running setup.py (path:/tmp/pip-5OMD1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:11 INFO - Running setup.py (path:/tmp/pip-6RzrWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:11 INFO - Running setup.py (path:/tmp/pip-OkgB3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:11 INFO - Running setup.py (path:/tmp/pip-kmLeEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:11 INFO - Running setup.py (path:/tmp/pip-05p8zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:11 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:11 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:11 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:11 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:11 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:11 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:13 INFO - Downloading blessings-1.5.1.tar.gz 11:49:13 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:13 INFO - Installing collected packages: blessings 11:49:13 INFO - Running setup.py install for blessings 11:49:13 INFO - Successfully installed blessings 11:49:13 INFO - Cleaning up... 11:49:13 INFO - Return code: 0 11:49:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:13 INFO - Reading from file tmpfile_stdout 11:49:13 INFO - Current package versions: 11:49:13 INFO - argparse == 1.2.1 11:49:13 INFO - blessings == 1.5.1 11:49:13 INFO - blobuploader == 1.2.4 11:49:13 INFO - docopt == 0.6.1 11:49:13 INFO - manifestparser == 1.1 11:49:13 INFO - mozInstall == 1.12 11:49:13 INFO - mozcrash == 0.16 11:49:13 INFO - mozdebug == 0.1 11:49:13 INFO - mozdevice == 0.47 11:49:13 INFO - mozfile == 1.2 11:49:13 INFO - mozhttpd == 0.7 11:49:13 INFO - mozinfo == 0.9 11:49:13 INFO - mozleak == 0.1 11:49:13 INFO - mozlog == 3.0 11:49:13 INFO - moznetwork == 0.27 11:49:13 INFO - mozprocess == 0.22 11:49:13 INFO - mozprofile == 0.27 11:49:13 INFO - mozrunner == 6.11 11:49:13 INFO - mozscreenshot == 0.1 11:49:13 INFO - mozsystemmonitor == 0.0 11:49:13 INFO - moztest == 0.7 11:49:13 INFO - mozversion == 1.4 11:49:13 INFO - psutil == 3.1.1 11:49:13 INFO - requests == 1.2.3 11:49:13 INFO - wsgiref == 0.1.2 11:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:13 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 0x7f8083a06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, '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': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 11:49:13 INFO - 'HOME': '/home/cltbld', 11:49:13 INFO - 'LANG': 'en_US.UTF-8', 11:49:13 INFO - 'LANGUAGE': 'en_US:en', 11:49:13 INFO - 'LOGNAME': 'cltbld', 11:49:13 INFO - 'MAIL': '/var/mail/cltbld', 11:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:13 INFO - 'MOZ_NO_REMOTE': '1', 11:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:13 INFO - 'NO_EM_RESTART': '1', 11:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:13 INFO - 'PWD': '/builds/slave/test', 11:49:13 INFO - 'SHELL': '/bin/bash', 11:49:13 INFO - 'SHLVL': '1', 11:49:13 INFO - 'TERM': 'linux', 11:49:13 INFO - 'TMOUT': '86400', 11:49:13 INFO - 'USER': 'cltbld', 11:49:13 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:13 INFO - '_': '/tools/buildbot/bin/python'} 11:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:49:14 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:14 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:14 INFO - Cleaning up... 11:49:14 INFO - Return code: 0 11:49:14 INFO - Running post-action listener: _resource_record_post_action 11:49:14 INFO - Running post-action listener: _start_resource_monitoring 11:49:14 INFO - Starting resource monitoring. 11:49:14 INFO - ##### 11:49:14 INFO - ##### Running install step. 11:49:14 INFO - ##### 11:49:14 INFO - Running pre-action listener: _resource_record_pre_action 11:49:14 INFO - Running main action method: install 11:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:14 INFO - Reading from file tmpfile_stdout 11:49:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:14 INFO - Reading from file tmpfile_stdout 11:49:14 INFO - Output received: 11:49:14 INFO - Usage: mozinstall [options] installer 11:49:14 INFO - Options: 11:49:14 INFO - -h, --help show this help message and exit 11:49:14 INFO - -d DEST, --destination=DEST 11:49:14 INFO - Directory to install application into. [default: 11:49:14 INFO - "/builds/slave/test"] 11:49:14 INFO - --app=APP Application being installed. [default: firefox] 11:49:14 INFO - mkdir: /builds/slave/test/build/application 11:49:14 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:14 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:49:28 INFO - Reading from file tmpfile_stdout 11:49:28 INFO - Output received: 11:49:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:49:28 INFO - Running post-action listener: _resource_record_post_action 11:49:28 INFO - ##### 11:49:28 INFO - ##### Running run-tests step. 11:49:28 INFO - ##### 11:49:28 INFO - Running pre-action listener: _resource_record_pre_action 11:49:28 INFO - Running main action method: run_tests 11:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:28 INFO - Python 2.7.3 11:49:28 INFO - Return code: 0 11:49:28 INFO - grabbing minidump binary from tooltool 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 - 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 0x16f5b70>, '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 0x1746dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1747250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:28 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:49:28 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:49:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:28 INFO - Return code: 0 11:49:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:49:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:49:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:28 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-023', '--webServer', 'localhost'] in /builds/slave/test/build 11:49:28 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-023 --webServer localhost 11:49:28 INFO - Using env: {'DISPLAY': ':0', 11:49:28 INFO - 'HOME': '/home/cltbld', 11:49:28 INFO - 'LANG': 'en_US.UTF-8', 11:49:28 INFO - 'LANGUAGE': 'en_US:en', 11:49:28 INFO - 'LOGNAME': 'cltbld', 11:49:28 INFO - 'MAIL': '/var/mail/cltbld', 11:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:28 INFO - 'MOZ_NO_REMOTE': '1', 11:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:28 INFO - 'NO_EM_RESTART': '1', 11:49:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:28 INFO - 'PWD': '/builds/slave/test', 11:49:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:28 INFO - 'SHELL': '/bin/bash', 11:49:28 INFO - 'SHLVL': '1', 11:49:28 INFO - 'TERM': 'linux', 11:49:28 INFO - 'TMOUT': '86400', 11:49:28 INFO - 'USER': 'cltbld', 11:49:28 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017', 11:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:28 INFO - '_': '/tools/buildbot/bin/python'} 11:49:28 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-023', '--webServer', 'localhost'] with output_timeout 3600 11:49:28 INFO - mozversion INFO | application_buildid: 20151123050554 11:49:28 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:49:28 INFO - mozversion INFO | application_display_name: Nightly 11:49:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:28 INFO - mozversion INFO | application_name: Firefox 11:49:28 INFO - mozversion INFO | application_remotingname: firefox 11:49:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:49:28 INFO - mozversion INFO | application_vendor: Mozilla 11:49:28 INFO - mozversion INFO | application_version: 45.0a1 11:49:28 INFO - mozversion INFO | platform_buildid: 20151123050554 11:49:28 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:49:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:49:28 INFO - mozversion INFO | platform_version: 45.0a1 11:49:28 INFO - 2015-11-23 11:49:28,890 DEBUG : using testdate: 1448308168 11:49:28 INFO - 2015-11-23 11:49:28,890 DEBUG : actual date: 1448308168 11:49:28 INFO - 2015-11-23 11:49:28,938 INFO : starting webserver on 'localhost:44358' 11:49:28 INFO - 2015-11-23 11:49:28,939 INFO : Starting test suite talos-linux64-ix-023 11:49:28 INFO - 2015-11-23 11:49:28,939 INFO : Starting test dromaeo_css 11:49:28 INFO - 2015-11-23 11:49:28,939 DEBUG : operating with platform_type : linux_ 11:49:28 INFO - 2015-11-23 11:49:28,940 INFO : Initialising browser for dromaeo_css test... 11:49:28 INFO - 2015-11-23 11:49:28,955 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubwLxL/profile http://localhost:44358/getInfo.html 11:49:34 INFO - 2015-11-23 11:49:34,313 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:49:34 INFO - 2015-11-23 11:49:34,313 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:49:34 INFO - 2015-11-23 11:49:34,313 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:49:34 INFO - 2015-11-23 11:49:34,313 DEBUG : BROWSER_OUTPUT: __metrics 11:49:34 INFO - 2015-11-23 11:49:34,470 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:35 INFO - 2015-11-23 11:49:35,726 INFO : Browser initialized. 11:49:35 INFO - 2015-11-23 11:49:35,726 INFO : Running cycle 1/1 for dromaeo_css test... 11:49:35 INFO - 2015-11-23 11:49:35,727 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubwLxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:49:47 INFO - 2015-11-23 11:49:47,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 141914112 11:49:47 INFO - 2015-11-23 11:49:47,622 DEBUG : BROWSER_OUTPUT: 11:50:39 INFO - 2015-11-23 11:50:39,142 DEBUG : BROWSER_OUTPUT: 1448308239140 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:52:51 INFO - 2015-11-23 11:52:51,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44358/tests/dromaeo/cssquery-ext.html) 11:52:52 INFO - 2015-11-23 11:52:52,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 224747520 11:52:52 INFO - 2015-11-23 11:52:52,720 DEBUG : BROWSER_OUTPUT: 11:55:55 INFO - 2015-11-23 11:55:55,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-ext.html (next: http://localhost:44358/tests/dromaeo/cssquery-jquery.html) 11:55:55 INFO - 2015-11-23 11:55:55,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 218710016 11:55:55 INFO - 2015-11-23 11:55:55,802 DEBUG : BROWSER_OUTPUT: 11:58:57 INFO - 2015-11-23 11:58:57,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44358/tests/dromaeo/cssquery-mootools.html) 11:58:58 INFO - 2015-11-23 11:58:58,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 212803584 11:58:58 INFO - 2015-11-23 11:58:58,381 DEBUG : BROWSER_OUTPUT: 12:02:00 INFO - 2015-11-23 12:02:00,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44358/tests/dromaeo/cssquery-prototype.html) 12:02:00 INFO - 2015-11-23 12:02:00,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 202309632 12:02:00 INFO - 2015-11-23 12:02:00,868 DEBUG : BROWSER_OUTPUT: 12:05:03 INFO - 2015-11-23 12:05:03,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44358/tests/dromaeo/cssquery-yui.html) 12:05:04 INFO - 2015-11-23 12:05:04,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 207601664 12:05:04 INFO - 2015-11-23 12:05:04,173 DEBUG : BROWSER_OUTPUT: 12:08:06 INFO - 2015-11-23 12:08:06,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-yui.html (next: http://localhost:44358/tests/dromaeo/cssquery-dojo.html) 12:08:07 INFO - 2015-11-23 12:08:07,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 251609088 12:08:07 INFO - 2015-11-23 12:08:07,051 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,052 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:08:07 INFO - 2015-11-23 12:08:07,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:08:07 INFO - 2015-11-23 12:08:07,052 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:08:07 INFO - 2015-11-23 12:08:07,052 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:08:07 INFO - 2015-11-23 12:08:07,052 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2651.7348265173487;2726.6046423268626;2730.7678847298002;2750.931226719333;2754.5454999925014;4559.065391594723;4716;4722.315264286681;4726.267428548576;4744.525547445253;4600;4621.792019359128;4685.531446855312;4698.718076915387;4704.059188162364;4327.22110020197;4413.646908247349;4417.337399390085;4423.955760442403;4450.287953927373;4155.044339801847;4434.445694288214;4455.576720211575;4476.03765190484;4485.102979404116;4243.427137336451;4313.762743049131;4335.6965012449145;4341.761203133827;4344.087741574273;4391.4730232372;4393.187260356813;4398.032432864765;4400.317950717644;4438.023634800339;4374.846880359204;4377.824887004516;4378.43080399546;4420.093880754438;4430.911381772346;4432.445944256968;4515.909681806345;4581.473130589991;4585.839495617637;4617.030423611046;5027.874303142414;5064.3163172971545;5073.949260507385;5074.441811400743;5127.6154288428515;5100.285959965608;5106.8212612558755;5109.054824857376;5112;5112.386513618352;4537.568930951555;4630.073985202973;4641.25739881624;4650.488446270908;4735.692180008288;5222.321098257202;5275.340582427197;5279.392869819943;5280.709560974184;5329.200619907045;5051.242313652908;5065.8733531662;5068.493150684976;5072.264521644414;5130.666506677054;4761.285807128889;4879.268109783561;4885.511448855157;4969.503049695001;5060.746962651852;4987.476314986874;4995.900081998412;5001.774920128603;5008.924866127011;5061.519155680205;4968.72672003036;4976.576990955737;4977;4980.726060066659;5027.84916452507;4073.0631954650003;4141.937870931938;4176.164767046603;4177.937330939978;4180.7909604519655;3626.9818650906577;3713.5729391119826;3735.9252814944093;3738.3831667775057;3740.532433445819;4267.253230684618;4332.393464914914;4332.67504937131;4352.978235108868;4372.0818628088455;5045.344105266292;5078.568321692624;5079.6952182869145;5092.312537807423;5098.388193416814;4119.134981653886;4218.303979843292;4224.577542245751;4349.3475978603465;4377.3433984901885;4443.533428989974;4531.161735079021;4539.228331183706;4561.521040290788;4580.564846339593;4837.129316723023;4840.7337596432535;4859.416869975626;4862.562369386772;4909.754512274372;4804.942912559231;4881.31661567388;5083.72039537829;5103.948960510347;5158.484151584811;4716.882077947941;4756.096341695067;4843.975780121218;4846.17615005457;4858.708477491362;5032.6980381177245;5042.672226305279;5044.672096313728;5052.671576347526;5081.18701007837;4765.7140571565815;4892.094962431962;5113.74431278442;5119.180931051014;5124.974375128249;4779.808807647794;4831.855044348676;4896.510348965075;4896.90206195867;4899.877503062452;4910.337104490991;4939.456659767495;4943.036107958914;4946.554810067111;4987;4660.883477912944;4779.808807647655;4846.224604063333;4848.612111031039;4866.1727506323305;4853.733044682576;4859.07677541266;4911.214205727067;4920.950790492049;4967.329410529676;4796.544328288807;4825.541573550507;4856.150173719656;4867.78042486592;4907.435644900882 12:08:07 INFO - 2015-11-23 12:08:07,053 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.7270773674768;582.2605291280074;585.958982871199;587.1691556447627;592.3691268798732;28563.714362856364;38195;38841.80579097104;38937.8053109734;38939.41590876132;41482.17035659285;42013.57986420135;42034.369484457755;42049;42115.368269475985;7035.964820175892;7165.713371465135;8071.677132914677;8252.174782521759;8256;10326.638567650134;10607.098396636295;10607.84088238677;10615.84076238857;10624.203184761136;10281.177505799555;10362.948185259063;10381.584736610526;10394.116500097502;10418.426986515738;7180.6050667213285;7379.225181355934;10054.195664346835;10190.643327483576;10407.895921040845;10134.797304053951;10259.897401025968;10267.897321026769;10276.126529245023;10279.537420816006;38741;39313.803430982945;39330.803345983375;39357.80321098376;39359.8032009841;2770.5844123381453;2914.8396838173894;2930.8388038657863;3171.9682803171904;3467.9826600866836;29035.41929161426;29149.854250728822;29220.269493262625;29244.853775731197;29831.70168298311;3389.4237979543536;3461.582623194692;3474.322507111114;3536.381133301662;3609.7653652512763;229796;231538;231947;232282;232463.9999999983;50944.49055509397;52717.209241861405;59832.70083649554;65118.67440662861;66955.96962318984;58268.417315827144;58293;58557.4144258552;58570.82858342809;58623.41376586265;13031.609051728463;13160.276184809927;13180.736385272241;13191.802122968164;13203.273819939996;10504.737381565523;10548.683539493828;10606.416647084485;10606.469676516142;10614.150867930546;19358.419247422316;19871.801281986995;19939.401817945483;20004.59990800205;20168.596628067357;7530.322270995527;7695.807604809813;7839.45123841337;7854.60726963661;7886.72396466121;718.9880466994264;759.6315786843377;777.3081957058223;790.0282652337656;923.0677016213539;26385.604215936775;26508.33729156748;26615.600765988525;27579.862100689366;29662.851685741865;909.5088652127777;935.2891802230218;995.6117114325274;1061.0980666433625;1089.0362029603857;13043.347832608331;13075.869241307655;13321.200727956353;13330;13351.599452016455;215688;220990;220999;221053;221431;43486.565134348886;43785.124297513874;47810.28284575734;47819.52180478151;47837.76081119572;1034.524118905312;1183.44378142273;1186.2645160000855;1192.0642295797757;1221.1146918484028;21044.894775526023;26543.33641658974;28043.158705238875;28293.15120546387;28370.716292837635;45144.32283515684;45625.31562026506;45625.77187114043;45636.54363456456;45659;237440;239921;248033;267477;270219;27532.311692207855;27545.31136721598;27568.96741358489;27923.720762792924;27945.58081628818;36744.81627591845;40000.59999399969;40384.59615403926;40587.1882562353;41039.38440923448;34347.656523434445;34348.04997425328;35207;35370.11574710653;35764.642353577176;34998.47502287417;40578.1884362317;42230.366544501245;42400.5759942409;43458.782706087535;37617.24765504729;37736.811315944346;38221.80889095537;38256.42615360828;38935.6106438932;37447;37679.62320376761;38232.2353552933;38305;38456.423153652155;29584;29875.103746887627;29933.700662993964;29946;30151.246218844706 12:08:07 INFO - 2015-11-23 12:08:07,054 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.59320019376645;338.4212995777221;338.93560223557523;338.9966100338999;343.1832239270536;12011;12373.938130309358;14921.328540215689;15098.622534436645;16217.594560135987;11652.30086194829;11928.70178245542;13369.866301337008;15560.299786509606;15606.219689015532;4316.697831151812;4518.254488009475;4523.728576285417;4525.683202175849;4530.207213737583;3371.6965473107416;3462.982685086571;4435.62297204738;4440.045390241097;4470;4992.625553083515;5132.5124113209185;5145.897082058375;5147.150720131174;5149.433562308143;5127.589792816584;5132.0249152661245;5140.871478213037;5257.579393648499;5601.6358936668985;5029.497050294978;5036.06832735945;5060.063888180698;5068.239764035387;5071.644984851062;12033;12953.805692914613;17719.468415947413;19440.125194366286;19442.027898605156;1862.5995410986702;1881.7741870975433;1909.837663798579;1945.9027048647652;2010.547626783962;9190.402623829497;12310.13829031968;12423.130380873343;12652.493900243979;12951.740965180737;1729.1008675488802;1766.7614871992373;1778.1464896849454;1785.3037315446986;1819.417786308382;52090.73954630241;54342.18486722702;54861.725691371685;55294;56376.71811640915;9597.376170548892;9795.363301385387;9804.264680149017;9871.111599956039;9879.456629885282;12431.316277604637;12486.438110285058;12503.249805011728;12508.437120329607;12537.310447925453;7135.892961605477;7151.642417879085;7157.6779044943105;7175.354218120394;7202.603856787927;6867;6886.139232595926;6906.136732908387;6919.584824910521;6923.757668481579;4103.179364127186;4158.376243563429;4159.604837540429;4161.375793630919;4187.309093999456;1605.6066263765451;1673.230314055548;1700.9574760631083;1732.4542769027717;1738.6261953679766;723.8950352198901;874.7200895713438;877.5831480047054;948.0661548374845;991.8313886639289;14967.925160374129;15013.849861501245;15646.139462329453;15701.371945122295;16006.519804405887;727.8653449111931;799.2686691677167;832.1636755061124;893.2095095840228;901.7024381953939;8583;8631.913680863237;8642;8763.518006509703;8922.241609463139;516341;517092;525264;543086;546444;66956;68130.65934670295;68971.65514172397;69347.30652693509;69708;1030.9278350515542;1044.550843137443;1097.3744965369822;1108.1688733449912;1108.3571528513444;13391.732165356832;13727.656808579466;14005.369758361103;14087;14272.357743901757;28941.85529072341;29090;29380.55929161107;32404.675953240167;33058.83470582632;39705.602943971346;39936.4009539863;40163.1967360657;41389.58610413857;42326;8959.73120806377;9078;9123.908760912305;9171.991080980953;12919;16473.34106635769;16815;16900.492985210465;17109.74335384945;17185.484435466955;13511.324433778469;14163.858361416666;14617.122972621677;14689.41242350294;14773.409063637335;8954.417962832395;9255.53722313895;9315.906840931775;9454.574544145667;14218.715625687222;9463.526823658653;9575.856362154713;9671.17794987434;9682.080202380763;9696.515174241118;13987.370568324654;14093.788593170906;14124.293785310489;14437.494687685881;14445.85554144445;14684.85315146835;14720.337584808494;15045;15245.085294882343;15271.694566108838 12:08:07 INFO - 2015-11-23 12:08:07,054 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1362.7478916400464;1372.3481346360477;1415.327719333316;1444.7327244459782;1564.8435156484352;5851.356350801414;6688.130543029405;6876.793696189116;6880.621565813878;6905.930940690591;6780.050792888999;6881.759138430156;6883.724651013966;6892.2763109873495;6893.138357705287;2087.8642888212294;2103.92636257731;2105.336818902041;2109.2512158183854;2109.9050542725536;1963.6563601369703;2079.688046792978;2098.401955442699;2139.12295958657;2146.2595404585395;2054.6609809381434;2068.0590331399176;2078.532330225702;2079.095593416861;2079.261862038977;2055.3525639423533;2061.783512731164;2065.39070974063;2065.514604068058;2067.3281183615386;2072.7098206251135;2082.562661841015;2099.3177217404404;2100.9684854727193;2104.8105670489576;5810.709464526757;5980.581359304851;6839.452843772487;6868.519203655746;6885.896711549331;3981.422693709396;4076.429299898017;4079.224947260011;4081.122558649875;4089.488813898263;2741.3283745482286;2778.3887544740123;2820.4218135282217;2822.294426393402;2880.8271503709843;901.33301356996;915.382117070981;952.0622187145656;965.3918031640092;1730.8874923129956;8157.632906519221;8160;8198.590070496452;8199.385046121564;8222.958885205595;3770.9057273567832;3846.9615303846604;3851.5763266040713;3855.4024126260474;3956.6043395660204;7520.6239688015385;7567.9243207567215;7569.167391586921;7570.470067095251;7579.5073320234005;4175.352820312856;4201.831926722958;4203.5376108628025;4204.201201771653;4207.410962465257;3814.427835824593;3849;3867.0525721198487;3877.5734669186368;3880.2239552089695;3175.412548678502;3202.551642770014;3206.1183174627163;3225.5000474926424;3234.6280177779386;974.3228456222998;977.0278572819948;980.029770527173;983.5279066048193;986.3194395866828;868.700298397052;913.6665117232162;1166.3468457663735;1175.4710380328886;1187.0147777344782;6337.65142917144;6393.9360606394275;6395.712192951329;6403.071554624554;6407.967960160263;1007.7379881230933;1024.7438140464883;1031.9380837149795;1032.3289861590026;1066.722652110457;4697.906041879143;5078.822241221539;5111.821086262037;5124;5124.667586427481;7266.854662906712;7581.924180758122;7719.961400193076;7785.805354866174;7876.0548734151125;7691.230876912376;7736.92263077362;7752.341051010727;7766.417518686121;7781.844363112706;6414.518911081687;6513.869722605521;6550.213974323112;6557.377049180321;6561.376669216417;6570.967145164243;6610.570312929644;6612.140421745143;6613.801585952429;6617.536772425884;7296.416286697157;7428.405727541892;7528.849423011399;7530.209328020698;7541.170471248268;7525.736599219001;7682.731104411542;7804.141544430222;7814.570198638902;7834.725784597512;5830.329512105993;5867.765289388377;5885.823425297248;5949.702514874326;5962.791302304398;6543.70553325111;6564.868702626016;6579.342065793574;6606.4384527315715;6609.603423794588;6133.325334213322;6189.81430557084;6252.531060170414;6378.107065010995;6379.553431259767;5964.194833697396;6010.9699451502465;6040.214772079602;6172.012478003498;6267.373262673696;6071.3625069368845;6120.387961203844;6133.601315914451;6135.171751813448;6136.969315153396;5574.16387541872;5588.050031494575;5599.552035837041;5604.299462567179;5604.8318550443555;5822.970885145547;5893.882122357614;5926.762929482945;5947.197128387786;5975.671338076448 12:08:07 INFO - 2015-11-23 12:08:07,055 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.14161057092997;317.04411200231306;323.009974428377;325.2162288883791;327.1999960097561;5277.551408130309;5368.785248590052;5372.086745253311;5383.896301258243;5390.838274851756;5296.020236256295;5306;5315.840524784263;5320.201969704546;5323.121684921993;3959.049828041264;4043.2115737431213;4097.344424892018;4197.265478541259;4199.853005144821;4064.796760161995;4088.3049881520064;4090.8568200113;4103.548609652936;4171.332586786115;4101.323281658522;4122.752634841919;4134.400511925769;4135.793210339486;4137.793110344486;3948.624880636335;4110.732802367851;4114.835406583748;4146.170765846843;4168.6665066794585;3584.5698516177963;3595.3708101082466;3655.488231647545;3695.7043436525014;3705.7591256568235;5058.266551350071;5067.6452648314635;5079.898402031976;5087.516685914832;5107.13178759608;4793.5685788279225;4801.063792560452;4804.735739534324;4805.231163013901;4807.254875494304;5498.835034948958;5573;5601.691906945116;5612.298462692163;5614.9438505615235;4023.8591649292134;4024.939625905614;4029.3351596986463;4030.415589739501;4031.113155105872;5865.618734782268;5872;5888.146218798293;5888.676122813244;5888.823335299905;4155.085881106152;4160.043190066242;4162.105147393325;4162.167566486714;4163.250614889349;4220.957790422118;4221.514525829508;4230.323148296257;4231.30183519722;4235.364695295731;4540.160070386989;4680.110778951988;4741.241401375763;4745.098431298112;4745.311929770164;5633.774649014075;5636.549076073904;5658.0381335173115;5660.179274005246;5660.29246344207;1437.978430323546;1463.8902082343866;1464.4801095611117;1464.61187785237;1466.6553359960615;986.452518852044;991.5785791038779;992.5483904823288;1010.9090181883665;1011.3072545306488;4970.950290497049;4974.27872958419;4977.083822728203;4980.90038199234;4981.078500477423;5852.356240813507;5853.707314634251;5854.326752423441;5862.824115276463;5863.387568418719;4971.676841005323;4977.925331120036;4978.90042199154;4979.975100124476;4981.950180498221;3031.5149576067724;3097.0337849221564;3127.5152351385573;3143.0570828751283;3162.177833763238;5423.674579525241;5477.589180811455;5517.5585953123655;5518.227448157261;5587.1339942309005;6032.1856549365275;6056.788012419633;6057.394260573908;6065;6069.635821850703;5575.99632066232;5577.665340079527;5579.2746942897165;5579.2746942897165;5585.664860108406;5727.770889164387;5883.794067207627;5915.733791979285;5923.7926672566255;5929.407059294036;5773.336066352424;5779;5781.797637082682;5787.421257874179;5790.681512516852;5598.608097433141;5603.8879222416135;5611.551075913999;5612.550995920398;5613.017721898733;3945.2109578083923;4062.3297155968935;4101;4104.486939132608;4106.3635136553885;5828.9507888580465;5830.096335068071;5836.037053886231;5837.6497410155525;5838.678872662044;5597.832065038056;5600.103983362643;5603.747831347518;5604.131359639263;5605.467480589337;5598.440155984369;5604.691741954069;5605.607607467438;5610.607257491936;5611.579131565068;5361.865953351197;5478.616496845342;5490.231367608458;5492.945070549244;5496.560275178056;5630.971845140748;5636.520895723909;5642.830715078554;5642.971785141048;5646.237757902795;5495.258140151029;5495.6153069284765;5499.230107784833;5500.834974950758;5503.889922201613 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: |5;yui.html;611;674.8177991942176;690.1859529779787;690.330379531854;700.068908351892;10748;10966.506507207176;10977.39624320662;10996;10996.450177491124;10678.092362149227;11112;11120.277181983165;11121.443927803597;11125.554977800879;626.8150895485843;635.044258391123;794.051108924835;813.1055838577577;813.7762115418249;797.7566842113154;806.1334065879204;812.5774597209447;813.308687615528;814.2020819596798;829.8298848735994;835.6699103853974;835.7534527314426;836.786619412049;836.9079401265856;649.5193556767981;655.9672016399185;820.8809722590191;837.459838404232;841.6296829395077;613.6594190224424;616.929053158888;618.2333905956626;618.523736722721;618.7710547097557;10274.845877311845;10357.482125893675;10357.948210258975;10367.792644147075;10375;9860.60557577696;10305.330153540071;10327.27709060366;10378.792424151474;10461.68614941553;8844.469331840046;8974.589476207633;8986.37095403322;9186.356955013152;9235.953820230856;3245.4807230842953;3310.2386451116377;3314.022363402802;3318.0377690469736;3390.7456940729544;37975.240495189944;38385;38397.80801096005;38453;38475;8640.26557742599;8699.739007829776;8741.213290803858;9053.230475409533;9069.319801014819;16329.91835040841;16446.75329870053;16480.09359485216;16480.752788708178;16490.670186596442;6415.935840641534;6434.131392262078;6528.37980391862;6631.801045968628;6693.196816381968;3549.290141971616;3607.2785442911522;3630.364686179908;3647.343478173901;3651.6348365163803;2749.0653177919603;2784.805063645566;2793.1062060140966;2796.454691335211;2800.8459534725785;504.2209785880823;510.75483767791667;524.666836558788;525.5847880174696;533.0405270513061;466.4053332001725;493.2921257994717;493.92838038484217;572.9054705973551;583.6556431705314;8130.227628375294;8158.592070396457;8161.795955101051;8183.345332373515;8508.574571271412;463.45312531213494;535.3789604059273;560.9831705048855;584.8830233953227;610.0513701194596;3645.143391303042;3666.871659491905;3682.8895133146048;3758.0604848787802;3779.4315359126203;48256.27615585769;48684.513154868;48770.512294877306;48944.26583601249;48963;42822;42892.57107428948;43517.34723979143;43647.56352436435;43683.78158109189;40785.79607101945;41008.38487422691;41181.79409102995;41359;41418.37872431916;7745.380369570308;7815.726449574237;7841.932334590452;7929.682812687428;8024.679012839421;32150.35699286048;32487.837560812044;32917.67082329242;33089.66910330866;33760;39688.451405517764;40196.799016004734;40444.59555404526;40813.1837363257;40890.591094088675;10075.445850478294;10085.797418616854;10279.229057820843;10370.896291036994;10396;11455;11512.30926144434;11677.76644467123;11686.18196726221;11725.296482211095;10417.270791044553;10589.205809564159;10869;11215;11245.493952772309;10851.240413171003;10908.94545527299;11189.664310070712;11289;11304.321740695585;10797.730056748644;10856.945715271373;10874.130069594572;11107.05590024857;11147.386893720923;9070.274378049871;9143.771405714644;9266.397684150508;9296.814063718553;9445.811083778148;9028.638854446011;9186.173244408035;9289.117533834275;9361.625534978797;9484.668036618685 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309287046__endTimestamp 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4660.01 Median:4796.54 stddev:487.83 (10.2%) stddev-sans-first:463.19 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: Values: 2651.7 2726.6 2730.8 2750.9 2754.5 4559.1 4716.0 4722.3 4726.3 4744.5 4600.0 4621.8 4685.5 4698.7 4704.1 4327.2 4413.6 4417.3 4424.0 4450.3 4155.0 4434.4 4455.6 4476.0 4485.1 4243.4 4313.8 4335.7 4341.8 4344.1 4391.5 4393.2 4398.0 4400.3 4438.0 4374.8 4377.8 4378.4 4420.1 4430.9 4432.4 4515.9 4581.5 4585.8 4617.0 5027.9 5064.3 5073.9 5074.4 5127.6 5100.3 5106.8 5109.1 5112.0 5112.4 4537.6 4630.1 4641.3 4650.5 4735.7 5222.3 5275.3 5279.4 5280.7 5329.2 5051.2 5065.9 5068.5 5072.3 5130.7 4761.3 4879.3 4885.5 4969.5 5060.7 4987.5 4995.9 5001.8 5008.9 5061.5 4968.7 4976.6 4977.0 4980.7 5027.8 4073.1 4141.9 4176.2 4177.9 4180.8 3627.0 3713.6 3735.9 3738.4 3740.5 4267.3 4332.4 4332.7 4353.0 4372.1 5045.3 5078.6 5079.7 5092.3 5098.4 4119.1 4218.3 4224.6 4349.3 4377.3 4443.5 4531.2 4539.2 4561.5 4580.6 4837.1 4840.7 4859.4 4862.6 4909.8 4804.9 4881.3 5083.7 5103.9 5158.5 4716.9 4756.1 4844.0 4846.2 4858.7 5032.7 5042.7 5044.7 5052.7 5081.2 4765.7 4892.1 5113.7 5119.2 5125.0 4779.8 4831.9 4896.5 4896.9 4899.9 4910.3 4939.5 4943.0 4946.6 4987.0 4660.9 4779.8 4846.2 4848.6 4866.2 4853.7 4859.1 4911.2 4921.0 4967.3 4796.5 4825.5 4856.2 4867.8 4907.4 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41288.43 Median:18868.54 stddev:61015.65 (323.4%) stddev-sans-first:61110.19 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: Values: 562.7 582.3 586.0 587.2 592.4 28563.7 38195.0 38841.8 38937.8 38939.4 41482.2 42013.6 42034.4 42049.0 42115.4 7036.0 7165.7 8071.7 8252.2 8256.0 10326.6 10607.1 10607.8 10615.8 10624.2 10281.2 10362.9 10381.6 10394.1 10418.4 7180.6 7379.2 10054.2 10190.6 10407.9 10134.8 10259.9 10267.9 10276.1 10279.5 38741.0 39313.8 39330.8 39357.8 39359.8 2770.6 2914.8 2930.8 3172.0 3468.0 29035.4 29149.9 29220.3 29244.9 29831.7 3389.4 3461.6 3474.3 3536.4 3609.8 229796.0 231538.0 231947.0 232282.0 232464.0 50944.5 52717.2 59832.7 65118.7 66956.0 58268.4 58293.0 58557.4 58570.8 58623.4 13031.6 13160.3 13180.7 13191.8 13203.3 10504.7 10548.7 10606.4 10606.5 10614.2 19358.4 19871.8 19939.4 20004.6 20168.6 7530.3 7695.8 7839.5 7854.6 7886.7 719.0 759.6 777.3 790.0 923.1 26385.6 26508.3 26615.6 27579.9 29662.9 909.5 935.3 995.6 1061.1 1089.0 13043.3 13075.9 13321.2 13330.0 13351.6 215688.0 220990.0 220999.0 221053.0 221431.0 43486.6 43785.1 47810.3 47819.5 47837.8 1034.5 1183.4 1186.3 1192.1 1221.1 21044.9 26543.3 28043.2 28293.2 28370.7 45144.3 45625.3 45625.8 45636.5 45659.0 237440.0 239921.0 248033.0 267477.0 270219.0 27532.3 27545.3 27569.0 27923.7 27945.6 36744.8 40000.6 40384.6 40587.2 41039.4 34347.7 34348.0 35207.0 35370.1 35764.6 34998.5 40578.2 42230.4 42400.6 43458.8 37617.2 37736.8 38221.8 38256.4 38935.6 37447.0 37679.6 38232.2 38305.0 38456.4 29584.0 29875.1 29933.7 29946.0 30151.2 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,058 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27258.62 Median:22133.19 stddev:86402.67 (390.4%) stddev-sans-first:86621.40 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: Values: 337.6 338.4 338.9 339.0 343.2 12011.0 12373.9 14921.3 15098.6 16217.6 11652.3 11928.7 13369.9 15560.3 15606.2 4316.7 4518.3 4523.7 4525.7 4530.2 3371.7 3463.0 4435.6 4440.0 4470.0 4992.6 5132.5 5145.9 5147.2 5149.4 5127.6 5132.0 5140.9 5257.6 5601.6 5029.5 5036.1 5060.1 5068.2 5071.6 12033.0 12953.8 17719.5 19440.1 19442.0 1862.6 1881.8 1909.8 1945.9 2010.5 9190.4 12310.1 12423.1 12652.5 12951.7 1729.1 1766.8 1778.1 1785.3 1819.4 52090.7 54342.2 54861.7 55294.0 56376.7 9597.4 9795.4 9804.3 9871.1 9879.5 12431.3 12486.4 12503.2 12508.4 12537.3 7135.9 7151.6 7157.7 7175.4 7202.6 6867.0 6886.1 6906.1 6919.6 6923.8 4103.2 4158.4 4159.6 4161.4 4187.3 1605.6 1673.2 1701.0 1732.5 1738.6 723.9 874.7 877.6 948.1 991.8 14967.9 15013.8 15646.1 15701.4 16006.5 727.9 799.3 832.2 893.2 901.7 8583.0 8631.9 8642.0 8763.5 8922.2 516341.0 517092.0 525264.0 543086.0 546444.0 66956.0 68130.7 68971.7 69347.3 69708.0 1030.9 1044.6 1097.4 1108.2 1108.4 13391.7 13727.7 14005.4 14087.0 14272.4 28941.9 29090.0 29380.6 32404.7 33058.8 39705.6 39936.4 40163.2 41389.6 42326.0 8959.7 9078.0 9123.9 9172.0 12919.0 16473.3 16815.0 16900.5 17109.7 17185.5 13511.3 14163.9 14617.1 14689.4 14773.4 8954.4 9255.5 9315.9 9454.6 14218.7 9463.5 9575.9 9671.2 9682.1 9696.5 13987.4 14093.8 14124.3 14437.5 14445.9 14684.9 14720.3 15045.0 15245.1 15271.7 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4759.28 Median:5969.93 stddev:2346.87 (39.3%) stddev-sans-first:2339.57 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: Values: 1362.7 1372.3 1415.3 1444.7 1564.8 5851.4 6688.1 6876.8 6880.6 6905.9 6780.1 6881.8 6883.7 6892.3 6893.1 2087.9 2103.9 2105.3 2109.3 2109.9 1963.7 2079.7 2098.4 2139.1 2146.3 2054.7 2068.1 2078.5 2079.1 2079.3 2055.4 2061.8 2065.4 2065.5 2067.3 2072.7 2082.6 2099.3 2101.0 2104.8 5810.7 5980.6 6839.5 6868.5 6885.9 3981.4 4076.4 4079.2 4081.1 4089.5 2741.3 2778.4 2820.4 2822.3 2880.8 901.3 915.4 952.1 965.4 1730.9 8157.6 8160.0 8198.6 8199.4 8223.0 3770.9 3847.0 3851.6 3855.4 3956.6 7520.6 7567.9 7569.2 7570.5 7579.5 4175.4 4201.8 4203.5 4204.2 4207.4 3814.4 3849.0 3867.1 3877.6 3880.2 3175.4 3202.6 3206.1 3225.5 3234.6 974.3 977.0 980.0 983.5 986.3 868.7 913.7 1166.3 1175.5 1187.0 6337.7 6393.9 6395.7 6403.1 6408.0 1007.7 1024.7 1031.9 1032.3 1066.7 4697.9 5078.8 5111.8 5124.0 5124.7 7266.9 7581.9 7720.0 7785.8 7876.1 7691.2 7736.9 7752.3 7766.4 7781.8 6414.5 6513.9 6550.2 6557.4 6561.4 6571.0 6610.6 6612.1 6613.8 6617.5 7296.4 7428.4 7528.8 7530.2 7541.2 7525.7 7682.7 7804.1 7814.6 7834.7 5830.3 5867.8 5885.8 5949.7 5962.8 6543.7 6564.9 6579.3 6606.4 6609.6 6133.3 6189.8 6252.5 6378.1 6379.6 5964.2 6011.0 6040.2 6172.0 6267.4 6071.4 6120.4 6133.6 6135.2 6137.0 5574.2 5588.1 5599.6 5604.3 5604.8 5823.0 5893.9 5926.8 5947.2 5975.7 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,060 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4685.15 Median:5318.02 stddev:1368.22 (25.7%) stddev-sans-first:1332.11 12:08:07 INFO - 2015-11-23 12:08:07,061 DEBUG : BROWSER_OUTPUT: Values: 312.1 317.0 323.0 325.2 327.2 5277.6 5368.8 5372.1 5383.9 5390.8 5296.0 5306.0 5315.8 5320.2 5323.1 3959.0 4043.2 4097.3 4197.3 4199.9 4064.8 4088.3 4090.9 4103.5 4171.3 4101.3 4122.8 4134.4 4135.8 4137.8 3948.6 4110.7 4114.8 4146.2 4168.7 3584.6 3595.4 3655.5 3695.7 3705.8 5058.3 5067.6 5079.9 5087.5 5107.1 4793.6 4801.1 4804.7 4805.2 4807.3 5498.8 5573.0 5601.7 5612.3 5614.9 4023.9 4024.9 4029.3 4030.4 4031.1 5865.6 5872.0 5888.1 5888.7 5888.8 4155.1 4160.0 4162.1 4162.2 4163.3 4221.0 4221.5 4230.3 4231.3 4235.4 4540.2 4680.1 4741.2 4745.1 4745.3 5633.8 5636.5 5658.0 5660.2 5660.3 1438.0 1463.9 1464.5 1464.6 1466.7 986.5 991.6 992.5 1010.9 1011.3 4971.0 4974.3 4977.1 4980.9 4981.1 5852.4 5853.7 5854.3 5862.8 5863.4 4971.7 4977.9 4978.9 4980.0 4982.0 3031.5 3097.0 3127.5 3143.1 3162.2 5423.7 5477.6 5517.6 5518.2 5587.1 6032.2 6056.8 6057.4 6065.0 6069.6 5576.0 5577.7 5579.3 5579.3 5585.7 5727.8 5883.8 5915.7 5923.8 5929.4 5773.3 5779.0 5781.8 5787.4 5790.7 5598.6 5603.9 5611.6 5612.6 5613.0 3945.2 4062.3 4101.0 4104.5 4106.4 5829.0 5830.1 5836.0 5837.6 5838.7 5597.8 5600.1 5603.7 5604.1 5605.5 5598.4 5604.7 5605.6 5610.6 5611.6 5361.9 5478.6 5490.2 5492.9 5496.6 5631.0 5636.5 5642.8 5643.0 5646.2 5495.3 5495.6 5499.2 5500.8 5503.9 12:08:07 INFO - 2015-11-23 12:08:07,062 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,062 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12142.09 Median:43204.96 stddev:13680.06 (31.7%) stddev-sans-first:13691.03 12:08:07 INFO - 2015-11-23 12:08:07,063 DEBUG : BROWSER_OUTPUT: Values: 611.0 674.8 690.2 690.3 700.1 10748.0 10966.5 10977.4 10996.0 10996.5 10678.1 11112.0 11120.3 11121.4 11125.6 626.8 635.0 794.1 813.1 813.8 797.8 806.1 812.6 813.3 814.2 829.8 835.7 835.8 836.8 836.9 649.5 656.0 820.9 837.5 841.6 613.7 616.9 618.2 618.5 618.8 10274.8 10357.5 10357.9 10367.8 10375.0 9860.6 10305.3 10327.3 10378.8 10461.7 8844.5 8974.6 8986.4 9186.4 9236.0 3245.5 3310.2 3314.0 3318.0 3390.7 37975.2 38385.0 38397.8 38453.0 38475.0 8640.3 8699.7 8741.2 9053.2 9069.3 16329.9 16446.8 16480.1 16480.8 16490.7 6415.9 6434.1 6528.4 6631.8 6693.2 3549.3 3607.3 3630.4 3647.3 3651.6 2749.1 2784.8 2793.1 2796.5 2800.8 504.2 510.8 524.7 525.6 533.0 466.4 493.3 493.9 572.9 583.7 8130.2 8158.6 8161.8 8183.3 8508.6 463.5 535.4 561.0 584.9 610.1 3645.1 3666.9 3682.9 3758.1 3779.4 48256.3 48684.5 48770.5 48944.3 48963.0 42822.0 42892.6 43517.3 43647.6 43683.8 40785.8 41008.4 41181.8 41359.0 41418.4 7745.4 7815.7 7841.9 7929.7 8024.7 32150.4 32487.8 32917.7 33089.7 33760.0 39688.5 40196.8 40444.6 40813.2 40890.6 10075.4 10085.8 10279.2 10370.9 10396.0 11455.0 11512.3 11677.8 11686.2 11725.3 10417.3 10589.2 10869.0 11215.0 11245.5 10851.2 10908.9 11189.7 11289.0 11304.3 10797.7 10856.9 10874.1 11107.1 11147.4 9070.3 9143.8 9266.4 9296.8 9445.8 9028.6 9186.2 9289.1 9361.6 9484.7 12:08:07 INFO - 2015-11-23 12:08:07,063 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:08:07 INFO - 2015-11-23 12:08:07,063 DEBUG : BROWSER_OUTPUT: 12:08:07 INFO - 2015-11-23 12:08:07,811 INFO : Browser exited with error code: 0 12:08:07 INFO - 2015-11-23 12:08:07,830 INFO : Completed test dromaeo_css (00:18:38) 12:08:07 INFO - 2015-11-23 12:08:07,830 INFO : Starting test kraken 12:08:07 INFO - 2015-11-23 12:08:07,830 DEBUG : operating with platform_type : linux_ 12:08:07 INFO - 2015-11-23 12:08:07,830 INFO : Initialising browser for kraken test... 12:08:07 INFO - 2015-11-23 12:08:07,836 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTrKnKw/profile http://localhost:44358/getInfo.html 12:08:12 INFO - 2015-11-23 12:08:12,136 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:08:12 INFO - 2015-11-23 12:08:12,136 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:08:12 INFO - 2015-11-23 12:08:12,136 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:08:12 INFO - 2015-11-23 12:08:12,136 DEBUG : BROWSER_OUTPUT: __metrics 12:08:12 INFO - 2015-11-23 12:08:12,265 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:13 INFO - 2015-11-23 12:08:13,506 INFO : Browser initialized. 12:08:13 INFO - 2015-11-23 12:08:13,507 INFO : Running cycle 1/1 for kraken test... 12:08:13 INFO - 2015-11-23 12:08:13,507 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTrKnKw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:08:25 INFO - 2015-11-23 12:08:25,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 140025856 12:08:25 INFO - 2015-11-23 12:08:25,400 DEBUG : BROWSER_OUTPUT: 12:08:27 INFO - 2015-11-23 12:08:27,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:28 INFO - 2015-11-23 12:08:28,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 178008064 12:08:28 INFO - 2015-11-23 12:08:28,573 DEBUG : BROWSER_OUTPUT: 12:08:31 INFO - 2015-11-23 12:08:31,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-dft) 12:08:31 INFO - 2015-11-23 12:08:31,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 168566784 12:08:31 INFO - 2015-11-23 12:08:31,883 DEBUG : BROWSER_OUTPUT: 12:08:34 INFO - 2015-11-23 12:08:34,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-fft) 12:08:35 INFO - 2015-11-23 12:08:35,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 150294528 12:08:35 INFO - 2015-11-23 12:08:35,461 DEBUG : BROWSER_OUTPUT: 12:08:37 INFO - 2015-11-23 12:08:37,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-oscillator) 12:08:38 INFO - 2015-11-23 12:08:38,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 154857472 12:08:38 INFO - 2015-11-23 12:08:38,040 DEBUG : BROWSER_OUTPUT: 12:08:40 INFO - 2015-11-23 12:08:40,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:40 INFO - 2015-11-23 12:08:40,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 156659712 12:08:40 INFO - 2015-11-23 12:08:40,801 DEBUG : BROWSER_OUTPUT: 12:08:43 INFO - 2015-11-23 12:08:43,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:44 INFO - 2015-11-23 12:08:44,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 155095040 12:08:44 INFO - 2015-11-23 12:08:44,389 DEBUG : BROWSER_OUTPUT: 12:08:47 INFO - 2015-11-23 12:08:47,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:48 INFO - 2015-11-23 12:08:48,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 157224960 12:08:48 INFO - 2015-11-23 12:08:48,415 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44358/tests/kraken/driver.html?testName=json-parse-financial) 12:08:51 INFO - 2015-11-23 12:08:51,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 155480064 12:08:51 INFO - 2015-11-23 12:08:51,828 DEBUG : BROWSER_OUTPUT: 12:08:53 INFO - 2015-11-23 12:08:53,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:54 INFO - 2015-11-23 12:08:54,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 164556800 12:08:54 INFO - 2015-11-23 12:08:54,113 DEBUG : BROWSER_OUTPUT: 12:08:56 INFO - 2015-11-23 12:08:56,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:56 INFO - 2015-11-23 12:08:56,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 165879808 12:08:56 INFO - 2015-11-23 12:08:56,589 DEBUG : BROWSER_OUTPUT: 12:08:58 INFO - 2015-11-23 12:08:58,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:59 INFO - 2015-11-23 12:08:59,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 174616576 12:08:59 INFO - 2015-11-23 12:08:59,328 DEBUG : BROWSER_OUTPUT: 12:09:01 INFO - 2015-11-23 12:09:01,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:02 INFO - 2015-11-23 12:09:02,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 180334592 12:09:02 INFO - 2015-11-23 12:09:02,445 DEBUG : BROWSER_OUTPUT: 12:09:05 INFO - 2015-11-23 12:09:05,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:05 INFO - 2015-11-23 12:09:05,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 178978816 12:09:05 INFO - 2015-11-23 12:09:05,657 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44358/tests/kraken/driver.html?testName=ai-astar) 12:09:07 INFO - 2015-11-23 12:09:07,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 237510656 12:09:07 INFO - 2015-11-23 12:09:07,637 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,641 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:07 INFO - 2015-11-23 12:09:07,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:07 INFO - 2015-11-23 12:09:07,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:07 INFO - 2015-11-23 12:09:07,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;112;113;112;102;113;116;112 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;131;153;162;132;154;167;132;170;131 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;162;161;160;162;161;161;162 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;91;73;72;73;112;88;72 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;130;90;90;91;132;91;91;131 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;110;110;110;111;110;110;110;110 12:09:07 INFO - 2015-11-23 12:09:07,642 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;148;146;147;147;146;147 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;95;96;95;95 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;69;69;69;70;69;77;66;67 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;69;69;68;69;70;70;70 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;81;94;84;83;87;93;91 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;130;120;117;131;121;127;117;120;123 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;143;146;147;153;139;152;144;148;137 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;69;67;67;67;71;67;69;71 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309347638__endTimestamp 12:09:07 INFO - 2015-11-23 12:09:07,643 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:4.04 (3.6%) stddev-sans-first:4.27 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 112.0 113.0 112.0 102.0 113.0 116.0 112.0 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.50 stddev:15.66 (10.2%) stddev-sans-first:16.55 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: Values: 152.0 131.0 153.0 162.0 132.0 154.0 167.0 132.0 170.0 131.0 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,645 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 12:09:07 INFO - 2015-11-23 12:09:07,646 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 162.0 161.0 160.0 162.0 161.0 161.0 162.0 12:09:07 INFO - 2015-11-23 12:09:07,646 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,646 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:13.38 (18.3%) stddev-sans-first:13.89 12:09:07 INFO - 2015-11-23 12:09:07,646 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 91.0 73.0 72.0 73.0 112.0 88.0 72.0 12:09:07 INFO - 2015-11-23 12:09:07,646 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.00 stddev:19.47 (21.4%) stddev-sans-first:20.18 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 130.0 90.0 90.0 91.0 132.0 91.0 91.0 131.0 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,647 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.40 Median:69.00 stddev:2.91 (4.2%) stddev-sans-first:3.09 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 69.0 77.0 66.0 67.0 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 69.0 69.0 68.0 69.0 70.0 70.0 70.0 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:5.02 (5.9%) stddev-sans-first:5.00 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 81.0 94.0 84.0 83.0 87.0 93.0 91.0 12:09:07 INFO - 2015-11-23 12:09:07,648 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.00 stddev:5.01 (4.1%) stddev-sans-first:5.28 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: Values: 121.0 130.0 120.0 117.0 131.0 121.0 127.0 117.0 120.0 123.0 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:147.50 stddev:5.59 (3.8%) stddev-sans-first:5.36 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: Values: 153.0 143.0 146.0 147.0 153.0 139.0 152.0 144.0 148.0 137.0 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: 12:09:07 INFO - 2015-11-23 12:09:07,649 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 12:09:07 INFO - 2015-11-23 12:09:07,650 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 67.0 67.0 67.0 71.0 67.0 69.0 71.0 12:09:07 INFO - 2015-11-23 12:09:07,650 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:07 INFO - 2015-11-23 12:09:07,650 DEBUG : BROWSER_OUTPUT: 12:09:08 INFO - 2015-11-23 12:09:08,551 INFO : Browser exited with error code: 0 12:09:08 INFO - 2015-11-23 12:09:08,604 INFO : Completed test kraken (00:01:00) 12:09:08 INFO - 2015-11-23 12:09:08,604 INFO : Starting test v8_7 12:09:08 INFO - 2015-11-23 12:09:08,605 DEBUG : operating with platform_type : linux_ 12:09:08 INFO - 2015-11-23 12:09:08,605 INFO : Initialising browser for v8_7 test... 12:09:08 INFO - 2015-11-23 12:09:08,611 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Da8WF/profile http://localhost:44358/getInfo.html 12:09:12 INFO - 2015-11-23 12:09:12,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:12 INFO - 2015-11-23 12:09:12,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:12 INFO - 2015-11-23 12:09:12,761 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:09:12 INFO - 2015-11-23 12:09:12,761 DEBUG : BROWSER_OUTPUT: __metrics 12:09:12 INFO - 2015-11-23 12:09:12,958 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:14 INFO - 2015-11-23 12:09:14,231 INFO : Browser initialized. 12:09:14 INFO - 2015-11-23 12:09:14,231 INFO : Running cycle 1/1 for v8_7 test... 12:09:14 INFO - 2015-11-23 12:09:14,232 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Da8WF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:26 INFO - 2015-11-23 12:09:26,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 12:09:26 INFO - 2015-11-23 12:09:26,179 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44358/tests/v8_7/run.html (next: http://localhost:44358/tests/v8_7/run.html) 12:09:47 INFO - 2015-11-23 12:09:47,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 502013952 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |0;Richards;164.85328058028355 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.49751053236307 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |6;Boyer;11686.046511627907 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |8;Splay;619.9628022318661 12:09:47 INFO - 2015-11-23 12:09:47,856 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309387850__endTimestamp 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.85 Median:164.85 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: Values: 164.9 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,857 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.50 Median:191.50 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: Values: 191.5 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: Values: 279.4 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: Values: 5050.5 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: Values: 1998.0 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,858 DEBUG : BROWSER_OUTPUT: Values: 791.1 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11686.05 Median:11686.05 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: Values: 11686.0 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: Values: 26736.8 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: Values: 620.0 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: Values: 4835.7 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:47 INFO - 2015-11-23 12:09:47,859 DEBUG : BROWSER_OUTPUT: 12:09:48 INFO - 2015-11-23 12:09:48,755 INFO : Browser exited with error code: 0 12:09:48 INFO - 2015-11-23 12:09:48,772 INFO : Completed test v8_7 (00:00:40) 12:09:48 INFO - 2015-11-23 12:09:48,886 INFO : Completed test suite (00:20:19) 12:09:48 INFO - 2015-11-23 12:09:48,886 DEBUG : Working with test: dromaeo_css 12:09:48 INFO - 2015-11-23 12:09:48,886 DEBUG : Generating results file: dromaeo_css 12:09:48 INFO - 2015-11-23 12:09:48,887 DEBUG : Working with test: kraken 12:09:48 INFO - 2015-11-23 12:09:48,887 DEBUG : Generating results file: kraken 12:09:48 INFO - 2015-11-23 12:09:48,888 INFO : javascript benchmark 12:09:48 INFO - 2015-11-23 12:09:48,888 DEBUG : Working with test: v8_7 12:09:48 INFO - 2015-11-23 12:09:48,888 DEBUG : Generating results file: v8_7 12:09:48 INFO - 2015-11-23 12:09:48,888 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:09:48 INFO - 2015-11-23 12:09:48,974 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:09:48 INFO - 2015-11-23 12:09:48,974 DEBUG : process_Request line: dromaeo_css 6337.72 graph.html#tests=[[72,132,35]] 12:09:48 INFO - 2015-11-23 12:09:48,974 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:09:49 INFO - 2015-11-23 12:09:49,011 DEBUG : process_Request line: kraken 1517.60 graph.html#tests=[[232,132,35]] 12:09:49 INFO - 2015-11-23 12:09:49,011 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:09:49 INFO - 2015-11-23 12:09:49,048 DEBUG : process_Request line: v8_7 19836.16 graph.html#tests=[[230,132,35]] 12:09:49 INFO - 2015-11-23 12:09:49,049 INFO : javascript benchmark 12:09:49 INFO - 2015-11-23 12:09:49,053 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2651.7348265173487, 2726.6046423268626, 2730.7678847298002, 2750.931226719333, 2754.5454999925014, 4559.065391594723, 4716.0, 4722.315264286681, 4726.267428548576, 4744.525547445253, 4600.0, 4621.792019359128, 4685.531446855312, 4698.718076915387, 4704.059188162364, 4327.22110020197, 4413.646908247349, 4417.337399390085, 4423.955760442403, 4450.287953927373, 4155.044339801847, 4434.445694288214, 4455.576720211575, 4476.03765190484, 4485.102979404116, 4243.427137336451, 4313.762743049131, 4335.6965012449145, 4341.761203133827, 4344.087741574273, 4391.4730232372, 4393.187260356813, 4398.032432864765, 4400.317950717644, 4438.023634800339, 4374.846880359204, 4377.824887004516, 4378.43080399546, 4420.093880754438, 4430.911381772346, 4432.445944256968, 4515.909681806345, 4581.473130589991, 4585.839495617637, 4617.030423611046, 5027.874303142414, 5064.3163172971545, 5073.949260507385, 5074.441811400743, 5127.6154288428515, 5100.285959965608, 5106.8212612558755, 5109.054824857376, 5112.0, 5112.386513618352, 4537.568930951555, 4630.073985202973, 4641.25739881624, 4650.488446270908, 4735.692180008288, 5222.321098257202, 5275.340582427197, 5279.392869819943, 5280.709560974184, 5329.200619907045, 5051.242313652908, 5065.8733531662, 5068.493150684976, 5072.264521644414, 5130.666506677054, 4761.285807128889, 4879.268109783561, 4885.511448855157, 4969.503049695001, 5060.746962651852, 4987.476314986874, 4995.900081998412, 5001.774920128603, 5008.924866127011, 5061.519155680205, 4968.72672003036, 4976.576990955737, 4977.0, 4980.726060066659, 5027.84916452507, 4073.0631954650003, 4141.937870931938, 4176.164767046603, 4177.937330939978, 4180.7909604519655, 3626.9818650906577, 3713.5729391119826, 3735.9252814944093, 3738.3831667775057, 3740.532433445819, 4267.253230684618, 4332.393464914914, 4332.67504937131, 4352.978235108868, 4372.0818628088455, 5045.344105266292, 5078.568321692624, 5079.6952182869145, 5092.312537807423, 5098.388193416814, 4119.134981653886, 4218.303979843292, 4224.577542245751, 4349.3475978603465, 4377.3433984901885, 4443.533428989974, 4531.161735079021, 4539.228331183706, 4561.521040290788, 4580.564846339593, 4837.129316723023, 4840.7337596432535, 4859.416869975626, 4862.562369386772, 4909.754512274372, 4804.942912559231, 4881.31661567388, 5083.72039537829, 5103.948960510347, 5158.484151584811, 4716.882077947941, 4756.096341695067, 4843.975780121218, 4846.17615005457, 4858.708477491362, 5032.6980381177245, 5042.672226305279, 5044.672096313728, 5052.671576347526, 5081.18701007837, 4765.7140571565815, 4892.094962431962, 5113.74431278442, 5119.180931051014, 5124.974375128249, 4779.808807647794, 4831.855044348676, 4896.510348965075, 4896.90206195867, 4899.877503062452, 4910.337104490991, 4939.456659767495, 4943.036107958914, 4946.554810067111, 4987.0, 4660.883477912944, 4779.808807647655, 4846.224604063333, 4848.612111031039, 4866.1727506323305, 4853.733044682576, 4859.07677541266, 4911.214205727067, 4920.950790492049, 4967.329410529676, 4796.544328288807, 4825.541573550507, 4856.150173719656, 4867.78042486592, 4907.435644900882], "unit": "ms", "name": "dojo.html", "value": 4629.888458525428}, {"lowerIsBetter": false, "replicates": [562.7270773674768, 582.2605291280074, 585.958982871199, 587.1691556447627, 592.3691268798732, 28563.714362856364, 38195.0, 38841.80579097104, 38937.8053109734, 38939.41590876132, 41482.17035659285, 42013.57986420135, 42034.369484457755, 42049.0, 42115.368269475985, 7035.964820175892, 7165.713371465135, 8071.677132914677, 8252.174782521759, 8256.0, 10326.638567650134, 10607.098396636295, 10607.84088238677, 10615.84076238857, 10624.203184761136, 10281.177505799555, 10362.948185259063, 10381.584736610526, 10394.116500097502, 10418.426986515738, 7180.6050667213285, 7379.225181355934, 10054.195664346835, 10190.643327483576, 10407.895921040845, 10134.797304053951, 10259.897401025968, 10267.897321026769, 10276.126529245023, 10279.537420816006, 38741.0, 39313.803430982945, 39330.803345983375, 39357.80321098376, 39359.8032009841, 2770.5844123381453, 2914.8396838173894, 2930.8388038657863, 3171.9682803171904, 3467.9826600866836, 29035.41929161426, 29149.854250728822, 29220.269493262625, 29244.853775731197, 29831.70168298311, 3389.4237979543536, 3461.582623194692, 3474.322507111114, 3536.381133301662, 3609.7653652512763, 229796.0, 231538.0, 231947.0, 232282.0, 232463.9999999983, 50944.49055509397, 52717.209241861405, 59832.70083649554, 65118.67440662861, 66955.96962318984, 58268.417315827144, 58293.0, 58557.4144258552, 58570.82858342809, 58623.41376586265, 13031.609051728463, 13160.276184809927, 13180.736385272241, 13191.802122968164, 13203.273819939996, 10504.737381565523, 10548.683539493828, 10606.416647084485, 10606.469676516142, 10614.150867930546, 19358.419247422316, 19871.801281986995, 19939.401817945483, 20004.59990800205, 20168.596628067357, 7530.322270995527, 7695.807604809813, 7839.45123841337, 7854.60726963661, 7886.72396466121, 718.9880466994264, 759.6315786843377, 777.3081957058223, 790.0282652337656, 923.0677016213539, 26385.604215936775, 26508.33729156748, 26615.600765988525, 27579.862100689366, 29662.851685741865, 909.5088652127777, 935.2891802230218, 995.6117114325274, 1061.0980666433625, 1089.0362029603857, 13043.347832608331, 13075.869241307655, 13321.200727956353, 13330.0, 13351.599452016455, 215688.0, 220990.0, 220999.0, 221053.0, 221431.0, 43486.565134348886, 43785.124297513874, 47810.28284575734, 47819.52180478151, 47837.76081119572, 1034.524118905312, 1183.44378142273, 1186.2645160000855, 1192.0642295797757, 1221.1146918484028, 21044.894775526023, 26543.33641658974, 28043.158705238875, 28293.15120546387, 28370.716292837635, 45144.32283515684, 45625.31562026506, 45625.77187114043, 45636.54363456456, 45659.0, 237440.0, 239921.0, 248033.0, 267477.0, 270219.0, 27532.311692207855, 27545.31136721598, 27568.96741358489, 27923.720762792924, 27945.58081628818, 36744.81627591845, 40000.59999399969, 40384.59615403926, 40587.1882562353, 41039.38440923448, 34347.656523434445, 34348.04997425328, 35207.0, 35370.11574710653, 35764.642353577176, 34998.47502287417, 40578.1884362317, 42230.366544501245, 42400.5759942409, 43458.782706087535, 37617.24765504729, 37736.811315944346, 38221.80889095537, 38256.42615360828, 38935.6106438932, 37447.0, 37679.62320376761, 38232.2353552933, 38305.0, 38456.423153652155, 29584.0, 29875.103746887627, 29933.700662993964, 29946.0, 30151.246218844706], "unit": "ms", "name": "ext.html", "value": 17804.592735772792}, {"lowerIsBetter": false, "replicates": [337.59320019376645, 338.4212995777221, 338.93560223557523, 338.9966100338999, 343.1832239270536, 12011.0, 12373.938130309358, 14921.328540215689, 15098.622534436645, 16217.594560135987, 11652.30086194829, 11928.70178245542, 13369.866301337008, 15560.299786509606, 15606.219689015532, 4316.697831151812, 4518.254488009475, 4523.728576285417, 4525.683202175849, 4530.207213737583, 3371.6965473107416, 3462.982685086571, 4435.62297204738, 4440.045390241097, 4470.0, 4992.625553083515, 5132.5124113209185, 5145.897082058375, 5147.150720131174, 5149.433562308143, 5127.589792816584, 5132.0249152661245, 5140.871478213037, 5257.579393648499, 5601.6358936668985, 5029.497050294978, 5036.06832735945, 5060.063888180698, 5068.239764035387, 5071.644984851062, 12033.0, 12953.805692914613, 17719.468415947413, 19440.125194366286, 19442.027898605156, 1862.5995410986702, 1881.7741870975433, 1909.837663798579, 1945.9027048647652, 2010.547626783962, 9190.402623829497, 12310.13829031968, 12423.130380873343, 12652.493900243979, 12951.740965180737, 1729.1008675488802, 1766.7614871992373, 1778.1464896849454, 1785.3037315446986, 1819.417786308382, 52090.73954630241, 54342.18486722702, 54861.725691371685, 55294.0, 56376.71811640915, 9597.376170548892, 9795.363301385387, 9804.264680149017, 9871.111599956039, 9879.456629885282, 12431.316277604637, 12486.438110285058, 12503.249805011728, 12508.437120329607, 12537.310447925453, 7135.892961605477, 7151.642417879085, 7157.6779044943105, 7175.354218120394, 7202.603856787927, 6867.0, 6886.139232595926, 6906.136732908387, 6919.584824910521, 6923.757668481579, 4103.179364127186, 4158.376243563429, 4159.604837540429, 4161.375793630919, 4187.309093999456, 1605.6066263765451, 1673.230314055548, 1700.9574760631083, 1732.4542769027717, 1738.6261953679766, 723.8950352198901, 874.7200895713438, 877.5831480047054, 948.0661548374845, 991.8313886639289, 14967.925160374129, 15013.849861501245, 15646.139462329453, 15701.371945122295, 16006.519804405887, 727.8653449111931, 799.2686691677167, 832.1636755061124, 893.2095095840228, 901.7024381953939, 8583.0, 8631.913680863237, 8642.0, 8763.518006509703, 8922.241609463139, 516341.0, 517092.0, 525264.0, 543086.0, 546444.0, 66956.0, 68130.65934670295, 68971.65514172397, 69347.30652693509, 69708.0, 1030.9278350515542, 1044.550843137443, 1097.3744965369822, 1108.1688733449912, 1108.3571528513444, 13391.732165356832, 13727.656808579466, 14005.369758361103, 14087.0, 14272.357743901757, 28941.85529072341, 29090.0, 29380.55929161107, 32404.675953240167, 33058.83470582632, 39705.602943971346, 39936.4009539863, 40163.1967360657, 41389.58610413857, 42326.0, 8959.73120806377, 9078.0, 9123.908760912305, 9171.991080980953, 12919.0, 16473.34106635769, 16815.0, 16900.492985210465, 17109.74335384945, 17185.484435466955, 13511.324433778469, 14163.858361416666, 14617.122972621677, 14689.41242350294, 14773.409063637335, 8954.417962832395, 9255.53722313895, 9315.906840931775, 9454.574544145667, 14218.715625687222, 9463.526823658653, 9575.856362154713, 9671.17794987434, 9682.080202380763, 9696.515174241118, 13987.370568324654, 14093.788593170906, 14124.293785310489, 14437.494687685881, 14445.85554144445, 14684.85315146835, 14720.337584808494, 15045.0, 15245.085294882343, 15271.694566108838], "unit": "ms", "name": "jquery.html", "value": 8212.27547946697}, {"lowerIsBetter": false, "replicates": [1362.7478916400464, 1372.3481346360477, 1415.327719333316, 1444.7327244459782, 1564.8435156484352, 5851.356350801414, 6688.130543029405, 6876.793696189116, 6880.621565813878, 6905.930940690591, 6780.050792888999, 6881.759138430156, 6883.724651013966, 6892.2763109873495, 6893.138357705287, 2087.8642888212294, 2103.92636257731, 2105.336818902041, 2109.2512158183854, 2109.9050542725536, 1963.6563601369703, 2079.688046792978, 2098.401955442699, 2139.12295958657, 2146.2595404585395, 2054.6609809381434, 2068.0590331399176, 2078.532330225702, 2079.095593416861, 2079.261862038977, 2055.3525639423533, 2061.783512731164, 2065.39070974063, 2065.514604068058, 2067.3281183615386, 2072.7098206251135, 2082.562661841015, 2099.3177217404404, 2100.9684854727193, 2104.8105670489576, 5810.709464526757, 5980.581359304851, 6839.452843772487, 6868.519203655746, 6885.896711549331, 3981.422693709396, 4076.429299898017, 4079.224947260011, 4081.122558649875, 4089.488813898263, 2741.3283745482286, 2778.3887544740123, 2820.4218135282217, 2822.294426393402, 2880.8271503709843, 901.33301356996, 915.382117070981, 952.0622187145656, 965.3918031640092, 1730.8874923129956, 8157.632906519221, 8160.0, 8198.590070496452, 8199.385046121564, 8222.958885205595, 3770.9057273567832, 3846.9615303846604, 3851.5763266040713, 3855.4024126260474, 3956.6043395660204, 7520.6239688015385, 7567.9243207567215, 7569.167391586921, 7570.470067095251, 7579.5073320234005, 4175.352820312856, 4201.831926722958, 4203.5376108628025, 4204.201201771653, 4207.410962465257, 3814.427835824593, 3849.0, 3867.0525721198487, 3877.5734669186368, 3880.2239552089695, 3175.412548678502, 3202.551642770014, 3206.1183174627163, 3225.5000474926424, 3234.6280177779386, 974.3228456222998, 977.0278572819948, 980.029770527173, 983.5279066048193, 986.3194395866828, 868.700298397052, 913.6665117232162, 1166.3468457663735, 1175.4710380328886, 1187.0147777344782, 6337.65142917144, 6393.9360606394275, 6395.712192951329, 6403.071554624554, 6407.967960160263, 1007.7379881230933, 1024.7438140464883, 1031.9380837149795, 1032.3289861590026, 1066.722652110457, 4697.906041879143, 5078.822241221539, 5111.821086262037, 5124.0, 5124.667586427481, 7266.854662906712, 7581.924180758122, 7719.961400193076, 7785.805354866174, 7876.0548734151125, 7691.230876912376, 7736.92263077362, 7752.341051010727, 7766.417518686121, 7781.844363112706, 6414.518911081687, 6513.869722605521, 6550.213974323112, 6557.377049180321, 6561.376669216417, 6570.967145164243, 6610.570312929644, 6612.140421745143, 6613.801585952429, 6617.536772425884, 7296.416286697157, 7428.405727541892, 7528.849423011399, 7530.209328020698, 7541.170471248268, 7525.736599219001, 7682.731104411542, 7804.141544430222, 7814.570198638902, 7834.725784597512, 5830.329512105993, 5867.765289388377, 5885.823425297248, 5949.702514874326, 5962.791302304398, 6543.70553325111, 6564.868702626016, 6579.342065793574, 6606.4384527315715, 6609.603423794588, 6133.325334213322, 6189.81430557084, 6252.531060170414, 6378.107065010995, 6379.553431259767, 5964.194833697396, 6010.9699451502465, 6040.214772079602, 6172.012478003498, 6267.373262673696, 6071.3625069368845, 6120.387961203844, 6133.601315914451, 6135.171751813448, 6136.969315153396, 5574.16387541872, 5588.050031494575, 5599.552035837041, 5604.299462567179, 5604.8318550443555, 5822.970885145547, 5893.882122357614, 5926.762929482945, 5947.197128387786, 5975.671338076448], "unit": "ms", "name": "mootools.html", "value": 3979.462161887962}, {"lowerIsBetter": false, "replicates": [312.14161057092997, 317.04411200231306, 323.009974428377, 325.2162288883791, 327.1999960097561, 5277.551408130309, 5368.785248590052, 5372.086745253311, 5383.896301258243, 5390.838274851756, 5296.020236256295, 5306.0, 5315.840524784263, 5320.201969704546, 5323.121684921993, 3959.049828041264, 4043.2115737431213, 4097.344424892018, 4197.265478541259, 4199.853005144821, 4064.796760161995, 4088.3049881520064, 4090.8568200113, 4103.548609652936, 4171.332586786115, 4101.323281658522, 4122.752634841919, 4134.400511925769, 4135.793210339486, 4137.793110344486, 3948.624880636335, 4110.732802367851, 4114.835406583748, 4146.170765846843, 4168.6665066794585, 3584.5698516177963, 3595.3708101082466, 3655.488231647545, 3695.7043436525014, 3705.7591256568235, 5058.266551350071, 5067.6452648314635, 5079.898402031976, 5087.516685914832, 5107.13178759608, 4793.5685788279225, 4801.063792560452, 4804.735739534324, 4805.231163013901, 4807.254875494304, 5498.835034948958, 5573.0, 5601.691906945116, 5612.298462692163, 5614.9438505615235, 4023.8591649292134, 4024.939625905614, 4029.3351596986463, 4030.415589739501, 4031.113155105872, 5865.618734782268, 5872.0, 5888.146218798293, 5888.676122813244, 5888.823335299905, 4155.085881106152, 4160.043190066242, 4162.105147393325, 4162.167566486714, 4163.250614889349, 4220.957790422118, 4221.514525829508, 4230.323148296257, 4231.30183519722, 4235.364695295731, 4540.160070386989, 4680.110778951988, 4741.241401375763, 4745.098431298112, 4745.311929770164, 5633.774649014075, 5636.549076073904, 5658.0381335173115, 5660.179274005246, 5660.29246344207, 1437.978430323546, 1463.8902082343866, 1464.4801095611117, 1464.61187785237, 1466.6553359960615, 986.452518852044, 991.5785791038779, 992.5483904823288, 1010.9090181883665, 1011.3072545306488, 4970.950290497049, 4974.27872958419, 4977.083822728203, 4980.90038199234, 4981.078500477423, 5852.356240813507, 5853.707314634251, 5854.326752423441, 5862.824115276463, 5863.387568418719, 4971.676841005323, 4977.925331120036, 4978.90042199154, 4979.975100124476, 4981.950180498221, 3031.5149576067724, 3097.0337849221564, 3127.5152351385573, 3143.0570828751283, 3162.177833763238, 5423.674579525241, 5477.589180811455, 5517.5585953123655, 5518.227448157261, 5587.1339942309005, 6032.1856549365275, 6056.788012419633, 6057.394260573908, 6065.0, 6069.635821850703, 5575.99632066232, 5577.665340079527, 5579.2746942897165, 5579.2746942897165, 5585.664860108406, 5727.770889164387, 5883.794067207627, 5915.733791979285, 5923.7926672566255, 5929.407059294036, 5773.336066352424, 5779.0, 5781.797637082682, 5787.421257874179, 5790.681512516852, 5598.608097433141, 5603.8879222416135, 5611.551075913999, 5612.550995920398, 5613.017721898733, 3945.2109578083923, 4062.3297155968935, 4101.0, 4104.486939132608, 4106.3635136553885, 5828.9507888580465, 5830.096335068071, 5836.037053886231, 5837.6497410155525, 5838.678872662044, 5597.832065038056, 5600.103983362643, 5603.747831347518, 5604.131359639263, 5605.467480589337, 5598.440155984369, 5604.691741954069, 5605.607607467438, 5610.607257491936, 5611.579131565068, 5361.865953351197, 5478.616496845342, 5490.231367608458, 5492.945070549244, 5496.560275178056, 5630.971845140748, 5636.520895723909, 5642.830715078554, 5642.971785141048, 5646.237757902795, 5495.258140151029, 5495.6153069284765, 5499.230107784833, 5500.834974950758, 5503.889922201613], "unit": "ms", "name": "prototype.html", "value": 4250.547318389741}, {"lowerIsBetter": false, "replicates": [611.0, 674.8177991942176, 690.1859529779787, 690.330379531854, 700.068908351892, 10748.0, 10966.506507207176, 10977.39624320662, 10996.0, 10996.450177491124, 10678.092362149227, 11112.0, 11120.277181983165, 11121.443927803597, 11125.554977800879, 626.8150895485843, 635.044258391123, 794.051108924835, 813.1055838577577, 813.7762115418249, 797.7566842113154, 806.1334065879204, 812.5774597209447, 813.308687615528, 814.2020819596798, 829.8298848735994, 835.6699103853974, 835.7534527314426, 836.786619412049, 836.9079401265856, 649.5193556767981, 655.9672016399185, 820.8809722590191, 837.459838404232, 841.6296829395077, 613.6594190224424, 616.929053158888, 618.2333905956626, 618.523736722721, 618.7710547097557, 10274.845877311845, 10357.482125893675, 10357.948210258975, 10367.792644147075, 10375.0, 9860.60557577696, 10305.330153540071, 10327.27709060366, 10378.792424151474, 10461.68614941553, 8844.469331840046, 8974.589476207633, 8986.37095403322, 9186.356955013152, 9235.953820230856, 3245.4807230842953, 3310.2386451116377, 3314.022363402802, 3318.0377690469736, 3390.7456940729544, 37975.240495189944, 38385.0, 38397.80801096005, 38453.0, 38475.0, 8640.26557742599, 8699.739007829776, 8741.213290803858, 9053.230475409533, 9069.319801014819, 16329.91835040841, 16446.75329870053, 16480.09359485216, 16480.752788708178, 16490.670186596442, 6415.935840641534, 6434.131392262078, 6528.37980391862, 6631.801045968628, 6693.196816381968, 3549.290141971616, 3607.2785442911522, 3630.364686179908, 3647.343478173901, 3651.6348365163803, 2749.0653177919603, 2784.805063645566, 2793.1062060140966, 2796.454691335211, 2800.8459534725785, 504.2209785880823, 510.75483767791667, 524.666836558788, 525.5847880174696, 533.0405270513061, 466.4053332001725, 493.2921257994717, 493.92838038484217, 572.9054705973551, 583.6556431705314, 8130.227628375294, 8158.592070396457, 8161.795955101051, 8183.345332373515, 8508.574571271412, 463.45312531213494, 535.3789604059273, 560.9831705048855, 584.8830233953227, 610.0513701194596, 3645.143391303042, 3666.871659491905, 3682.8895133146048, 3758.0604848787802, 3779.4315359126203, 48256.27615585769, 48684.513154868, 48770.512294877306, 48944.26583601249, 48963.0, 42822.0, 42892.57107428948, 43517.34723979143, 43647.56352436435, 43683.78158109189, 40785.79607101945, 41008.38487422691, 41181.79409102995, 41359.0, 41418.37872431916, 7745.380369570308, 7815.726449574237, 7841.932334590452, 7929.682812687428, 8024.679012839421, 32150.35699286048, 32487.837560812044, 32917.67082329242, 33089.66910330866, 33760.0, 39688.451405517764, 40196.799016004734, 40444.59555404526, 40813.1837363257, 40890.591094088675, 10075.445850478294, 10085.797418616854, 10279.229057820843, 10370.896291036994, 10396.0, 11455.0, 11512.30926144434, 11677.76644467123, 11686.18196726221, 11725.296482211095, 10417.270791044553, 10589.205809564159, 10869.0, 11215.0, 11245.493952772309, 10851.240413171003, 10908.94545527299, 11189.664310070712, 11289.0, 11304.321740695585, 10797.730056748644, 10856.945715271373, 10874.130069594572, 11107.05590024857, 11147.386893720923, 9070.274378049871, 9143.771405714644, 9266.397684150508, 9296.814063718553, 9445.811083778148, 9028.638854446011, 9186.173244408035, 9289.117533834275, 9361.625534978797, 9484.668036618685], "unit": "ms", "name": "yui.html", "value": 5658.697573366651}], "name": "dromaeo_css", "value": 6337.723598131035}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 112.0, 113.0, 112.0, 102.0, 113.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 153.0, 162.0, 132.0, 154.0, 167.0, 132.0, 170.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 91.0, 73.0, 72.0, 73.0, 112.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 130.0, 90.0, 90.0, 91.0, 132.0, 91.0, 91.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 77.0, 66.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 81.0, 94.0, 84.0, 83.0, 87.0, 93.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 120.0, 117.0, 131.0, 121.0, 127.0, 117.0, 120.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [153.0, 143.0, 146.0, 147.0, 153.0, 139.0, 152.0, 144.0, 148.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 67.0, 67.0, 67.0, 71.0, 67.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1517.6000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.85328058028355], "unit": "score", "name": "Richards", "value": 214.14193200000003}, {"lowerIsBetter": false, "replicates": [191.49751053236307], "unit": "score", "name": "DeltaBlue", "value": 345.26819599999993}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [11686.046511627907], "unit": "score", "name": "Boyer", "value": 57.0306646766169}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19836.162780355822}]} 12:09:49 INFO - RETURN: dromaeo_css: 6337.72 12:09:49 INFO - RETURN: kraken: 1517.60 12:09:49 INFO - RETURN: v8_7: 19836.16 12:09:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19836.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6337.72"}}} 12:09:49 INFO - Return code: 0 12:09:49 INFO - # TBPL SUCCESS # 12:09:49 INFO - Running post-action listener: _resource_record_post_action 12:09:49 INFO - Running post-run listener: _resource_record_post_run 12:09:50 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 511856640; Read time: 0; Write time: 499504 12:09:50 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 170569728; Read time: 0; Write time: 187728 12:09:50 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 337338368; Read time: 0; Write time: 311232 12:09:50 INFO - Running post-run listener: _upload_blobber_files 12:09:50 INFO - Blob upload gear active. 12:09:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:09:50 INFO - Copying logs to upload dir... 12:09:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.054380 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-23 12:09:48.735979) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:09:48.743570) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 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.009937 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.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:09:48.772206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:09:48.772637) ========= 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=e10134013339c31d8d0c4708000001d6-1448307891.262365-716296017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:09:48.826023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:09:48.826373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:09:48.826720) ========= ========= Total master_lag: 0.23 =========