builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1448308164.07 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.067537) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.068019) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.068337) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006701 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.108291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.108559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.228687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.228989) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.322245) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.322511) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.322844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.323124) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 11:49:25-- 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% 77.2M=0s 2015-11-23 11:49:25 (77.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168357 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.520740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.521121) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020775 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.580533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.580836) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 11:49:25,797 truncating revision to first 12 chars 2015-11-23 11:49:25,797 Setting DEBUG logging. 2015-11-23 11:49:25,797 attempt 1/10 2015-11-23 11:49:25,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:49:26,032 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.130277) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.130547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.237479) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.237839) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.238298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-23 11:49:25.238582) ========= /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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:26 INFO - MultiFileLogger online at 20151123 11:49:26 in /builds/slave/test 11:49:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:49:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:26 INFO - {'append_to_log': False, 11:49:26 INFO - 'base_work_dir': '/builds/slave/test', 11:49:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:49:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:26 INFO - 'branch': 'Fx-Team-Non-PGO', 11:49:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:26 INFO - 'config_files': ('talos/linux_config.py',), 11:49:26 INFO - 'default_actions': ('clobber', 11:49:26 INFO - 'read-buildbot-config', 11:49:26 INFO - 'download-and-extract', 11:49:26 INFO - 'populate-webroot', 11:49:26 INFO - 'create-virtualenv', 11:49:26 INFO - 'install', 11:49:26 INFO - 'run-tests'), 11:49:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:26 INFO - 'download_minidump_stackwalk': True, 11:49:26 INFO - 'download_symbols': 'ondemand', 11:49:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:26 INFO - 'installer_path': 'installer.exe', 11:49:26 INFO - 'log_level': 'info', 11:49:26 INFO - 'log_name': 'talos', 11:49:26 INFO - 'log_to_console': True, 11:49:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:26 INFO - 'opt_config_files': (), 11:49:26 INFO - 'pip_index': False, 11:49:26 INFO - 'sps_profile': False, 11:49:26 INFO - 'sps_profile_interval': 0, 11:49:26 INFO - 'suite': 'dromaeojs', 11:49:26 INFO - 'system_bits': '64', 11:49:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:26 INFO - 'title': 'talos-linux64-ix-061', 11:49:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:26 INFO - 'use_talos_json': True, 11:49:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:26 INFO - 'work_dir': 'build'} 11:49:26 INFO - ##### 11:49:26 INFO - ##### Running clobber step. 11:49:26 INFO - ##### 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: clobber 11:49:26 INFO - rmtree: /builds/slave/test/build 11:49:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:26 INFO - Running post-action listener: _resource_record_post_action 11:49:26 INFO - ##### 11:49:26 INFO - ##### Running read-buildbot-config step. 11:49:26 INFO - ##### 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: read_buildbot_config 11:49:26 INFO - Using buildbot properties: 11:49:26 INFO - { 11:49:26 INFO - "properties": { 11:49:26 INFO - "buildnumber": 1119, 11:49:26 INFO - "product": "firefox", 11:49:26 INFO - "script_repo_revision": "production", 11:49:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:49:26 INFO - "repository": "", 11:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:49:26 INFO - "buildid": "20151123050554", 11:49:26 INFO - "slavename": "talos-linux64-ix-061", 11:49:26 INFO - "pgo_build": "False", 11:49:26 INFO - "basedir": "/builds/slave/test", 11:49:26 INFO - "project": "", 11:49:26 INFO - "platform": "ubuntu64_hw", 11:49:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:49:26 INFO - "slavebuilddir": "test", 11:49:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:49:26 INFO - "branch": "fx-team", 11:49:26 INFO - "repo_path": "integration/fx-team", 11:49:26 INFO - "stage_platform": "linux64", 11:49:26 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - }, 11:49:26 INFO - "sourcestamp": { 11:49:26 INFO - "repository": "", 11:49:26 INFO - "hasPatch": false, 11:49:26 INFO - "project": "", 11:49:26 INFO - "branch": "fx-team-linux64-talos", 11:49:26 INFO - "changes": [ 11:49:26 INFO - { 11:49:26 INFO - "category": null, 11:49:26 INFO - "files": [ 11:49:26 INFO - { 11:49:26 INFO - "url": null, 11:49:26 INFO - "name": "https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:49:26 INFO - } 11:49:26 INFO - ], 11:49:26 INFO - "repository": "", 11:49:26 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:49:26 INFO - "who": "pbrosset@mozilla.com", 11:49:26 INFO - "when": 1448285946, 11:49:26 INFO - "number": 6694867, 11:49:26 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:49:26 INFO - "project": "", 11:49:26 INFO - "at": "Mon 23 Nov 2015 05:39:06", 11:49:26 INFO - "branch": "fx-team-linux64-talos", 11:49:26 INFO - "revlink": "", 11:49:26 INFO - "properties": [ 11:49:26 INFO - [ 11:49:26 INFO - "buildid", 11:49:26 INFO - "20151123050554", 11:49:26 INFO - "Change" 11:49:26 INFO - ], 11:49:26 INFO - [ 11:49:26 INFO - "builduid", 11:49:26 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:26 INFO - "Change" 11:49:26 INFO - ], 11:49:26 INFO - [ 11:49:26 INFO - "pgo_build", 11:49:26 INFO - "False", 11:49:26 INFO - "Change" 11:49:26 INFO - ] 11:49:26 INFO - ], 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - } 11:49:26 INFO - ], 11:49:26 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:26 INFO - } 11:49:26 INFO - } 11:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:49:26 INFO - Running post-action listener: _resource_record_post_action 11:49:26 INFO - ##### 11:49:26 INFO - ##### Running download-and-extract step. 11:49:26 INFO - ##### 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: download_and_extract 11:49:26 INFO - mkdir: /builds/slave/test/build/tests 11:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:26 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:49:28 INFO - Downloaded 1302 bytes. 11:49:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:49:28 INFO - Using the following test package requirements: 11:49:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'jsshell-linux-x86_64.zip'], 11:49:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:28 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:29 INFO - Downloaded 21339409 bytes. 11:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:49:30 INFO - Return code: 0 11:49:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:49:30 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:30 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:32 INFO - Downloaded 21339409 bytes. 11:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:49:33 INFO - Return code: 0 11:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:33 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:49:34 INFO - Downloaded 11130997 bytes. 11:49:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:49:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:49:34 INFO - Return code: 0 11:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:34 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:49:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:49:36 INFO - Downloaded 55911868 bytes. 11:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:36 INFO - mkdir: /builds/slave/test/properties 11:49:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:36 INFO - Contents: 11:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:36 INFO - Running post-action listener: _resource_record_post_action 11:49:36 INFO - Running post-action listener: set_extra_try_arguments 11:49:36 INFO - ##### 11:49:36 INFO - ##### Running populate-webroot step. 11:49:36 INFO - ##### 11:49:36 INFO - Running pre-action listener: _resource_record_pre_action 11:49:36 INFO - Running main action method: populate_webroot 11:49:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:36 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:49:36 INFO - '../fennec_ids.txt'], 11:49:36 INFO - 'tests': ['tcheck2']}, 11:49:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:36 INFO - '--tppagecycles', 11:49:36 INFO - '7'], 11:49:36 INFO - 'tests': ['tsvgm']}}, 11:49:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:49:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['damp', 'tps']}, 11:49:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['damp', 'tps']}, 11:49:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:49:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:36 INFO - 'other': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'other_l64': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'other_nol64': {'tests': ['a11yr', 11:49:36 INFO - 'ts_paint', 11:49:36 INFO - 'tpaint', 11:49:36 INFO - 'sessionrestore', 11:49:36 INFO - 'sessionrestore_no_auto_restore']}, 11:49:36 INFO - 'svgr': {'tests': ['tsvgx', 11:49:36 INFO - 'tsvgr_opacity', 11:49:36 INFO - 'tart', 11:49:36 INFO - 'tscrollx', 11:49:36 INFO - 'cart']}, 11:49:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['tsvgx', 11:49:36 INFO - 'tsvgr_opacity', 11:49:36 INFO - 'tart', 11:49:36 INFO - 'tscrollx', 11:49:36 INFO - 'cart']}, 11:49:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'tests': ['tp5o']}, 11:49:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--e10s'], 11:49:36 INFO - 'tests': ['tp5o']}, 11:49:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--xperf_path', 11:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:36 INFO - 'tests': ['tp5n']}, 11:49:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:36 INFO - 'talos_options': ['--e10s', 11:49:36 INFO - '--xperf_path', 11:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:36 INFO - 'tests': ['tp5n']}}, 11:49:36 INFO - 'talos.zip': {'path': '', 11:49:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:36 INFO - Running post-action listener: _resource_record_post_action 11:49:36 INFO - ##### 11:49:36 INFO - ##### Running create-virtualenv step. 11:49:36 INFO - ##### 11:49:36 INFO - Running pre-action listener: _resource_record_pre_action 11:49:36 INFO - Running main action method: create_virtualenv 11:49:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:49:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:36 INFO - Using real prefix '/usr' 11:49:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:39 INFO - Installing pip.................done. 11:49:39 INFO - Return code: 0 11:49:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:39 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:49:39 INFO - Using env: {'DISPLAY': ':0', 11:49:39 INFO - 'HOME': '/home/cltbld', 11:49:39 INFO - 'LANG': 'en_US.UTF-8', 11:49:39 INFO - 'LANGUAGE': 'en_US:en', 11:49:39 INFO - 'LOGNAME': 'cltbld', 11:49:39 INFO - 'MAIL': '/var/mail/cltbld', 11:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:39 INFO - 'MOZ_NO_REMOTE': '1', 11:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:39 INFO - 'NO_EM_RESTART': '1', 11:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:39 INFO - 'PWD': '/builds/slave/test', 11:49:39 INFO - 'SHELL': '/bin/bash', 11:49:39 INFO - 'SHLVL': '1', 11:49:39 INFO - 'TERM': 'linux', 11:49:39 INFO - 'TMOUT': '86400', 11:49:39 INFO - 'USER': 'cltbld', 11:49:39 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:39 INFO - '_': '/tools/buildbot/bin/python'} 11:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:49:39 INFO - Cleaning up... 11:49:39 INFO - Return code: 0 11:49:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:39 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:49:39 INFO - Using env: {'DISPLAY': ':0', 11:49:39 INFO - 'HOME': '/home/cltbld', 11:49:39 INFO - 'LANG': 'en_US.UTF-8', 11:49:39 INFO - 'LANGUAGE': 'en_US:en', 11:49:39 INFO - 'LOGNAME': 'cltbld', 11:49:39 INFO - 'MAIL': '/var/mail/cltbld', 11:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:39 INFO - 'MOZ_NO_REMOTE': '1', 11:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:39 INFO - 'NO_EM_RESTART': '1', 11:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:39 INFO - 'PWD': '/builds/slave/test', 11:49:39 INFO - 'SHELL': '/bin/bash', 11:49:39 INFO - 'SHLVL': '1', 11:49:39 INFO - 'TERM': 'linux', 11:49:39 INFO - 'TMOUT': '86400', 11:49:39 INFO - 'USER': 'cltbld', 11:49:39 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:39 INFO - '_': '/tools/buildbot/bin/python'} 11:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:39 INFO - Downloading/unpacking psutil>=0.7.1 11:49:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:39 INFO - 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:39 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:39 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:39 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:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:49:41 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:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:41 INFO - Installing collected packages: psutil 11:49:41 INFO - Running setup.py install for psutil 11:49:41 INFO - building 'psutil._psutil_linux' extension 11:49:41 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:41 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:41 INFO - building 'psutil._psutil_posix' extension 11:49:41 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:41 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:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:41 INFO - Successfully installed psutil 11:49:41 INFO - Cleaning up... 11:49:41 INFO - Return code: 0 11:49:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:41 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 11:49:41 INFO - 'HOME': '/home/cltbld', 11:49:41 INFO - 'LANG': 'en_US.UTF-8', 11:49:41 INFO - 'LANGUAGE': 'en_US:en', 11:49:41 INFO - 'LOGNAME': 'cltbld', 11:49:41 INFO - 'MAIL': '/var/mail/cltbld', 11:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:41 INFO - 'MOZ_NO_REMOTE': '1', 11:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:41 INFO - 'NO_EM_RESTART': '1', 11:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:41 INFO - 'PWD': '/builds/slave/test', 11:49:41 INFO - 'SHELL': '/bin/bash', 11:49:41 INFO - 'SHLVL': '1', 11:49:41 INFO - 'TERM': 'linux', 11:49:41 INFO - 'TMOUT': '86400', 11:49:41 INFO - 'USER': 'cltbld', 11:49:41 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:41 INFO - '_': '/tools/buildbot/bin/python'} 11:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:43 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:43 INFO - Installing collected packages: mozsystemmonitor 11:49:43 INFO - Running setup.py install for mozsystemmonitor 11:49:43 INFO - Successfully installed mozsystemmonitor 11:49:43 INFO - Cleaning up... 11:49:43 INFO - Return code: 0 11:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49: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:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:43 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 11:49:43 INFO - 'HOME': '/home/cltbld', 11:49:43 INFO - 'LANG': 'en_US.UTF-8', 11:49:43 INFO - 'LANGUAGE': 'en_US:en', 11:49:43 INFO - 'LOGNAME': 'cltbld', 11:49:43 INFO - 'MAIL': '/var/mail/cltbld', 11:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:43 INFO - 'MOZ_NO_REMOTE': '1', 11:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:43 INFO - 'NO_EM_RESTART': '1', 11:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:43 INFO - 'PWD': '/builds/slave/test', 11:49:43 INFO - 'SHELL': '/bin/bash', 11:49:43 INFO - 'SHLVL': '1', 11:49:43 INFO - 'TERM': 'linux', 11:49:43 INFO - 'TMOUT': '86400', 11:49:43 INFO - 'USER': 'cltbld', 11:49:43 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:43 INFO - '_': '/tools/buildbot/bin/python'} 11:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:45 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:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:45 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:45 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:45 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:45 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:45 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:45 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:46 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:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:46 INFO - Downloading docopt-0.6.1.tar.gz 11:49:46 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:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:46 INFO - Running setup.py install for blobuploader 11:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:46 INFO - Running setup.py install for requests 11:49:46 INFO - Running setup.py install for docopt 11:49:47 INFO - Successfully installed blobuploader requests docopt 11:49:47 INFO - Cleaning up... 11:49:47 INFO - Return code: 0 11:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 11:49:47 INFO - 'HOME': '/home/cltbld', 11:49:47 INFO - 'LANG': 'en_US.UTF-8', 11:49:47 INFO - 'LANGUAGE': 'en_US:en', 11:49:47 INFO - 'LOGNAME': 'cltbld', 11:49:47 INFO - 'MAIL': '/var/mail/cltbld', 11:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:47 INFO - 'MOZ_NO_REMOTE': '1', 11:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:47 INFO - 'NO_EM_RESTART': '1', 11:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:47 INFO - 'PWD': '/builds/slave/test', 11:49:47 INFO - 'SHELL': '/bin/bash', 11:49:47 INFO - 'SHLVL': '1', 11:49:47 INFO - 'TERM': 'linux', 11:49:47 INFO - 'TMOUT': '86400', 11:49:47 INFO - 'USER': 'cltbld', 11:49:47 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:47 INFO - '_': '/tools/buildbot/bin/python'} 11:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:47 INFO - Running setup.py (path:/tmp/pip-44nnyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:47 INFO - Running setup.py (path:/tmp/pip-q0bAV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:47 INFO - Running setup.py (path:/tmp/pip-DqogOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:47 INFO - Running setup.py (path:/tmp/pip-Pbgh5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:47 INFO - Running setup.py (path:/tmp/pip-VjBNyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:47 INFO - Running setup.py (path:/tmp/pip-1vofEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:47 INFO - Running setup.py (path:/tmp/pip-Zh3ZoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:47 INFO - Running setup.py (path:/tmp/pip-lpbG0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:47 INFO - Running setup.py (path:/tmp/pip-Bg3V0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:47 INFO - Running setup.py (path:/tmp/pip-0dALgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:48 INFO - Running setup.py (path:/tmp/pip-7GaNM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:48 INFO - Running setup.py (path:/tmp/pip-_avNLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:48 INFO - Running setup.py (path:/tmp/pip-UzijiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:48 INFO - Running setup.py (path:/tmp/pip-HAh52p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:48 INFO - Running setup.py (path:/tmp/pip-cEacJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:48 INFO - Running setup.py (path:/tmp/pip-CiG_9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:48 INFO - Running setup.py (path:/tmp/pip-R4Zs5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:48 INFO - Running setup.py install for manifestparser 11:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozcrash 11:49:48 INFO - Running setup.py install for mozdebug 11:49:48 INFO - Running setup.py install for mozdevice 11:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:48 INFO - Running setup.py install for mozfile 11:49:49 INFO - Running setup.py install for mozhttpd 11:49:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozinfo 11:49:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozInstall 11:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozleak 11:49:49 INFO - Running setup.py install for mozlog 11:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for moznetwork 11:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozprocess 11:49:49 INFO - Running setup.py install for mozprofile 11:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozrunner 11:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:49 INFO - Running setup.py install for mozscreenshot 11:49:50 INFO - Running setup.py install for moztest 11:49:50 INFO - Running setup.py install for mozversion 11:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:50 INFO - Cleaning up... 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 11:49:50 INFO - 'HOME': '/home/cltbld', 11:49:50 INFO - 'LANG': 'en_US.UTF-8', 11:49:50 INFO - 'LANGUAGE': 'en_US:en', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MAIL': '/var/mail/cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SHLVL': '1', 11:49:50 INFO - 'TERM': 'linux', 11:49:50 INFO - 'TMOUT': '86400', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - '_': '/tools/buildbot/bin/python'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 INFO - Running setup.py (path:/tmp/pip-wL9y62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 INFO - Running setup.py (path:/tmp/pip-atUDxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 INFO - Running setup.py (path:/tmp/pip-w7ZaHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 INFO - Running setup.py (path:/tmp/pip-eRELHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Running setup.py (path:/tmp/pip-FTw1wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Running setup.py (path:/tmp/pip-Yjjx8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:50 INFO - Running setup.py (path:/tmp/pip-4yNThL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 INFO - Running setup.py (path:/tmp/pip-BIQ1L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:51 INFO - Running setup.py (path:/tmp/pip-QGUpjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:51 INFO - Running setup.py (path:/tmp/pip-Wu40C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 INFO - Running setup.py (path:/tmp/pip-rnRZc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 INFO - Running setup.py (path:/tmp/pip-TsLttv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 INFO - Running setup.py (path:/tmp/pip-4A7bgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 INFO - Running setup.py (path:/tmp/pip-cIH70T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 INFO - Running setup.py (path:/tmp/pip-_olvg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:51 INFO - Running setup.py (path:/tmp/pip-SR27vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:51 INFO - Running setup.py (path:/tmp/pip-3QLMe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - Downloading blessings-1.5.1.tar.gz 11:49:53 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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:53 INFO - Installing collected packages: blessings 11:49:53 INFO - Running setup.py install for blessings 11:49:53 INFO - Successfully installed blessings 11:49:53 INFO - Cleaning up... 11:49:53 INFO - Return code: 0 11:49:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:53 INFO - Reading from file tmpfile_stdout 11:49:53 INFO - Current package versions: 11:49:53 INFO - argparse == 1.2.1 11:49:53 INFO - blessings == 1.5.1 11:49:53 INFO - blobuploader == 1.2.4 11:49:53 INFO - docopt == 0.6.1 11:49:53 INFO - manifestparser == 1.1 11:49:53 INFO - mozInstall == 1.12 11:49:53 INFO - mozcrash == 0.16 11:49:53 INFO - mozdebug == 0.1 11:49:53 INFO - mozdevice == 0.47 11:49:53 INFO - mozfile == 1.2 11:49:53 INFO - mozhttpd == 0.7 11:49:53 INFO - mozinfo == 0.9 11:49:53 INFO - mozleak == 0.1 11:49:53 INFO - mozlog == 3.0 11:49:53 INFO - moznetwork == 0.27 11:49:53 INFO - mozprocess == 0.22 11:49:53 INFO - mozprofile == 0.27 11:49:53 INFO - mozrunner == 6.11 11:49:53 INFO - mozscreenshot == 0.1 11:49:53 INFO - mozsystemmonitor == 0.0 11:49:53 INFO - moztest == 0.7 11:49:53 INFO - mozversion == 1.4 11:49:53 INFO - psutil == 3.1.1 11:49:53 INFO - requests == 1.2.3 11:49:53 INFO - wsgiref == 0.1.2 11:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:53 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 0x7f43c260cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a7900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, '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': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', '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:53 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:53 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:53 INFO - Using env: {'DISPLAY': ':0', 11:49:53 INFO - 'HOME': '/home/cltbld', 11:49:53 INFO - 'LANG': 'en_US.UTF-8', 11:49:53 INFO - 'LANGUAGE': 'en_US:en', 11:49:53 INFO - 'LOGNAME': 'cltbld', 11:49:53 INFO - 'MAIL': '/var/mail/cltbld', 11:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:53 INFO - 'MOZ_NO_REMOTE': '1', 11:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:53 INFO - 'NO_EM_RESTART': '1', 11:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:53 INFO - 'PWD': '/builds/slave/test', 11:49:53 INFO - 'SHELL': '/bin/bash', 11:49:53 INFO - 'SHLVL': '1', 11:49:53 INFO - 'TERM': 'linux', 11:49:53 INFO - 'TMOUT': '86400', 11:49:53 INFO - 'USER': 'cltbld', 11:49:53 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:53 INFO - '_': '/tools/buildbot/bin/python'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Running post-action listener: _resource_record_post_action 11:49:54 INFO - Running post-action listener: _start_resource_monitoring 11:49:54 INFO - Starting resource monitoring. 11:49:54 INFO - ##### 11:49:54 INFO - ##### Running install step. 11:49:54 INFO - ##### 11:49:54 INFO - Running pre-action listener: _resource_record_pre_action 11:49:54 INFO - Running main action method: install 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:54 INFO - Reading from file tmpfile_stdout 11:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:54 INFO - Reading from file tmpfile_stdout 11:49:54 INFO - Output received: 11:49:54 INFO - Usage: mozinstall [options] installer 11:49:54 INFO - Options: 11:49:54 INFO - -h, --help show this help message and exit 11:49:54 INFO - -d DEST, --destination=DEST 11:49:54 INFO - Directory to install application into. [default: 11:49:54 INFO - "/builds/slave/test"] 11:49:54 INFO - --app=APP Application being installed. [default: firefox] 11:49:54 INFO - mkdir: /builds/slave/test/build/application 11:49:54 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:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:50:08 INFO - Reading from file tmpfile_stdout 11:50:08 INFO - Output received: 11:50:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:08 INFO - Running post-action listener: _resource_record_post_action 11:50:08 INFO - ##### 11:50:08 INFO - ##### Running run-tests step. 11:50:08 INFO - ##### 11:50:08 INFO - Running pre-action listener: _resource_record_pre_action 11:50:08 INFO - Running main action method: run_tests 11:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:08 INFO - Python 2.7.3 11:50:08 INFO - Return code: 0 11:50:08 INFO - grabbing minidump binary from tooltool 11:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:08 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 0x26edb70>, '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 0x273edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:50:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:50:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:08 INFO - Return code: 0 11:50:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:08 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-061', '--webServer', 'localhost'] in /builds/slave/test/build 11:50:08 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-061 --webServer localhost 11:50:08 INFO - Using env: {'DISPLAY': ':0', 11:50:08 INFO - 'HOME': '/home/cltbld', 11:50:08 INFO - 'LANG': 'en_US.UTF-8', 11:50:08 INFO - 'LANGUAGE': 'en_US:en', 11:50:08 INFO - 'LOGNAME': 'cltbld', 11:50:08 INFO - 'MAIL': '/var/mail/cltbld', 11:50:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:08 INFO - 'MOZ_NO_REMOTE': '1', 11:50:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:08 INFO - 'NO_EM_RESTART': '1', 11:50:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:08 INFO - 'PWD': '/builds/slave/test', 11:50:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:08 INFO - 'SHELL': '/bin/bash', 11:50:08 INFO - 'SHLVL': '1', 11:50:08 INFO - 'TERM': 'linux', 11:50:08 INFO - 'TMOUT': '86400', 11:50:08 INFO - 'USER': 'cltbld', 11:50:08 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188', 11:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:08 INFO - '_': '/tools/buildbot/bin/python'} 11:50:08 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-061', '--webServer', 'localhost'] with output_timeout 3600 11:50:08 INFO - mozversion INFO | application_buildid: 20151123050554 11:50:08 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:08 INFO - mozversion INFO | application_display_name: Nightly 11:50:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:08 INFO - mozversion INFO | application_name: Firefox 11:50:08 INFO - mozversion INFO | application_remotingname: firefox 11:50:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:50:08 INFO - mozversion INFO | application_vendor: Mozilla 11:50:08 INFO - mozversion INFO | application_version: 45.0a1 11:50:08 INFO - mozversion INFO | platform_buildid: 20151123050554 11:50:08 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:08 INFO - mozversion INFO | platform_version: 45.0a1 11:50:08 INFO - 2015-11-23 11:50:08,817 DEBUG : using testdate: 1448308208 11:50:08 INFO - 2015-11-23 11:50:08,817 DEBUG : actual date: 1448308208 11:50:08 INFO - 2015-11-23 11:50:08,865 INFO : starting webserver on 'localhost:44998' 11:50:08 INFO - 2015-11-23 11:50:08,867 INFO : Starting test suite talos-linux64-ix-061 11:50:08 INFO - 2015-11-23 11:50:08,867 INFO : Starting test dromaeo_css 11:50:08 INFO - 2015-11-23 11:50:08,867 DEBUG : operating with platform_type : linux_ 11:50:08 INFO - 2015-11-23 11:50:08,868 INFO : Initialising browser for dromaeo_css test... 11:50:08 INFO - 2015-11-23 11:50:08,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXtAOC/profile http://localhost:44998/getInfo.html 11:50:13 INFO - 2015-11-23 11:50:13,038 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:50:13 INFO - 2015-11-23 11:50:13,038 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:50:13 INFO - 2015-11-23 11:50:13,038 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:50:13 INFO - 2015-11-23 11:50:13,038 DEBUG : BROWSER_OUTPUT: __metrics 11:50:13 INFO - 2015-11-23 11:50:13,139 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:14 INFO - 2015-11-23 11:50:14,402 INFO : Browser initialized. 11:50:14 INFO - 2015-11-23 11:50:14,402 INFO : Running cycle 1/1 for dromaeo_css test... 11:50:14 INFO - 2015-11-23 11:50:14,403 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXtAOC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:50:26 INFO - 2015-11-23 11:50:26,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 142266368 11:50:26 INFO - 2015-11-23 11:50:26,298 DEBUG : BROWSER_OUTPUT: 11:51:17 INFO - 2015-11-23 11:51:17,799 DEBUG : BROWSER_OUTPUT: 1448308277798 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:53:29 INFO - 2015-11-23 11:53:29,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44998/tests/dromaeo/cssquery-ext.html) 11:53:31 INFO - 2015-11-23 11:53:31,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 246329344 11:53:31 INFO - 2015-11-23 11:53:31,259 DEBUG : BROWSER_OUTPUT: 11:56:33 INFO - 2015-11-23 11:56:33,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-ext.html (next: http://localhost:44998/tests/dromaeo/cssquery-jquery.html) 11:56:34 INFO - 2015-11-23 11:56:34,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 215658496 11:56:34 INFO - 2015-11-23 11:56:34,311 DEBUG : BROWSER_OUTPUT: 11:59:36 INFO - 2015-11-23 11:59:36,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44998/tests/dromaeo/cssquery-mootools.html) 11:59:36 INFO - 2015-11-23 11:59:36,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 215236608 11:59:36 INFO - 2015-11-23 11:59:36,916 DEBUG : BROWSER_OUTPUT: 12:02:38 INFO - 2015-11-23 12:02:38,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44998/tests/dromaeo/cssquery-prototype.html) 12:02:39 INFO - 2015-11-23 12:02:39,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 201674752 12:02:39 INFO - 2015-11-23 12:02:39,434 DEBUG : BROWSER_OUTPUT: 12:05:42 INFO - 2015-11-23 12:05:42,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44998/tests/dromaeo/cssquery-yui.html) 12:05:42 INFO - 2015-11-23 12:05:42,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 204709888 12:05:42 INFO - 2015-11-23 12:05:42,841 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-yui.html (next: http://localhost:44998/tests/dromaeo/cssquery-dojo.html) 12:08:45 INFO - 2015-11-23 12:08:45,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 247836672 12:08:45 INFO - 2015-11-23 12:08:45,828 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:08:45 INFO - 2015-11-23 12:08:45,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:08:45 INFO - 2015-11-23 12:08:45,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:08:45 INFO - 2015-11-23 12:08:45,830 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:08:45 INFO - 2015-11-23 12:08:45,834 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2639.9868000659994;2740;2755.8070935034557;2768.5708715149144;2776.4030733392324;4421.292593185091;4556.270996640538;4683.1804434224005;4741.359916411284;4745.738984355863;4571.9314210286875;4589.518100599439;4639.280911458721;4643.698159619622;4654.418197725285;4288.0351920817875;4332.220200363933;4349.304111342194;4487.663425243103;4500;4174.749515029092;4403.603675669189;4442.289233722605;4502.842400515982;4526.207913615121;4241.1093670329265;4252.8511502097435;4295.548967358445;4301.032267739764;4338.739675619473;4329.805158767863;4336.696431249814;4340.978295108536;4349.891252718676;4368.301071828492;4159.729617574878;4251.4685664291965;4311.137772445492;4325.091730736549;4363.890902727426;4525.954740452619;4554.658400619934;4628.32889231063;4633.6988095774;4634.536546345372;5111.821086261963;5156.948430515685;5158.277841102249;5164.664296820694;5170.069387510247;5158.767855446514;5173.405058418292;5177.430482646906;5186.092433824104;5225.921611175835;4561.908761824778;4639.791209395586;4685.20351540239;4689.6717229793585;4742.549457801503;5198.298229738937;5261.947610477843;5263.473652634706;5263.868403289948;5265.973670131625;5035.1188542005;5062.468440813662;5065.974670126626;5066.240063990431;5106.770195341219;4849.539293767087;4949.7772600233075;4952.504749525018;4955.90088198234;4958.033183529177;4991;4999.875003124878;5004.449510553836;5019.774110164978;5041.420236672756;4977.527134922177;4982.128127577732;4983.6013118950395;4983.9252411213865;5038.294638750578;3992.86024989124;4080.18396320737;4086.979565102215;4206.8737937861915;4213.199492096492;3641.9453708194396;3685.94471082934;3698.6301369863336;3721.4789929409903;3738.5513738351574;4373.300271956536;4402.581754733295;4402.779861006937;4403.493598236244;4443.4445694288215;4800.543948324904;4904.190808516626;4912.72979986097;5108.514691104339;5149.536541711264;4233.5554766749665;4305.332673435622;4309.3966844641145;4331.610155086058;4349.064951035542;4488.730676159375;4491.955080449219;4502.707324023928;4516.525764794715;4544.863654090383;4624.237000894949;4768.57082862544;4777.020710754217;4826.493218212037;4837.274408838632;4863.975680121577;4928.310036594808;4948.233023881304;4951.653384263067;4985.675931064469;4774.880627984189;4801.639877009168;4807.351007614067;4843.346148269939;4848.981713840133;4732.479427263067;4821.879453013562;4837.201861692782;4972.900541989212;5044.344235249394;4925.605951523941;4986.775595098156;4989.925151122663;5005.149124648746;5040.974795126001;4858.732769697701;4869;4877.6585639004925;4877.853664390074;4910.091633047898;4709.128811169808;4810.56704896547;4846.055019271208;4857.635677324144;4904.362432883702;4712.222483290218;4730.526947305242;4843.24929635907;4854.83008094715;4875.317455556154;4910.8281210157475;4914.9017019658695;4917.58200552957;4925.433575138905;4937.23472861707;4798.904021919612;4809.591184749335;4814.566688998007;4819.831305904277;4846.442659094249 12:08:45 INFO - 2015-11-23 12:08:45,835 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.1873616014968;572.5820151289556;575.7006356694519;588.1501230721607;588.3616276340168;27770.16689499316;36724.81637591815;37462.8126859366;37561.624383756156;37589.62410375896;40543.39184912229;41024;41243.22594836718;41258.79370603143;41337.17325653485;6964.825879353031;7082.752103676372;7899.802504937379;8088.676452941875;9908.653197138101;10049.095581397673;10178.745531361737;10186.083252507273;10189.08298253157;10195.541200645952;10115.696529104138;10220;10230.744231394201;10233.795324093551;10235.641752538662;6897.344752248553;7112.182099058597;10250.7437314067;10490.527926243338;10503.527341269584;9967.700968970943;10103.19174466041;10104.646337378157;10117.848232276521;10118.443485608288;37900.43149352762;38388.23223535542;38416.61583384186;38521;38539;2743.0262256898714;2845.573164025392;2903.41931613676;2957.955630665542;3018.7886847920654;28292.018415217553;28897.855510722522;28901.421971560452;28927.276818079506;29236.122916312546;3337.149026998124;3349.5645566076496;3397.082787647346;3399.048266485388;3483.9303213935577;237936.5341252813;238538;239137;239172;239963.99999999825;56296.718516407156;56497.15254271189;56613;56634;56701.716491418105;50199.49800501948;51872.40637968086;59422.40577594169;61134;61141.694291528256;12840.61478155657;13089.934550327187;13094.476220951055;13115.803262951064;13160;10057;10121.746956326004;10181.847272290921;10200.795984080425;10202.387856728472;18815.529611759543;19062.428127156207;19142.521436964187;19169.52076198106;19179.712304315446;7493.826790230881;7853.41099417546;7853.8821917671285;7862.174471680506;7899.723509677134;783.2285199078902;783.5807842804187;842.7219017724136;903.9548022598843;996.7508122969258;26350.86824565865;27143.86428067847;28405.289867753472;28519;29077;897.8967418746797;916.5234078279391;924.1220840201835;972.4991629310911;1031.3554028732042;12569.811452828215;12596.874031259571;12600.495980160875;12612.36938153107;12626.368681565886;281924;285624;285713;285924;285949;46269;46546.5345346549;46689;46695;46699.76650116728;1217.3061355027548;1218.0925210717894;1232.8274041634359;1233.0505510756668;1236.2397125767588;22158.446038849157;22428.439289017904;22483.887580561994;22680.886595566917;22739.545209096057;37079.6292037087;37585.4362184562;46430.53569464262;48113.759431204024;48291.75854120707;217940;218276;219425;219859;220074;24246.87876560606;24914;27962.58056129119;28337.716622833508;28338.2915427116;37608;38127;39846.2030759389;40907;42153.78923105488;30843.383132337676;31341.373172536878;31972.20069498281;32294.35411291808;32481;32271;32475.512867306537;32486.83756581202;32638.83680581582;32684.673153268162;31844.36311273808;32282.19294517562;32478.512822307213;32578.511322330658;32699.509507357885;28628.85685571642;29154;29663.258418538844;29865.402691946474;30677.693223067483;20451.79548204499;20651.4837129073;20720.896395517924;20767;20819.583608327444 12:08:45 INFO - 2015-11-23 12:08:45,836 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.07338373370317;327.11678468136034;329.91786938840596;332.9750268729846;337.43479671550165;11699.766004679923;12148.149629525937;14915.477958271462;15430.614234644125;15618.687626247482;13112.93443532781;13526.594202173927;13789.793153102686;14446.927765361159;14542.854571454282;4320.351947207921;4908.877278068059;5061.44324124346;5065.442801291855;5068.1890897456415;3553.6091029986683;3659.359612067891;5012.72430016349;5441.891162176774;5610.24261724666;5517.779288828442;5532.861678458031;5532.889342213153;5556.305461817273;5566.8608284793;5486.177073438977;5523.337199536061;5608.915866262009;5648.8870222595315;5656.038473459522;4971.875703107415;4974.37820272466;4978.377702787152;4979.825706100305;4981.227909674007;18739.250429982785;18908.527286817938;19320.13059412316;19320.71018934717;19342.613147737105;1903.5431496440892;1951.658459769549;1978.3669225847734;1980.960380792376;1987.1455274232073;12425.378731063502;12561.74876502474;12562.371881405985;12593.118481706284;13020.218786872818;1682.7055265328518;1690.1887094194856;1750.1949103412446;1786.0355408079622;1786.928522859084;51202.16998913027;53275.46724532744;53376.73311633456;53505.73247133778;53569.1964620531;9078.954605227063;9220.7694807629;9341.299402544837;9341.346105772667;9416.952915235517;11834.88165118355;11849.703757406134;11857.940710296394;11864.050875929905;11864.525418983316;6769.8646027079185;6779.898301525481;6882.793516194522;6892.414744608768;6974.930250697428;6560.278369379364;6636.037774522667;6655.733770649216;6703.597784132968;6704.698288577026;5559.332880054339;5644.689542075225;5654.208410822488;5682.602217844794;5694.515966142924;1534.1562140822725;1575.8187808401951;1589.348367169455;1600.5198440468046;1656.8177500474937;801.4069588504581;825.7976795685096;828.5070383122032;844.50174397106;851.4550687559966;14891.70216595662;15634.843651563566;15762.448314308944;15933.601659958595;15994.120323382092;728.9830686192837;807.6990028100389;814.0503494131522;832.8375966686559;843.6667516331015;8381.748547543584;8605.26855217301;8626.654933802578;8648.78378040554;8778.341624378198;513457;520264;524018;526277;528689;66846.66576667085;68788;69412.3058769416;69454.65272673604;69903.30096699069;1088.5645741703381;1088.7223757941674;1147.1969621265148;1156.8380426740264;1164.1850704506878;13366.93316533411;13439.664008399868;14126.223057731924;14178.503752368617;14218.360173792411;29329.853350733963;29383.971560996117;30378.544321834746;31665.366692666477;32026.356178354476;35281;36108.45837312495;36412.4538131923;36461.817690911375;36646;8609.139086091342;8709.825803483767;8850.822983540422;8989.235914947303;9003.234725048182;15557.688846223238;15686.843131568538;15880.761788572949;15979.520614381587;16195.190240488164;13162.736745264849;13215.273159976294;13300.401481933142;13331.266780327174;13787;12908.41912113976;13044.869551304366;13267.872230860485;13574;13700.588982330546;10323.48382580853;13112.475500979854;13698.178109313472;14028.719425611635;14141.505047323295;8423;8603.225709686158;8749.693760718344;8762.079981602095;8773.078826723102;12406.25562466255;12785.424655890321;13029.609111726664;13046.804297935729;13255.072144949761 12:08:45 INFO - 2015-11-23 12:08:45,838 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1411.054593422407;1619.8866079374443;1641.1548052752835;1684.7894013248344;1690.5520037190147;5721.25623668923;6506;6707.564008339455;6708.530402871801;6714.362135597116;6604.3395660433935;6807.387335139836;6810.421114205298;6810.489213308997;6813.3527314905;2086.968695469569;2112.7464704235513;2113.9894300528554;2114.8202402795705;2115.6614941609346;2060.9515457136554;2063.484128967758;2072.637288474511;2072.8963551822426;2073.4712648274667;2064.3394113883564;2076.4289820299464;2084.6977188307687;2085.5620319732875;2088.1647341063544;2066.5143691232547;2074.1392322186275;2075.0247383729625;2076.294060019593;2077.314486219544;2059.6395630764705;2072.5336799220054;2088.571842772228;2089.268755935426;2093.445237012193;5721.284839395075;5903.881922361572;6705.798826035227;6745.8650826983185;6752.054712340277;3897.7856217908;4017.7589344639414;4023.114914718757;4027.1140349123148;4029.5567487576345;2767.9861600691866;2770.4182121754457;2831.688514263429;2837.815541989764;2856.685764565896;852.1989330029814;856.7344123321728;868.6916144768579;884.5709830732154;886.4814083761007;8916.643334266622;8955.37312388133;8994.595243214071;8995.280377569845;9008.864867027065;3923.7645741255046;3953.327934251127;3981.7212795104065;3999.420084087791;4005.4192142139227;8009.959950200328;8020;8020.438569300093;8027;8035.758927232192;4233.97883010583;4248.787560621957;4250.128723611714;4251.192273468031;4257.318828987409;3818.8090595470117;3823.598522155189;3825.9043523912123;3829.7319187657154;3831.616838316146;3259.222333000997;3266.1508007917637;3273.967260327414;3284.917877053093;3299.472084466474;1042.9582816687248;1061.7823346214007;1065.674969134406;1067.6583493282076;1077.0683358894657;855.7176131876466;907.7503686486269;1163.0230606290588;1181.2203945395997;1183.7869183547043;6347.206599175103;6378.52161087911;6413.518986076063;6446.000869865178;6449;930.0652843891845;934.5047125023748;970.9174720148725;1011.5346940407347;1021.5913634546241;4761.166795810719;5059.19052951526;5121.334226550524;5138.2292656101135;5139.177731562932;7239.963800180965;7810.101838288556;7908.604569771488;7933.404994625426;7999.4400391972;7685.846283074307;7705.113911900091;7787.29914307715;7795.674735295013;7809.765707028798;6090.086487026982;6200.844978875564;6252.343503932022;6259.436650701458;6280.246370435577;6275.874482510233;6276.246850377984;6280.560360774702;6288.591241569284;6299.338569450325;6940.7917762467205;7065.788026359218;7144.892826607501;7153.499255052305;7159.105111861018;7176.246494118252;7307.3423391894985;7310.634468276671;7381.667824947783;7405.2224516425;5623.3533143689;5695.658260504383;5703.344115426779;5703.572232082527;5725.198472213977;6530.47756179495;6635.668216589248;6643.56816806906;6654;6669.6665166740495;6063.818085457443;6131.754729810936;6132.938670613236;6196.442320191204;6313.810585682437;5908.143319218603;6172.629642221481;6224.595401298901;6227.595206311576;6234.563580549318;6175.289841668086;6222;6254;6264.060390941213;6274.121622972696;5634.661920284796;5655.547556195576;5666.801661941812;5667.574931880043;5669.489745922887;5834.095715164156;5891.05743081105;5930.495907847709;5931.228940237742;5934.465898069195 12:08:45 INFO - 2015-11-23 12:08:45,839 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.1857171354479;320.88929319384806;322.82728740124037;324.9203945033467;326.31148277135253;5376.301080859487;5387.784488620456;5406.378266499354;5415.350157981038;5445.801923576817;5097.286379906816;5223.962654564713;5295.126304159819;5393.164059570763;5414.702191379472;4255.212785634652;4257.020885196407;4269.0394661201135;4273.764942928137;4275.636570891478;4021.7586944783407;4262.254105531535;4265.466816647919;4270.572942705736;4284.2930916398755;4034.253663072326;4081.1021575253544;4122.752634841919;4172.561881002496;4195.748255104703;4162.854300099482;4173.707840451169;4178.6448151907125;4182.2890108681295;4186;3652.3060618482405;3655.5065066215984;3656.744027918047;3657.3599620066384;3667.3032123896373;5217.426083130853;5240.68555886648;5244.187150991603;5248.632595718302;5263.815766448156;4706.3411122442885;4830.154722923509;4835.492273311322;4864.586510146642;4868.78090485929;5745.109508026263;5749.367569567345;5751.798687045934;5762.510186634141;5762.798302059449;4008.3586626139677;4008.4788977432745;4011.3180759270995;4012.7592344459135;4013.137175507251;5979.19280897082;6055.303640081359;6060.090986351995;6069.57512974092;6071.362506936796;4083.7753923533896;4122.381642753611;4124.587541245912;4134.111166099303;4137.40007698888;4175.916481670411;4186.016286172747;4188.141431006637;4191;4191.140816132685;4785.928211076836;4790.4251489821445;4791.736454495036;4792.616590672737;4796.856094317176;5703.458171473703;5713.6857472838565;5733.512651424592;5735.369109397963;5736.942630573641;1430.5708287513705;1452.0561634937376;1476.0258229568433;1476.1364601707905;1479.3121198642468;974.9025097490336;984.3798407003542;993.4933184076173;994.8806143262855;996.7358649957768;4964.329815474937;5021.221710634857;5025.195968645073;5025.79896804131;5027.296178535008;5923.644581325134;5929.73316200772;5930.169776231331;5931.288245410578;5934.762609495659;4857.757112144449;4896.314515967767;5007.298978143063;5013.623978201576;5082.415522214918;3201.7278531325096;3206.7915585486867;3232.884654794092;3235.4014507316224;3240.7893486923745;5672.517835983905;5675.290588676416;5676.914846277309;5677.801276955287;5679.119736440858;6047.818565443044;6188.226471691039;6189.071639254058;6189.102580125947;6192.938070619236;5670.319561652628;5683.60214784961;5683.914741278884;5687.919295333956;5691.089425691869;6015.969920150371;6019.849503762441;6021.638701677914;6022.337542870193;6028.246469191351;5876.6180198286975;5878;5878.882422351615;5882.264716910387;5887.4406931341455;5510.834674959758;5667.206591077335;5668.121441176624;5674.404187560247;5677.659340439587;4102;4104.076582768973;4107.54816970139;4108.239975604522;4111.362738775495;5996.940030599638;5997.280326360865;6007;6007.609505382136;6008.54935879802;5578.414266501959;5763.711814409179;5776.422357764358;5779.826605201851;5780.884382312414;5764.827055188351;5766.481016708516;5767.653940763567;5773.884522309614;5774.39368866263;5615.522680572197;5621.128725047624;5624.072028115479;5625.971870140623;5632.549396048388;5638.407967163389;5757.510611598061;5806.82579522615;5811.389804070512;5813.738381772746;5694.430556944272;5697.287839020122;5701.945140149086;5702.087665973424;5704.9429505706075 12:08:45 INFO - 2015-11-23 12:08:45,840 DEBUG : BROWSER_OUTPUT: |5;yui.html;644.5971267957526;704.9707427156352;766.6894907562436;782.3271986091962;783.150281944091;11337.26307789993;11589.594364197255;11602.767944641113;11603.303801771899;11614.941925290372;11884.7623047539;11965.102617303715;11966.042716582675;11976.64070077897;11977.700557486067;771.3096778383343;813.8209593889335;816.1715858403695;816.3632366753941;816.7590560784582;607.0045125993353;623.4233334165901;623.915771370866;759.4038679636486;805.3597390074875;829.1211316005024;830.2154464031493;836.9497830130211;837.2548431895618;837.811492414208;834.2408408348374;834.3742193354984;835.2399316621845;835.4820011592791;835.5154010673825;461.63761447264073;474.79109191955774;475.3084262398237;583.7227317024422;619.9628022318675;10387.792244155151;10520.053195212391;10541.367517948871;10573.73565660857;10584.100351470135;11353.602623908206;11436.142289328334;11451.942740286246;11456.140789440742;11511.654650360419;9187.724368268962;9222.30832687551;9326.533673316308;9419.48192849393;9466.90533094667;3313.1385839681616;3340.1148695595684;3340.8496617652263;3344.615369232545;3344.715699165574;41141.38287925684;41550.1689966199;41550.58449415528;41562.168756625004;41615.37576936348;9079.45523268606;9149;9249.90750092504;9318.813623727487;9447.433154010781;15602.141882196362;15699.450519231772;15881;15932.601684957737;15939.123348215959;5991.700414979321;6445.6454894981225;6482.319356467598;6492.156019717407;6678.065070890079;3601.513795637608;3659.5425571803526;3684.4657524658774;3688.133288677159;3692.1508053147927;2709.9729002710114;2737.630419893329;2742.561190209557;2745.08039806663;2751.312171957011;495.5341978540161;497.9377577802775;506.3164727617687;516.6796586116557;521.5801279969661;458.86922227165763;502.4924825925841;526.5103453787938;565.3187908570245;598.1237487081446;7493.925060749431;7576.507527010726;7682.654280557388;8005.079415867133;8391.538465384341;547.9232907392968;588.8733922206746;627.0969803482969;628.3936001758325;628.5286035473395;3571.5535558055244;3813.0276779421624;3840.71194660396;3863.555691095504;3877.786721730332;52158.739206303726;53155.20267195995;53165.468345316054;53178.202326965125;53219;45618.77190614092;45734;46525;46584.767076164404;46639;41487.792561037;42552.14895702131;42720;42736.35895461571;42836.78581607072;7307.853842923006;7401.22287159862;8254.42219044661;8346.386995071962;8422.6209820557;31592.210194745316;32096.518552221267;32144.678553215104;33039.174020649676;33593.83203083969;42064;42108.789456052524;42113;42466;42490;10331.121854642439;10358.119559837196;10402.375857448576;10419.166466682496;10494.160467162455;11499.425028748696;11552.82670759956;11635.01102406305;11973.820392694292;12052.397380131133;10266.127379172554;10450.268481206547;10627.468626568487;10742.624008159677;10996.725081873017;10302.175825934057;10514.894851051391;10582.50358086316;10716.624918127829;10732.73168170802;9137.543122843965;10108.848367274644;10433.739156520844;10524;10601.681949541526;8918;9010.90989090127;9167.358284920258;9181.127792859668;9237.907620923705;8049.195080492138;8236.135205803304;8603.225709686158;8855.60149793248;9027.277817774693 12:08:45 INFO - 2015-11-23 12:08:45,840 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:08:45 INFO - 2015-11-23 12:08:45,840 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:08:45 INFO - 2015-11-23 12:08:45,840 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1001 12:08:45 INFO - 2015-11-23 12:08:45,840 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309325829__endTimestamp 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4642.29 Median:4777.02 stddev:483.49 (10.1%) stddev-sans-first:458.75 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: Values: 2640.0 2740.0 2755.8 2768.6 2776.4 4421.3 4556.3 4683.2 4741.4 4745.7 4571.9 4589.5 4639.3 4643.7 4654.4 4288.0 4332.2 4349.3 4487.7 4500.0 4174.7 4403.6 4442.3 4502.8 4526.2 4241.1 4252.9 4295.5 4301.0 4338.7 4329.8 4336.7 4341.0 4349.9 4368.3 4159.7 4251.5 4311.1 4325.1 4363.9 4526.0 4554.7 4628.3 4633.7 4634.5 5111.8 5156.9 5158.3 5164.7 5170.1 5158.8 5173.4 5177.4 5186.1 5225.9 4561.9 4639.8 4685.2 4689.7 4742.5 5198.3 5261.9 5263.5 5263.9 5266.0 5035.1 5062.5 5066.0 5066.2 5106.8 4849.5 4949.8 4952.5 4955.9 4958.0 4991.0 4999.9 5004.4 5019.8 5041.4 4977.5 4982.1 4983.6 4983.9 5038.3 3992.9 4080.2 4087.0 4206.9 4213.2 3641.9 3685.9 3698.6 3721.5 3738.6 4373.3 4402.6 4402.8 4403.5 4443.4 4800.5 4904.2 4912.7 5108.5 5149.5 4233.6 4305.3 4309.4 4331.6 4349.1 4488.7 4492.0 4502.7 4516.5 4544.9 4624.2 4768.6 4777.0 4826.5 4837.3 4864.0 4928.3 4948.2 4951.7 4985.7 4774.9 4801.6 4807.4 4843.3 4849.0 4732.5 4821.9 4837.2 4972.9 5044.3 4925.6 4986.8 4989.9 5005.1 5041.0 4858.7 4869.0 4877.7 4877.9 4910.1 4709.1 4810.6 4846.1 4857.6 4904.4 4712.2 4730.5 4843.2 4854.8 4875.3 4910.8 4914.9 4917.6 4925.4 4937.2 4798.9 4809.6 4814.6 4819.8 4846.4 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40946.96 Median:29764.33 stddev:64972.68 (218.3%) stddev-sans-first:65084.14 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: Values: 548.2 572.6 575.7 588.2 588.4 27770.2 36724.8 37462.8 37561.6 37589.6 40543.4 41024.0 41243.2 41258.8 41337.2 6964.8 7082.8 7899.8 8088.7 9908.7 10049.1 10178.7 10186.1 10189.1 10195.5 10115.7 10220.0 10230.7 10233.8 10235.6 6897.3 7112.2 10250.7 10490.5 10503.5 9967.7 10103.2 10104.6 10117.8 10118.4 37900.4 38388.2 38416.6 38521.0 38539.0 2743.0 2845.6 2903.4 2958.0 3018.8 28292.0 28897.9 28901.4 28927.3 29236.1 3337.1 3349.6 3397.1 3399.0 3483.9 237936.5 238538.0 239137.0 239172.0 239964.0 56296.7 56497.2 56613.0 56634.0 56701.7 50199.5 51872.4 59422.4 61134.0 61141.7 12840.6 13089.9 13094.5 13115.8 13160.0 10057.0 10121.7 10181.8 10200.8 10202.4 18815.5 19062.4 19142.5 19169.5 19179.7 7493.8 7853.4 7853.9 7862.2 7899.7 783.2 783.6 842.7 904.0 996.8 26350.9 27143.9 28405.3 28519.0 29077.0 897.9 916.5 924.1 972.5 1031.4 12569.8 12596.9 12600.5 12612.4 12626.4 281924.0 285624.0 285713.0 285924.0 285949.0 46269.0 46546.5 46689.0 46695.0 46699.8 1217.3 1218.1 1232.8 1233.1 1236.2 22158.4 22428.4 22483.9 22680.9 22739.5 37079.6 37585.4 46430.5 48113.8 48291.8 217940.0 218276.0 219425.0 219859.0 220074.0 24246.9 24914.0 27962.6 28337.7 28338.3 37608.0 38127.0 39846.2 40907.0 42153.8 30843.4 31341.4 31972.2 32294.4 32481.0 32271.0 32475.5 32486.8 32638.8 32684.7 31844.4 32282.2 32478.5 32578.5 32699.5 28628.9 29154.0 29663.3 29865.4 30677.7 20451.8 20651.5 20720.9 20767.0 20819.6 12:08:45 INFO - 2015-11-23 12:08:45,841 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,842 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26921.41 Median:19417.30 stddev:85189.00 (438.7%) stddev-sans-first:85404.57 12:08:45 INFO - 2015-11-23 12:08:45,842 DEBUG : BROWSER_OUTPUT: Values: 324.1 327.1 329.9 333.0 337.4 11699.8 12148.1 14915.5 15430.6 15618.7 13112.9 13526.6 13789.8 14446.9 14542.9 4320.4 4908.9 5061.4 5065.4 5068.2 3553.6 3659.4 5012.7 5441.9 5610.2 5517.8 5532.9 5532.9 5556.3 5566.9 5486.2 5523.3 5608.9 5648.9 5656.0 4971.9 4974.4 4978.4 4979.8 4981.2 18739.3 18908.5 19320.1 19320.7 19342.6 1903.5 1951.7 1978.4 1981.0 1987.1 12425.4 12561.7 12562.4 12593.1 13020.2 1682.7 1690.2 1750.2 1786.0 1786.9 51202.2 53275.5 53376.7 53505.7 53569.2 9079.0 9220.8 9341.3 9341.3 9417.0 11834.9 11849.7 11857.9 11864.1 11864.5 6769.9 6779.9 6882.8 6892.4 6974.9 6560.3 6636.0 6655.7 6703.6 6704.7 5559.3 5644.7 5654.2 5682.6 5694.5 1534.2 1575.8 1589.3 1600.5 1656.8 801.4 825.8 828.5 844.5 851.5 14891.7 15634.8 15762.4 15933.6 15994.1 729.0 807.7 814.1 832.8 843.7 8381.7 8605.3 8626.7 8648.8 8778.3 513457.0 520264.0 524018.0 526277.0 528689.0 66846.7 68788.0 69412.3 69454.7 69903.3 1088.6 1088.7 1147.2 1156.8 1164.2 13366.9 13439.7 14126.2 14178.5 14218.4 29329.9 29384.0 30378.5 31665.4 32026.4 35281.0 36108.5 36412.5 36461.8 36646.0 8609.1 8709.8 8850.8 8989.2 9003.2 15557.7 15686.8 15880.8 15979.5 16195.2 13162.7 13215.3 13300.4 13331.3 13787.0 12908.4 13044.9 13267.9 13574.0 13700.6 10323.5 13112.5 13698.2 14028.7 14141.5 8423.0 8603.2 8749.7 8762.1 8773.1 12406.3 12785.4 13029.6 13046.8 13255.1 12:08:45 INFO - 2015-11-23 12:08:45,842 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,842 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4751.66 Median:5919.32 stddev:2359.54 (39.9%) stddev-sans-first:2352.80 12:08:45 INFO - 2015-11-23 12:08:45,843 DEBUG : BROWSER_OUTPUT: Values: 1411.1 1619.9 1641.2 1684.8 1690.6 5721.3 6506.0 6707.6 6708.5 6714.4 6604.3 6807.4 6810.4 6810.5 6813.4 2087.0 2112.7 2114.0 2114.8 2115.7 2061.0 2063.5 2072.6 2072.9 2073.5 2064.3 2076.4 2084.7 2085.6 2088.2 2066.5 2074.1 2075.0 2076.3 2077.3 2059.6 2072.5 2088.6 2089.3 2093.4 5721.3 5903.9 6705.8 6745.9 6752.1 3897.8 4017.8 4023.1 4027.1 4029.6 2768.0 2770.4 2831.7 2837.8 2856.7 852.2 856.7 868.7 884.6 886.5 8916.6 8955.4 8994.6 8995.3 9008.9 3923.8 3953.3 3981.7 3999.4 4005.4 8010.0 8020.0 8020.4 8027.0 8035.8 4234.0 4248.8 4250.1 4251.2 4257.3 3818.8 3823.6 3825.9 3829.7 3831.6 3259.2 3266.2 3274.0 3284.9 3299.5 1043.0 1061.8 1065.7 1067.7 1077.1 855.7 907.8 1163.0 1181.2 1183.8 6347.2 6378.5 6413.5 6446.0 6449.0 930.1 934.5 970.9 1011.5 1021.6 4761.2 5059.2 5121.3 5138.2 5139.2 7240.0 7810.1 7908.6 7933.4 7999.4 7685.8 7705.1 7787.3 7795.7 7809.8 6090.1 6200.8 6252.3 6259.4 6280.2 6275.9 6276.2 6280.6 6288.6 6299.3 6940.8 7065.8 7144.9 7153.5 7159.1 7176.2 7307.3 7310.6 7381.7 7405.2 5623.4 5695.7 5703.3 5703.6 5725.2 6530.5 6635.7 6643.6 6654.0 6669.7 6063.8 6131.8 6132.9 6196.4 6313.8 5908.1 6172.6 6224.6 6227.6 6234.6 6175.3 6222.0 6254.0 6264.1 6274.1 5634.7 5655.5 5666.8 5667.6 5669.5 5834.1 5891.1 5930.5 5931.2 5934.5 12:08:45 INFO - 2015-11-23 12:08:45,843 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,843 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4764.23 Median:5399.77 stddev:1406.85 (26.1%) stddev-sans-first:1370.55 12:08:45 INFO - 2015-11-23 12:08:45,844 DEBUG : BROWSER_OUTPUT: Values: 313.2 320.9 322.8 324.9 326.3 5376.3 5387.8 5406.4 5415.4 5445.8 5097.3 5224.0 5295.1 5393.2 5414.7 4255.2 4257.0 4269.0 4273.8 4275.6 4021.8 4262.3 4265.5 4270.6 4284.3 4034.3 4081.1 4122.8 4172.6 4195.7 4162.9 4173.7 4178.6 4182.3 4186.0 3652.3 3655.5 3656.7 3657.4 3667.3 5217.4 5240.7 5244.2 5248.6 5263.8 4706.3 4830.2 4835.5 4864.6 4868.8 5745.1 5749.4 5751.8 5762.5 5762.8 4008.4 4008.5 4011.3 4012.8 4013.1 5979.2 6055.3 6060.1 6069.6 6071.4 4083.8 4122.4 4124.6 4134.1 4137.4 4175.9 4186.0 4188.1 4191.0 4191.1 4785.9 4790.4 4791.7 4792.6 4796.9 5703.5 5713.7 5733.5 5735.4 5736.9 1430.6 1452.1 1476.0 1476.1 1479.3 974.9 984.4 993.5 994.9 996.7 4964.3 5021.2 5025.2 5025.8 5027.3 5923.6 5929.7 5930.2 5931.3 5934.8 4857.8 4896.3 5007.3 5013.6 5082.4 3201.7 3206.8 3232.9 3235.4 3240.8 5672.5 5675.3 5676.9 5677.8 5679.1 6047.8 6188.2 6189.1 6189.1 6192.9 5670.3 5683.6 5683.9 5687.9 5691.1 6016.0 6019.8 6021.6 6022.3 6028.2 5876.6 5878.0 5878.9 5882.3 5887.4 5510.8 5667.2 5668.1 5674.4 5677.7 4102.0 4104.1 4107.5 4108.2 4111.4 5996.9 5997.3 6007.0 6007.6 6008.5 5578.4 5763.7 5776.4 5779.8 5780.9 5764.8 5766.5 5767.7 5773.9 5774.4 5615.5 5621.1 5624.1 5626.0 5632.5 5638.4 5757.5 5806.8 5811.4 5813.7 5694.4 5697.3 5701.9 5702.1 5704.9 12:08:45 INFO - 2015-11-23 12:08:45,844 DEBUG : BROWSER_OUTPUT: 12:08:45 INFO - 2015-11-23 12:08:45,844 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12518.78 Median:23096.43 stddev:14526.64 (62.9%) stddev-sans-first:14540.03 12:08:45 INFO - 2015-11-23 12:08:45,845 DEBUG : BROWSER_OUTPUT: Values: 644.6 705.0 766.7 782.3 783.2 11337.3 11589.6 11602.8 11603.3 11614.9 11884.8 11965.1 11966.0 11976.6 11977.7 771.3 813.8 816.2 816.4 816.8 607.0 623.4 623.9 759.4 805.4 829.1 830.2 836.9 837.3 837.8 834.2 834.4 835.2 835.5 835.5 461.6 474.8 475.3 583.7 620.0 10387.8 10520.1 10541.4 10573.7 10584.1 11353.6 11436.1 11451.9 11456.1 11511.7 9187.7 9222.3 9326.5 9419.5 9466.9 3313.1 3340.1 3340.8 3344.6 3344.7 41141.4 41550.2 41550.6 41562.2 41615.4 9079.5 9149.0 9249.9 9318.8 9447.4 15602.1 15699.5 15881.0 15932.6 15939.1 5991.7 6445.6 6482.3 6492.2 6678.1 3601.5 3659.5 3684.5 3688.1 3692.2 2710.0 2737.6 2742.6 2745.1 2751.3 495.5 497.9 506.3 516.7 521.6 458.9 502.5 526.5 565.3 598.1 7493.9 7576.5 7682.7 8005.1 8391.5 547.9 588.9 627.1 628.4 628.5 3571.6 3813.0 3840.7 3863.6 3877.8 52158.7 53155.2 53165.5 53178.2 53219.0 45618.8 45734.0 46525.0 46584.8 46639.0 41487.8 42552.1 42720.0 42736.4 42836.8 7307.9 7401.2 8254.4 8346.4 8422.6 31592.2 32096.5 32144.7 33039.2 33593.8 42064.0 42108.8 42113.0 42466.0 42490.0 10331.1 10358.1 10402.4 10419.2 10494.2 11499.4 11552.8 11635.0 11973.8 12052.4 10266.1 10450.3 10627.5 10742.6 10996.7 10302.2 10514.9 10582.5 10716.6 10732.7 9137.5 10108.8 10433.7 10524.0 10601.7 8918.0 9010.9 9167.4 9181.1 9237.9 8049.2 8236.1 8603.2 8855.6 9027.3 12:08:45 INFO - 2015-11-23 12:08:45,845 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:08:45 INFO - 2015-11-23 12:08:45,845 DEBUG : BROWSER_OUTPUT: 12:08:46 INFO - 2015-11-23 12:08:46,525 INFO : Browser exited with error code: 0 12:08:46 INFO - 2015-11-23 12:08:46,542 INFO : Completed test dromaeo_css (00:18:37) 12:08:46 INFO - 2015-11-23 12:08:46,542 INFO : Starting test kraken 12:08:46 INFO - 2015-11-23 12:08:46,542 DEBUG : operating with platform_type : linux_ 12:08:46 INFO - 2015-11-23 12:08:46,542 INFO : Initialising browser for kraken test... 12:08:46 INFO - 2015-11-23 12:08:46,548 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhGDUN/profile http://localhost:44998/getInfo.html 12:08:50 INFO - 2015-11-23 12:08:50,443 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:08:50 INFO - 2015-11-23 12:08:50,443 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:08:50 INFO - 2015-11-23 12:08:50,443 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:08:50 INFO - 2015-11-23 12:08:50,443 DEBUG : BROWSER_OUTPUT: __metrics 12:08:50 INFO - 2015-11-23 12:08:50,531 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:08:51 INFO - 2015-11-23 12:08:51,767 INFO : Browser initialized. 12:08:51 INFO - 2015-11-23 12:08:51,767 INFO : Running cycle 1/1 for kraken test... 12:08:51 INFO - 2015-11-23 12:08:51,767 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhGDUN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:03 INFO - 2015-11-23 12:09:03,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 12:09:03 INFO - 2015-11-23 12:09:03,666 DEBUG : BROWSER_OUTPUT: 12:09:06 INFO - 2015-11-23 12:09:06,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:06 INFO - 2015-11-23 12:09:06,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 176922624 12:09:06 INFO - 2015-11-23 12:09:06,893 DEBUG : BROWSER_OUTPUT: 12:09:09 INFO - 2015-11-23 12:09:09,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-dft) 12:09:10 INFO - 2015-11-23 12:09:10,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 168599552 12:09:10 INFO - 2015-11-23 12:09:10,172 DEBUG : BROWSER_OUTPUT: 12:09:13 INFO - 2015-11-23 12:09:13,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-fft) 12:09:13 INFO - 2015-11-23 12:09:13,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 151072768 12:09:13 INFO - 2015-11-23 12:09:13,779 DEBUG : BROWSER_OUTPUT: 12:09:15 INFO - 2015-11-23 12:09:15,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-oscillator) 12:09:16 INFO - 2015-11-23 12:09:16,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 154546176 12:09:16 INFO - 2015-11-23 12:09:16,417 DEBUG : BROWSER_OUTPUT: 12:09:18 INFO - 2015-11-23 12:09:18,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:19 INFO - 2015-11-23 12:09:19,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 156614656 12:09:19 INFO - 2015-11-23 12:09:19,206 DEBUG : BROWSER_OUTPUT: 12:09:22 INFO - 2015-11-23 12:09:22,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:22 INFO - 2015-11-23 12:09:22,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 155824128 12:09:22 INFO - 2015-11-23 12:09:22,769 DEBUG : BROWSER_OUTPUT: 12:09:26 INFO - 2015-11-23 12:09:26,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:26 INFO - 2015-11-23 12:09:26,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 157782016 12:09:26 INFO - 2015-11-23 12:09:26,755 DEBUG : BROWSER_OUTPUT: 12:09:29 INFO - 2015-11-23 12:09:29,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44998/tests/kraken/driver.html?testName=json-parse-financial) 12:09:30 INFO - 2015-11-23 12:09:30,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 156569600 12:09:30 INFO - 2015-11-23 12:09:30,142 DEBUG : BROWSER_OUTPUT: 12:09:31 INFO - 2015-11-23 12:09:31,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:32 INFO - 2015-11-23 12:09:32,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 166604800 12:09:32 INFO - 2015-11-23 12:09:32,445 DEBUG : BROWSER_OUTPUT: 12:09:34 INFO - 2015-11-23 12:09:34,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:34 INFO - 2015-11-23 12:09:34,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 166944768 12:09:34 INFO - 2015-11-23 12:09:34,930 DEBUG : BROWSER_OUTPUT: 12:09:37 INFO - 2015-11-23 12:09:37,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:37 INFO - 2015-11-23 12:09:37,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 173662208 12:09:37 INFO - 2015-11-23 12:09:37,657 DEBUG : BROWSER_OUTPUT: 12:09:40 INFO - 2015-11-23 12:09:40,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:40 INFO - 2015-11-23 12:09:40,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 182788096 12:09:40 INFO - 2015-11-23 12:09:40,764 DEBUG : BROWSER_OUTPUT: 12:09:43 INFO - 2015-11-23 12:09:43,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:43 INFO - 2015-11-23 12:09:43,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 179564544 12:09:43 INFO - 2015-11-23 12:09:43,933 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44998/tests/kraken/driver.html?testName=ai-astar) 12:09:45 INFO - 2015-11-23 12:09:45,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 238743552 12:09:45 INFO - 2015-11-23 12:09:45,947 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,951 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:45 INFO - 2015-11-23 12:09:45,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:45 INFO - 2015-11-23 12:09:45,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:45 INFO - 2015-11-23 12:09:45,951 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;107;114;112;114;102;113;116;114 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;134;154;169;131;153;158;130;171;130 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;163;160;161;163;163;161;161;162 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;81;91;74;73;73;123;91;73 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;127;91;91;93;128;91;92;132 12:09:45 INFO - 2015-11-23 12:09:45,952 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;109;110;109;110;110;109 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;148;147;147;148;148;147;146 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;96;95;95 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;69;70;70;70;69;79;65;67 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;69;70;69;69;69 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;85;82;87;82;83;84;89;81 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;117;127;130;134;122;126;128;115;122 12:09:45 INFO - 2015-11-23 12:09:45,953 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;146;150;146;146;134;146;144;145;138 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;69;70;70;68;70;67;69 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,973 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309385949__endTimestamp 12:09:45 INFO - 2015-11-23 12:09:45,954 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:4.14 (3.6%) stddev-sans-first:4.39 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 107.0 114.0 112.0 114.0 102.0 113.0 116.0 114.0 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.10 Median:153.50 stddev:15.89 (10.4%) stddev-sans-first:16.82 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: Values: 151.0 134.0 154.0 169.0 131.0 153.0 158.0 130.0 171.0 130.0 12:09:45 INFO - 2015-11-23 12:09:45,958 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 163.0 160.0 161.0 163.0 163.0 161.0 161.0 162.0 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:15.96 (21.6%) stddev-sans-first:16.62 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 81.0 91.0 74.0 73.0 73.0 123.0 91.0 73.0 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:91.50 stddev:18.06 (19.7%) stddev-sans-first:18.72 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 127.0 91.0 91.0 93.0 128.0 91.0 92.0 132.0 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:09:45 INFO - 2015-11-23 12:09:45,959 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 148.0 147.0 147.0 148.0 148.0 147.0 146.0 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,960 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:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.70 Median:69.50 stddev:3.62 (5.2%) stddev-sans-first:3.83 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 70.0 70.0 69.0 79.0 65.0 67.0 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 12:09:45 INFO - 2015-11-23 12:09:45,960 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.53 (3.0%) stddev-sans-first:2.67 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 85.0 82.0 87.0 82.0 83.0 84.0 89.0 81.0 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:127.50 stddev:5.88 (4.6%) stddev-sans-first:6.13 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: Values: 128.0 117.0 127.0 130.0 134.0 122.0 126.0 128.0 115.0 122.0 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:146.00 stddev:4.69 (3.2%) stddev-sans-first:4.86 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 150.0 146.0 146.0 134.0 146.0 144.0 145.0 138.0 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,961 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.05 (1.5%) stddev-sans-first:1.05 12:09:45 INFO - 2015-11-23 12:09:45,962 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 70.0 70.0 68.0 70.0 67.0 69.0 12:09:45 INFO - 2015-11-23 12:09:45,962 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:45 INFO - 2015-11-23 12:09:45,962 DEBUG : BROWSER_OUTPUT: 12:09:46 INFO - 2015-11-23 12:09:46,869 INFO : Browser exited with error code: 0 12:09:46 INFO - 2015-11-23 12:09:46,921 INFO : Completed test kraken (00:01:00) 12:09:46 INFO - 2015-11-23 12:09:46,921 INFO : Starting test v8_7 12:09:46 INFO - 2015-11-23 12:09:46,921 DEBUG : operating with platform_type : linux_ 12:09:46 INFO - 2015-11-23 12:09:46,921 INFO : Initialising browser for v8_7 test... 12:09:46 INFO - 2015-11-23 12:09:46,927 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCfCjC9/profile http://localhost:44998/getInfo.html 12:09:50 INFO - 2015-11-23 12:09:50,883 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:50 INFO - 2015-11-23 12:09:50,884 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:50 INFO - 2015-11-23 12:09:50,884 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:09:50 INFO - 2015-11-23 12:09:50,884 DEBUG : BROWSER_OUTPUT: __metrics 12:09:51 INFO - 2015-11-23 12:09:51,001 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:52 INFO - 2015-11-23 12:09:52,196 INFO : Browser initialized. 12:09:52 INFO - 2015-11-23 12:09:52,197 INFO : Running cycle 1/1 for v8_7 test... 12:09:52 INFO - 2015-11-23 12:09:52,197 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCfCjC9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:04 INFO - 2015-11-23 12:10:04,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 142290944 12:10:04 INFO - 2015-11-23 12:10:04,133 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44998/tests/v8_7/run.html (next: http://localhost:44998/tests/v8_7/run.html) 12:10:25 INFO - 2015-11-23 12:10:25,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 463507456 12:10:25 INFO - 2015-11-23 12:10:25,811 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,812 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:25 INFO - 2015-11-23 12:10:25,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:25 INFO - 2015-11-23 12:10:25,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:25 INFO - 2015-11-23 12:10:25,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |0;Richards;162.65452179570593 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.0860545524395 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 12:10:25 INFO - 2015-11-23 12:10:25,813 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: |6;Boyer;12658.227848101265 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: |7;RegExp;27888.88888888889 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: |8;Splay;616.1429451632779 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:25 INFO - 2015-11-23 12:10:25,814 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309425809__endTimestamp 12:10:25 INFO - 2015-11-23 12:10:25,815 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,815 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:25 INFO - 2015-11-23 12:10:25,815 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:10:25 INFO - 2015-11-23 12:10:25,815 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,815 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.65 Median:162.65 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: Values: 162.7 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: Values: 192.1 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,816 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,817 DEBUG : BROWSER_OUTPUT: Values: 280.0 12:10:25 INFO - 2015-11-23 12:10:25,817 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,817 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,817 DEBUG : BROWSER_OUTPUT: Values: 5035.2 12:10:25 INFO - 2015-11-23 12:10:25,817 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,818 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,818 DEBUG : BROWSER_OUTPUT: Values: 2002.0 12:10:25 INFO - 2015-11-23 12:10:25,818 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,818 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,818 DEBUG : BROWSER_OUTPUT: Values: 791.1 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12658.23 Median:12658.23 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: Values: 12658.2 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27888.89 Median:27888.89 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: Values: 27888.9 12:10:25 INFO - 2015-11-23 12:10:25,819 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.14 Median:616.14 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: Values: 616.1 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: Values: 4835.7 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:25 INFO - 2015-11-23 12:10:25,820 DEBUG : BROWSER_OUTPUT: 12:10:26 INFO - 2015-11-23 12:10:26,705 INFO : Browser exited with error code: 0 12:10:26 INFO - 2015-11-23 12:10:26,722 INFO : Completed test v8_7 (00:00:39) 12:10:26 INFO - 2015-11-23 12:10:26,808 INFO : Completed test suite (00:20:17) 12:10:26 INFO - 2015-11-23 12:10:26,808 DEBUG : Working with test: dromaeo_css 12:10:26 INFO - 2015-11-23 12:10:26,808 DEBUG : Generating results file: dromaeo_css 12:10:26 INFO - 2015-11-23 12:10:26,810 DEBUG : Working with test: kraken 12:10:26 INFO - 2015-11-23 12:10:26,810 DEBUG : Generating results file: kraken 12:10:26 INFO - 2015-11-23 12:10:26,810 INFO : javascript benchmark 12:10:26 INFO - 2015-11-23 12:10:26,810 DEBUG : Working with test: v8_7 12:10:26 INFO - 2015-11-23 12:10:26,810 DEBUG : Generating results file: v8_7 12:10:26 INFO - 2015-11-23 12:10:26,811 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:26 INFO - 2015-11-23 12:10:26,878 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:10:26 INFO - 2015-11-23 12:10:26,878 DEBUG : process_Request line: dromaeo_css 6313.70 graph.html#tests=[[72,132,35]] 12:10:26 INFO - 2015-11-23 12:10:26,878 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:26 INFO - 2015-11-23 12:10:26,913 DEBUG : process_Request line: kraken 1519.90 graph.html#tests=[[232,132,35]] 12:10:26 INFO - 2015-11-23 12:10:26,914 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:27 INFO - 2015-11-23 12:10:27,024 DEBUG : process_Request line: v8_7 19629.97 graph.html#tests=[[230,132,35]] 12:10:27 INFO - 2015-11-23 12:10:27,025 INFO : javascript benchmark 12:10:27 INFO - 2015-11-23 12:10:27,029 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2639.9868000659994, 2740.0, 2755.8070935034557, 2768.5708715149144, 2776.4030733392324, 4421.292593185091, 4556.270996640538, 4683.1804434224005, 4741.359916411284, 4745.738984355863, 4571.9314210286875, 4589.518100599439, 4639.280911458721, 4643.698159619622, 4654.418197725285, 4288.0351920817875, 4332.220200363933, 4349.304111342194, 4487.663425243103, 4500.0, 4174.749515029092, 4403.603675669189, 4442.289233722605, 4502.842400515982, 4526.207913615121, 4241.1093670329265, 4252.8511502097435, 4295.548967358445, 4301.032267739764, 4338.739675619473, 4329.805158767863, 4336.696431249814, 4340.978295108536, 4349.891252718676, 4368.301071828492, 4159.729617574878, 4251.4685664291965, 4311.137772445492, 4325.091730736549, 4363.890902727426, 4525.954740452619, 4554.658400619934, 4628.32889231063, 4633.6988095774, 4634.536546345372, 5111.821086261963, 5156.948430515685, 5158.277841102249, 5164.664296820694, 5170.069387510247, 5158.767855446514, 5173.405058418292, 5177.430482646906, 5186.092433824104, 5225.921611175835, 4561.908761824778, 4639.791209395586, 4685.20351540239, 4689.6717229793585, 4742.549457801503, 5198.298229738937, 5261.947610477843, 5263.473652634706, 5263.868403289948, 5265.973670131625, 5035.1188542005, 5062.468440813662, 5065.974670126626, 5066.240063990431, 5106.770195341219, 4849.539293767087, 4949.7772600233075, 4952.504749525018, 4955.90088198234, 4958.033183529177, 4991.0, 4999.875003124878, 5004.449510553836, 5019.774110164978, 5041.420236672756, 4977.527134922177, 4982.128127577732, 4983.6013118950395, 4983.9252411213865, 5038.294638750578, 3992.86024989124, 4080.18396320737, 4086.979565102215, 4206.8737937861915, 4213.199492096492, 3641.9453708194396, 3685.94471082934, 3698.6301369863336, 3721.4789929409903, 3738.5513738351574, 4373.300271956536, 4402.581754733295, 4402.779861006937, 4403.493598236244, 4443.4445694288215, 4800.543948324904, 4904.190808516626, 4912.72979986097, 5108.514691104339, 5149.536541711264, 4233.5554766749665, 4305.332673435622, 4309.3966844641145, 4331.610155086058, 4349.064951035542, 4488.730676159375, 4491.955080449219, 4502.707324023928, 4516.525764794715, 4544.863654090383, 4624.237000894949, 4768.57082862544, 4777.020710754217, 4826.493218212037, 4837.274408838632, 4863.975680121577, 4928.310036594808, 4948.233023881304, 4951.653384263067, 4985.675931064469, 4774.880627984189, 4801.639877009168, 4807.351007614067, 4843.346148269939, 4848.981713840133, 4732.479427263067, 4821.879453013562, 4837.201861692782, 4972.900541989212, 5044.344235249394, 4925.605951523941, 4986.775595098156, 4989.925151122663, 5005.149124648746, 5040.974795126001, 4858.732769697701, 4869.0, 4877.6585639004925, 4877.853664390074, 4910.091633047898, 4709.128811169808, 4810.56704896547, 4846.055019271208, 4857.635677324144, 4904.362432883702, 4712.222483290218, 4730.526947305242, 4843.24929635907, 4854.83008094715, 4875.317455556154, 4910.8281210157475, 4914.9017019658695, 4917.58200552957, 4925.433575138905, 4937.23472861707, 4798.904021919612, 4809.591184749335, 4814.566688998007, 4819.831305904277, 4846.442659094249], "unit": "ms", "name": "dojo.html", "value": 4612.74815625987}, {"lowerIsBetter": false, "replicates": [548.1873616014968, 572.5820151289556, 575.7006356694519, 588.1501230721607, 588.3616276340168, 27770.16689499316, 36724.81637591815, 37462.8126859366, 37561.624383756156, 37589.62410375896, 40543.39184912229, 41024.0, 41243.22594836718, 41258.79370603143, 41337.17325653485, 6964.825879353031, 7082.752103676372, 7899.802504937379, 8088.676452941875, 9908.653197138101, 10049.095581397673, 10178.745531361737, 10186.083252507273, 10189.08298253157, 10195.541200645952, 10115.696529104138, 10220.0, 10230.744231394201, 10233.795324093551, 10235.641752538662, 6897.344752248553, 7112.182099058597, 10250.7437314067, 10490.527926243338, 10503.527341269584, 9967.700968970943, 10103.19174466041, 10104.646337378157, 10117.848232276521, 10118.443485608288, 37900.43149352762, 38388.23223535542, 38416.61583384186, 38521.0, 38539.0, 2743.0262256898714, 2845.573164025392, 2903.41931613676, 2957.955630665542, 3018.7886847920654, 28292.018415217553, 28897.855510722522, 28901.421971560452, 28927.276818079506, 29236.122916312546, 3337.149026998124, 3349.5645566076496, 3397.082787647346, 3399.048266485388, 3483.9303213935577, 237936.5341252813, 238538.0, 239137.0, 239172.0, 239963.99999999825, 56296.718516407156, 56497.15254271189, 56613.0, 56634.0, 56701.716491418105, 50199.49800501948, 51872.40637968086, 59422.40577594169, 61134.0, 61141.694291528256, 12840.61478155657, 13089.934550327187, 13094.476220951055, 13115.803262951064, 13160.0, 10057.0, 10121.746956326004, 10181.847272290921, 10200.795984080425, 10202.387856728472, 18815.529611759543, 19062.428127156207, 19142.521436964187, 19169.52076198106, 19179.712304315446, 7493.826790230881, 7853.41099417546, 7853.8821917671285, 7862.174471680506, 7899.723509677134, 783.2285199078902, 783.5807842804187, 842.7219017724136, 903.9548022598843, 996.7508122969258, 26350.86824565865, 27143.86428067847, 28405.289867753472, 28519.0, 29077.0, 897.8967418746797, 916.5234078279391, 924.1220840201835, 972.4991629310911, 1031.3554028732042, 12569.811452828215, 12596.874031259571, 12600.495980160875, 12612.36938153107, 12626.368681565886, 281924.0, 285624.0, 285713.0, 285924.0, 285949.0, 46269.0, 46546.5345346549, 46689.0, 46695.0, 46699.76650116728, 1217.3061355027548, 1218.0925210717894, 1232.8274041634359, 1233.0505510756668, 1236.2397125767588, 22158.446038849157, 22428.439289017904, 22483.887580561994, 22680.886595566917, 22739.545209096057, 37079.6292037087, 37585.4362184562, 46430.53569464262, 48113.759431204024, 48291.75854120707, 217940.0, 218276.0, 219425.0, 219859.0, 220074.0, 24246.87876560606, 24914.0, 27962.58056129119, 28337.716622833508, 28338.2915427116, 37608.0, 38127.0, 39846.2030759389, 40907.0, 42153.78923105488, 30843.383132337676, 31341.373172536878, 31972.20069498281, 32294.35411291808, 32481.0, 32271.0, 32475.512867306537, 32486.83756581202, 32638.83680581582, 32684.673153268162, 31844.36311273808, 32282.19294517562, 32478.512822307213, 32578.511322330658, 32699.509507357885, 28628.85685571642, 29154.0, 29663.258418538844, 29865.402691946474, 30677.693223067483, 20451.79548204499, 20651.4837129073, 20720.896395517924, 20767.0, 20819.583608327444], "unit": "ms", "name": "ext.html", "value": 17067.641526066447}, {"lowerIsBetter": false, "replicates": [324.07338373370317, 327.11678468136034, 329.91786938840596, 332.9750268729846, 337.43479671550165, 11699.766004679923, 12148.149629525937, 14915.477958271462, 15430.614234644125, 15618.687626247482, 13112.93443532781, 13526.594202173927, 13789.793153102686, 14446.927765361159, 14542.854571454282, 4320.351947207921, 4908.877278068059, 5061.44324124346, 5065.442801291855, 5068.1890897456415, 3553.6091029986683, 3659.359612067891, 5012.72430016349, 5441.891162176774, 5610.24261724666, 5517.779288828442, 5532.861678458031, 5532.889342213153, 5556.305461817273, 5566.8608284793, 5486.177073438977, 5523.337199536061, 5608.915866262009, 5648.8870222595315, 5656.038473459522, 4971.875703107415, 4974.37820272466, 4978.377702787152, 4979.825706100305, 4981.227909674007, 18739.250429982785, 18908.527286817938, 19320.13059412316, 19320.71018934717, 19342.613147737105, 1903.5431496440892, 1951.658459769549, 1978.3669225847734, 1980.960380792376, 1987.1455274232073, 12425.378731063502, 12561.74876502474, 12562.371881405985, 12593.118481706284, 13020.218786872818, 1682.7055265328518, 1690.1887094194856, 1750.1949103412446, 1786.0355408079622, 1786.928522859084, 51202.16998913027, 53275.46724532744, 53376.73311633456, 53505.73247133778, 53569.1964620531, 9078.954605227063, 9220.7694807629, 9341.299402544837, 9341.346105772667, 9416.952915235517, 11834.88165118355, 11849.703757406134, 11857.940710296394, 11864.050875929905, 11864.525418983316, 6769.8646027079185, 6779.898301525481, 6882.793516194522, 6892.414744608768, 6974.930250697428, 6560.278369379364, 6636.037774522667, 6655.733770649216, 6703.597784132968, 6704.698288577026, 5559.332880054339, 5644.689542075225, 5654.208410822488, 5682.602217844794, 5694.515966142924, 1534.1562140822725, 1575.8187808401951, 1589.348367169455, 1600.5198440468046, 1656.8177500474937, 801.4069588504581, 825.7976795685096, 828.5070383122032, 844.50174397106, 851.4550687559966, 14891.70216595662, 15634.843651563566, 15762.448314308944, 15933.601659958595, 15994.120323382092, 728.9830686192837, 807.6990028100389, 814.0503494131522, 832.8375966686559, 843.6667516331015, 8381.748547543584, 8605.26855217301, 8626.654933802578, 8648.78378040554, 8778.341624378198, 513457.0, 520264.0, 524018.0, 526277.0, 528689.0, 66846.66576667085, 68788.0, 69412.3058769416, 69454.65272673604, 69903.30096699069, 1088.5645741703381, 1088.7223757941674, 1147.1969621265148, 1156.8380426740264, 1164.1850704506878, 13366.93316533411, 13439.664008399868, 14126.223057731924, 14178.503752368617, 14218.360173792411, 29329.853350733963, 29383.971560996117, 30378.544321834746, 31665.366692666477, 32026.356178354476, 35281.0, 36108.45837312495, 36412.4538131923, 36461.817690911375, 36646.0, 8609.139086091342, 8709.825803483767, 8850.822983540422, 8989.235914947303, 9003.234725048182, 15557.688846223238, 15686.843131568538, 15880.761788572949, 15979.520614381587, 16195.190240488164, 13162.736745264849, 13215.273159976294, 13300.401481933142, 13331.266780327174, 13787.0, 12908.41912113976, 13044.869551304366, 13267.872230860485, 13574.0, 13700.588982330546, 10323.48382580853, 13112.475500979854, 13698.178109313472, 14028.719425611635, 14141.505047323295, 8423.0, 8603.225709686158, 8749.693760718344, 8762.079981602095, 8773.078826723102, 12406.25562466255, 12785.424655890321, 13029.609111726664, 13046.804297935729, 13255.072144949761], "unit": "ms", "name": "jquery.html", "value": 8231.51106344352}, {"lowerIsBetter": false, "replicates": [1411.054593422407, 1619.8866079374443, 1641.1548052752835, 1684.7894013248344, 1690.5520037190147, 5721.25623668923, 6506.0, 6707.564008339455, 6708.530402871801, 6714.362135597116, 6604.3395660433935, 6807.387335139836, 6810.421114205298, 6810.489213308997, 6813.3527314905, 2086.968695469569, 2112.7464704235513, 2113.9894300528554, 2114.8202402795705, 2115.6614941609346, 2060.9515457136554, 2063.484128967758, 2072.637288474511, 2072.8963551822426, 2073.4712648274667, 2064.3394113883564, 2076.4289820299464, 2084.6977188307687, 2085.5620319732875, 2088.1647341063544, 2066.5143691232547, 2074.1392322186275, 2075.0247383729625, 2076.294060019593, 2077.314486219544, 2059.6395630764705, 2072.5336799220054, 2088.571842772228, 2089.268755935426, 2093.445237012193, 5721.284839395075, 5903.881922361572, 6705.798826035227, 6745.8650826983185, 6752.054712340277, 3897.7856217908, 4017.7589344639414, 4023.114914718757, 4027.1140349123148, 4029.5567487576345, 2767.9861600691866, 2770.4182121754457, 2831.688514263429, 2837.815541989764, 2856.685764565896, 852.1989330029814, 856.7344123321728, 868.6916144768579, 884.5709830732154, 886.4814083761007, 8916.643334266622, 8955.37312388133, 8994.595243214071, 8995.280377569845, 9008.864867027065, 3923.7645741255046, 3953.327934251127, 3981.7212795104065, 3999.420084087791, 4005.4192142139227, 8009.959950200328, 8020.0, 8020.438569300093, 8027.0, 8035.758927232192, 4233.97883010583, 4248.787560621957, 4250.128723611714, 4251.192273468031, 4257.318828987409, 3818.8090595470117, 3823.598522155189, 3825.9043523912123, 3829.7319187657154, 3831.616838316146, 3259.222333000997, 3266.1508007917637, 3273.967260327414, 3284.917877053093, 3299.472084466474, 1042.9582816687248, 1061.7823346214007, 1065.674969134406, 1067.6583493282076, 1077.0683358894657, 855.7176131876466, 907.7503686486269, 1163.0230606290588, 1181.2203945395997, 1183.7869183547043, 6347.206599175103, 6378.52161087911, 6413.518986076063, 6446.000869865178, 6449.0, 930.0652843891845, 934.5047125023748, 970.9174720148725, 1011.5346940407347, 1021.5913634546241, 4761.166795810719, 5059.19052951526, 5121.334226550524, 5138.2292656101135, 5139.177731562932, 7239.963800180965, 7810.101838288556, 7908.604569771488, 7933.404994625426, 7999.4400391972, 7685.846283074307, 7705.113911900091, 7787.29914307715, 7795.674735295013, 7809.765707028798, 6090.086487026982, 6200.844978875564, 6252.343503932022, 6259.436650701458, 6280.246370435577, 6275.874482510233, 6276.246850377984, 6280.560360774702, 6288.591241569284, 6299.338569450325, 6940.7917762467205, 7065.788026359218, 7144.892826607501, 7153.499255052305, 7159.105111861018, 7176.246494118252, 7307.3423391894985, 7310.634468276671, 7381.667824947783, 7405.2224516425, 5623.3533143689, 5695.658260504383, 5703.344115426779, 5703.572232082527, 5725.198472213977, 6530.47756179495, 6635.668216589248, 6643.56816806906, 6654.0, 6669.6665166740495, 6063.818085457443, 6131.754729810936, 6132.938670613236, 6196.442320191204, 6313.810585682437, 5908.143319218603, 6172.629642221481, 6224.595401298901, 6227.595206311576, 6234.563580549318, 6175.289841668086, 6222.0, 6254.0, 6264.060390941213, 6274.121622972696, 5634.661920284796, 5655.547556195576, 5666.801661941812, 5667.574931880043, 5669.489745922887, 5834.095715164156, 5891.05743081105, 5930.495907847709, 5931.228940237742, 5934.465898069195], "unit": "ms", "name": "mootools.html", "value": 3963.3836013936443}, {"lowerIsBetter": false, "replicates": [313.1857171354479, 320.88929319384806, 322.82728740124037, 324.9203945033467, 326.31148277135253, 5376.301080859487, 5387.784488620456, 5406.378266499354, 5415.350157981038, 5445.801923576817, 5097.286379906816, 5223.962654564713, 5295.126304159819, 5393.164059570763, 5414.702191379472, 4255.212785634652, 4257.020885196407, 4269.0394661201135, 4273.764942928137, 4275.636570891478, 4021.7586944783407, 4262.254105531535, 4265.466816647919, 4270.572942705736, 4284.2930916398755, 4034.253663072326, 4081.1021575253544, 4122.752634841919, 4172.561881002496, 4195.748255104703, 4162.854300099482, 4173.707840451169, 4178.6448151907125, 4182.2890108681295, 4186.0, 3652.3060618482405, 3655.5065066215984, 3656.744027918047, 3657.3599620066384, 3667.3032123896373, 5217.426083130853, 5240.68555886648, 5244.187150991603, 5248.632595718302, 5263.815766448156, 4706.3411122442885, 4830.154722923509, 4835.492273311322, 4864.586510146642, 4868.78090485929, 5745.109508026263, 5749.367569567345, 5751.798687045934, 5762.510186634141, 5762.798302059449, 4008.3586626139677, 4008.4788977432745, 4011.3180759270995, 4012.7592344459135, 4013.137175507251, 5979.19280897082, 6055.303640081359, 6060.090986351995, 6069.57512974092, 6071.362506936796, 4083.7753923533896, 4122.381642753611, 4124.587541245912, 4134.111166099303, 4137.40007698888, 4175.916481670411, 4186.016286172747, 4188.141431006637, 4191.0, 4191.140816132685, 4785.928211076836, 4790.4251489821445, 4791.736454495036, 4792.616590672737, 4796.856094317176, 5703.458171473703, 5713.6857472838565, 5733.512651424592, 5735.369109397963, 5736.942630573641, 1430.5708287513705, 1452.0561634937376, 1476.0258229568433, 1476.1364601707905, 1479.3121198642468, 974.9025097490336, 984.3798407003542, 993.4933184076173, 994.8806143262855, 996.7358649957768, 4964.329815474937, 5021.221710634857, 5025.195968645073, 5025.79896804131, 5027.296178535008, 5923.644581325134, 5929.73316200772, 5930.169776231331, 5931.288245410578, 5934.762609495659, 4857.757112144449, 4896.314515967767, 5007.298978143063, 5013.623978201576, 5082.415522214918, 3201.7278531325096, 3206.7915585486867, 3232.884654794092, 3235.4014507316224, 3240.7893486923745, 5672.517835983905, 5675.290588676416, 5676.914846277309, 5677.801276955287, 5679.119736440858, 6047.818565443044, 6188.226471691039, 6189.071639254058, 6189.102580125947, 6192.938070619236, 5670.319561652628, 5683.60214784961, 5683.914741278884, 5687.919295333956, 5691.089425691869, 6015.969920150371, 6019.849503762441, 6021.638701677914, 6022.337542870193, 6028.246469191351, 5876.6180198286975, 5878.0, 5878.882422351615, 5882.264716910387, 5887.4406931341455, 5510.834674959758, 5667.206591077335, 5668.121441176624, 5674.404187560247, 5677.659340439587, 4102.0, 4104.076582768973, 4107.54816970139, 4108.239975604522, 4111.362738775495, 5996.940030599638, 5997.280326360865, 6007.0, 6007.609505382136, 6008.54935879802, 5578.414266501959, 5763.711814409179, 5776.422357764358, 5779.826605201851, 5780.884382312414, 5764.827055188351, 5766.481016708516, 5767.653940763567, 5773.884522309614, 5774.39368866263, 5615.522680572197, 5621.128725047624, 5624.072028115479, 5625.971870140623, 5632.549396048388, 5638.407967163389, 5757.510611598061, 5806.82579522615, 5811.389804070512, 5813.738381772746, 5694.430556944272, 5697.287839020122, 5701.945140149086, 5702.087665973424, 5704.9429505706075], "unit": "ms", "name": "prototype.html", "value": 4314.380545174913}, {"lowerIsBetter": false, "replicates": [644.5971267957526, 704.9707427156352, 766.6894907562436, 782.3271986091962, 783.150281944091, 11337.26307789993, 11589.594364197255, 11602.767944641113, 11603.303801771899, 11614.941925290372, 11884.7623047539, 11965.102617303715, 11966.042716582675, 11976.64070077897, 11977.700557486067, 771.3096778383343, 813.8209593889335, 816.1715858403695, 816.3632366753941, 816.7590560784582, 607.0045125993353, 623.4233334165901, 623.915771370866, 759.4038679636486, 805.3597390074875, 829.1211316005024, 830.2154464031493, 836.9497830130211, 837.2548431895618, 837.811492414208, 834.2408408348374, 834.3742193354984, 835.2399316621845, 835.4820011592791, 835.5154010673825, 461.63761447264073, 474.79109191955774, 475.3084262398237, 583.7227317024422, 619.9628022318675, 10387.792244155151, 10520.053195212391, 10541.367517948871, 10573.73565660857, 10584.100351470135, 11353.602623908206, 11436.142289328334, 11451.942740286246, 11456.140789440742, 11511.654650360419, 9187.724368268962, 9222.30832687551, 9326.533673316308, 9419.48192849393, 9466.90533094667, 3313.1385839681616, 3340.1148695595684, 3340.8496617652263, 3344.615369232545, 3344.715699165574, 41141.38287925684, 41550.1689966199, 41550.58449415528, 41562.168756625004, 41615.37576936348, 9079.45523268606, 9149.0, 9249.90750092504, 9318.813623727487, 9447.433154010781, 15602.141882196362, 15699.450519231772, 15881.0, 15932.601684957737, 15939.123348215959, 5991.700414979321, 6445.6454894981225, 6482.319356467598, 6492.156019717407, 6678.065070890079, 3601.513795637608, 3659.5425571803526, 3684.4657524658774, 3688.133288677159, 3692.1508053147927, 2709.9729002710114, 2737.630419893329, 2742.561190209557, 2745.08039806663, 2751.312171957011, 495.5341978540161, 497.9377577802775, 506.3164727617687, 516.6796586116557, 521.5801279969661, 458.86922227165763, 502.4924825925841, 526.5103453787938, 565.3187908570245, 598.1237487081446, 7493.925060749431, 7576.507527010726, 7682.654280557388, 8005.079415867133, 8391.538465384341, 547.9232907392968, 588.8733922206746, 627.0969803482969, 628.3936001758325, 628.5286035473395, 3571.5535558055244, 3813.0276779421624, 3840.71194660396, 3863.555691095504, 3877.786721730332, 52158.739206303726, 53155.20267195995, 53165.468345316054, 53178.202326965125, 53219.0, 45618.77190614092, 45734.0, 46525.0, 46584.767076164404, 46639.0, 41487.792561037, 42552.14895702131, 42720.0, 42736.35895461571, 42836.78581607072, 7307.853842923006, 7401.22287159862, 8254.42219044661, 8346.386995071962, 8422.6209820557, 31592.210194745316, 32096.518552221267, 32144.678553215104, 33039.174020649676, 33593.83203083969, 42064.0, 42108.789456052524, 42113.0, 42466.0, 42490.0, 10331.121854642439, 10358.119559837196, 10402.375857448576, 10419.166466682496, 10494.160467162455, 11499.425028748696, 11552.82670759956, 11635.01102406305, 11973.820392694292, 12052.397380131133, 10266.127379172554, 10450.268481206547, 10627.468626568487, 10742.624008159677, 10996.725081873017, 10302.175825934057, 10514.894851051391, 10582.50358086316, 10716.624918127829, 10732.73168170802, 9137.543122843965, 10108.848367274644, 10433.739156520844, 10524.0, 10601.681949541526, 8918.0, 9010.90989090127, 9167.358284920258, 9181.127792859668, 9237.907620923705, 8049.195080492138, 8236.135205803304, 8603.225709686158, 8855.60149793248, 9027.277817774693], "unit": "ms", "name": "yui.html", "value": 5715.608939477454}], "name": "dromaeo_css", "value": 6313.705046889292}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 107.0, 114.0, 112.0, 114.0, 102.0, 113.0, 116.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 154.0, 169.0, 131.0, 153.0, 158.0, 130.0, 171.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 160.0, 161.0, 163.0, 163.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 81.0, 91.0, 74.0, 73.0, 73.0, 123.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 127.0, 91.0, 91.0, 93.0, 128.0, 91.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 102.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.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, 70.0, 70.0, 70.0, 69.0, 79.0, 65.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 85.0, 82.0, 87.0, 82.0, 83.0, 84.0, 89.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [128.0, 117.0, 127.0, 130.0, 134.0, 122.0, 126.0, 128.0, 115.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 150.0, 146.0, 146.0, 134.0, 146.0, 144.0, 145.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 70.0, 70.0, 68.0, 70.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1519.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.65452179570593], "unit": "score", "name": "Richards", "value": 217.03669599999998}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12658.227848101265], "unit": "score", "name": "Boyer", "value": 52.65057700000003}, {"lowerIsBetter": false, "replicates": [27888.88888888889], "unit": "score", "name": "RegExp", "value": 32.66480079681274}, {"lowerIsBetter": false, "replicates": [616.1429451632779], "unit": "score", "name": "Splay", "value": 132.25989299999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19629.974314567433}]} 12:10:27 INFO - RETURN: dromaeo_css: 6313.70 12:10:27 INFO - RETURN: kraken: 1519.90 12:10:27 INFO - RETURN: v8_7: 19629.97 12:10:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19629.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6313.70"}}} 12:10:27 INFO - Return code: 0 12:10:27 INFO - # TBPL SUCCESS # 12:10:27 INFO - Running post-action listener: _resource_record_post_action 12:10:27 INFO - Running post-run listener: _resource_record_post_run 12:10:28 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509681664; Read time: 12; Write time: 402188 12:10:28 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 231886848; Read time: 0; Write time: 269208 12:10:28 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 277794816; Read time: 0; Write time: 132980 12:10:28 INFO - Running post-run listener: _upload_blobber_files 12:10:28 INFO - Blob upload gear active. 12:10:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:10:28 INFO - Copying logs to upload dir... 12:10:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.824877 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-23 12:10:27.051969) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:27.055613) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 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.009950 build_url: 'https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:27.111116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:27.111699) ========= 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=5804b9f07a53938c557deee7000001c5-1448302084.302015-1934483188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:27.165160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:27.165830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:27.166623) ========= ========= Total master_lag: 0.29 =========