builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1448035719.61 results: success (0) buildid: 20151120065338 builduid: e91c4c42984246d7b1dea428abd71592 revision: 8cab032fa1e931b6eb294000cb8af0b2393dff0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.612335) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.612841) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.613160) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006387 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.633681) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.634009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.647429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.647740) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.697339) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.697699) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.698128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.698461) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 08:08:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-11-20 08:08:40 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.806436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.806733) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.855806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:39.856180) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cab032fa1e931b6eb294000cb8af0b2393dff0c --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 8cab032fa1e931b6eb294000cb8af0b2393dff0c --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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 08:08:40,120 truncating revision to first 12 chars 2015-11-20 08:08:40,120 Setting DEBUG logging. 2015-11-20 08:08:40,120 attempt 1/10 2015-11-20 08:08:40,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cab032fa1e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 08:08:40,449 unpacking tar archive at: fx-team-8cab032fa1e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:40.462849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:40.463164) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:40.472576) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:40.472882) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 08:08:40.473314) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-20 08:08:40.473605) ========= /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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:40 INFO - MultiFileLogger online at 20151120 08:08:40 in /builds/slave/test 08:08:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:08:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:40 INFO - {'append_to_log': False, 08:08:40 INFO - 'base_work_dir': '/builds/slave/test', 08:08:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:40 INFO - 'branch': 'Fx-Team-Non-PGO', 08:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:40 INFO - 'config_files': ('talos/linux_config.py',), 08:08:40 INFO - 'default_actions': ('clobber', 08:08:40 INFO - 'read-buildbot-config', 08:08:40 INFO - 'download-and-extract', 08:08:40 INFO - 'populate-webroot', 08:08:40 INFO - 'create-virtualenv', 08:08:40 INFO - 'install', 08:08:40 INFO - 'run-tests'), 08:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:40 INFO - 'download_minidump_stackwalk': True, 08:08:40 INFO - 'download_symbols': 'ondemand', 08:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:40 INFO - 'installer_path': 'installer.exe', 08:08:40 INFO - 'log_level': 'info', 08:08:40 INFO - 'log_name': 'talos', 08:08:40 INFO - 'log_to_console': True, 08:08:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:40 INFO - 'opt_config_files': (), 08:08:40 INFO - 'pip_index': False, 08:08:40 INFO - 'sps_profile': False, 08:08:40 INFO - 'sps_profile_interval': 0, 08:08:40 INFO - 'suite': 'dromaeojs', 08:08:40 INFO - 'system_bits': '64', 08:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:40 INFO - 'title': 'talos-linux64-ix-014', 08:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:40 INFO - 'use_talos_json': True, 08:08:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:40 INFO - 'work_dir': 'build'} 08:08:40 INFO - ##### 08:08:40 INFO - ##### Running clobber step. 08:08:40 INFO - ##### 08:08:40 INFO - Running pre-action listener: _resource_record_pre_action 08:08:40 INFO - Running main action method: clobber 08:08:40 INFO - rmtree: /builds/slave/test/build 08:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:41 INFO - Running post-action listener: _resource_record_post_action 08:08:41 INFO - ##### 08:08:41 INFO - ##### Running read-buildbot-config step. 08:08:41 INFO - ##### 08:08:41 INFO - Running pre-action listener: _resource_record_pre_action 08:08:41 INFO - Running main action method: read_buildbot_config 08:08:41 INFO - Using buildbot properties: 08:08:41 INFO - { 08:08:41 INFO - "properties": { 08:08:41 INFO - "buildnumber": 2097, 08:08:41 INFO - "product": "firefox", 08:08:41 INFO - "script_repo_revision": "production", 08:08:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:08:41 INFO - "repository": "", 08:08:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:08:41 INFO - "buildid": "20151120065338", 08:08:41 INFO - "slavename": "talos-linux64-ix-014", 08:08:41 INFO - "pgo_build": "False", 08:08:41 INFO - "basedir": "/builds/slave/test", 08:08:41 INFO - "project": "", 08:08:41 INFO - "platform": "ubuntu64_hw", 08:08:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:08:41 INFO - "slavebuilddir": "test", 08:08:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:08:41 INFO - "branch": "fx-team", 08:08:41 INFO - "repo_path": "integration/fx-team", 08:08:41 INFO - "stage_platform": "linux64", 08:08:41 INFO - "builduid": "e91c4c42984246d7b1dea428abd71592", 08:08:41 INFO - "revision": "8cab032fa1e931b6eb294000cb8af0b2393dff0c" 08:08:41 INFO - }, 08:08:41 INFO - "sourcestamp": { 08:08:41 INFO - "repository": "", 08:08:41 INFO - "hasPatch": false, 08:08:41 INFO - "project": "", 08:08:41 INFO - "branch": "fx-team-linux64-talos", 08:08:41 INFO - "changes": [ 08:08:41 INFO - { 08:08:41 INFO - "category": null, 08:08:41 INFO - "files": [ 08:08:41 INFO - { 08:08:41 INFO - "url": null, 08:08:41 INFO - "name": "https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:08:41 INFO - } 08:08:41 INFO - ], 08:08:41 INFO - "repository": "", 08:08:41 INFO - "rev": "8cab032fa1e931b6eb294000cb8af0b2393dff0c", 08:08:41 INFO - "who": "bgrinstead@mozilla.com", 08:08:41 INFO - "when": 1448035659, 08:08:41 INFO - "number": 6689147, 08:08:41 INFO - "comments": "Bug 1222617 - Filter out service worker messages that happened before a page load;r=bkelly", 08:08:41 INFO - "project": "", 08:08:41 INFO - "at": "Fri 20 Nov 2015 08:07:39", 08:08:41 INFO - "branch": "fx-team-linux64-talos", 08:08:41 INFO - "revlink": "", 08:08:41 INFO - "properties": [ 08:08:41 INFO - [ 08:08:41 INFO - "buildid", 08:08:41 INFO - "20151120065338", 08:08:41 INFO - "Change" 08:08:41 INFO - ], 08:08:41 INFO - [ 08:08:41 INFO - "builduid", 08:08:41 INFO - "e91c4c42984246d7b1dea428abd71592", 08:08:41 INFO - "Change" 08:08:41 INFO - ], 08:08:41 INFO - [ 08:08:41 INFO - "pgo_build", 08:08:41 INFO - "False", 08:08:41 INFO - "Change" 08:08:41 INFO - ] 08:08:41 INFO - ], 08:08:41 INFO - "revision": "8cab032fa1e931b6eb294000cb8af0b2393dff0c" 08:08:41 INFO - } 08:08:41 INFO - ], 08:08:41 INFO - "revision": "8cab032fa1e931b6eb294000cb8af0b2393dff0c" 08:08:41 INFO - } 08:08:41 INFO - } 08:08:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:08:41 INFO - Running post-action listener: _resource_record_post_action 08:08:41 INFO - ##### 08:08:41 INFO - ##### Running download-and-extract step. 08:08:41 INFO - ##### 08:08:41 INFO - Running pre-action listener: _resource_record_pre_action 08:08:41 INFO - Running main action method: download_and_extract 08:08:41 INFO - mkdir: /builds/slave/test/build/tests 08:08: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')]} 08:08:41 INFO - https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/test_packages.json 08:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/test_packages.json 08:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:08:42 INFO - Downloaded 1302 bytes. 08:08:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:08:42 INFO - Using the following test package requirements: 08:08:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'jsshell-linux-x86_64.zip'], 08:08:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:42 INFO - https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:08:44 INFO - Downloaded 21340206 bytes. 08:08:44 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 08:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:44 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 08:08:45 INFO - Return code: 0 08:08:45 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 08:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:45 INFO - https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:09:05 INFO - Downloaded 21340206 bytes. 08:09:05 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 08:09:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:09:05 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 08:09:07 INFO - Return code: 0 08:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:07 INFO - https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:09:15 INFO - Downloaded 11130997 bytes. 08:09:15 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 08:09:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:15 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 08:09:15 INFO - Return code: 0 08:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:15 INFO - https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vx7ItbThRJWHB-rN1aTsvw/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 08:09:16 INFO - Downloaded 55782519 bytes. 08:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:09:16 INFO - mkdir: /builds/slave/test/properties 08:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:16 INFO - Contents: 08:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:09:16 INFO - Running post-action listener: _resource_record_post_action 08:09:16 INFO - Running post-action listener: set_extra_try_arguments 08:09:16 INFO - ##### 08:09:16 INFO - ##### Running populate-webroot step. 08:09:16 INFO - ##### 08:09:16 INFO - Running pre-action listener: _resource_record_pre_action 08:09:16 INFO - Running main action method: populate_webroot 08:09:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:09:16 INFO - '../fennec_ids.txt'], 08:09:16 INFO - 'tests': ['tcheck2']}, 08:09:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:16 INFO - '--tppagecycles', 08:09:16 INFO - '7'], 08:09:16 INFO - 'tests': ['tsvgm']}}, 08:09:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:09:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:09:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'tests': ['damp', 'tps']}, 08:09:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['damp', 'tps']}, 08:09:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:16 INFO - 'other': {'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'other_l64': {'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:16 INFO - 'ts_paint', 08:09:16 INFO - 'tpaint', 08:09:16 INFO - 'sessionrestore', 08:09:16 INFO - 'sessionrestore_no_auto_restore']}, 08:09:16 INFO - 'svgr': {'tests': ['tsvgx', 08:09:16 INFO - 'tsvgr_opacity', 08:09:16 INFO - 'tart', 08:09:16 INFO - 'tscrollx', 08:09:16 INFO - 'cart']}, 08:09:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['tsvgx', 08:09:16 INFO - 'tsvgr_opacity', 08:09:16 INFO - 'tart', 08:09:16 INFO - 'tscrollx', 08:09:16 INFO - 'cart']}, 08:09:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'tests': ['tp5o']}, 08:09:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'talos_options': ['--e10s'], 08:09:16 INFO - 'tests': ['tp5o']}, 08:09:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'talos_options': ['--xperf_path', 08:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:16 INFO - 'tests': ['tp5n']}, 08:09:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:16 INFO - 'talos_options': ['--e10s', 08:09:16 INFO - '--xperf_path', 08:09:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:16 INFO - 'tests': ['tp5n']}}, 08:09:16 INFO - 'talos.zip': {'path': '', 08:09:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:16 INFO - Running post-action listener: _resource_record_post_action 08:09:16 INFO - ##### 08:09:16 INFO - ##### Running create-virtualenv step. 08:09:16 INFO - ##### 08:09:16 INFO - Running pre-action listener: _resource_record_pre_action 08:09:16 INFO - Running main action method: create_virtualenv 08:09:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:16 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 08:09:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:16 INFO - Using real prefix '/usr' 08:09:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:19 INFO - Installing pip.................done. 08:09:19 INFO - Return code: 0 08:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:19 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')]} 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:19 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')]} 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:19 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:19 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 08:09:19 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 08:09:19 INFO - Using env: {'DISPLAY': ':0', 08:09:19 INFO - 'HOME': '/home/cltbld', 08:09:19 INFO - 'LANG': 'en_US.UTF-8', 08:09:19 INFO - 'LANGUAGE': 'en_US:en', 08:09:19 INFO - 'LOGNAME': 'cltbld', 08:09:19 INFO - 'MAIL': '/var/mail/cltbld', 08:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:19 INFO - 'MOZ_NO_REMOTE': '1', 08:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:19 INFO - 'NO_EM_RESTART': '1', 08:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:19 INFO - 'PWD': '/builds/slave/test', 08:09:19 INFO - 'SHELL': '/bin/bash', 08:09:19 INFO - 'SHLVL': '1', 08:09:19 INFO - 'TERM': 'linux', 08:09:19 INFO - 'TMOUT': '86400', 08:09:19 INFO - 'USER': 'cltbld', 08:09:19 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:19 INFO - '_': '/tools/buildbot/bin/python'} 08:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:19 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 08:09:19 INFO - Cleaning up... 08:09:19 INFO - Return code: 0 08:09:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:19 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')]} 08:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:19 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')]} 08:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:19 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:19 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 08:09:19 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 08:09:19 INFO - Using env: {'DISPLAY': ':0', 08:09:19 INFO - 'HOME': '/home/cltbld', 08:09:19 INFO - 'LANG': 'en_US.UTF-8', 08:09:19 INFO - 'LANGUAGE': 'en_US:en', 08:09:19 INFO - 'LOGNAME': 'cltbld', 08:09:19 INFO - 'MAIL': '/var/mail/cltbld', 08:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:19 INFO - 'MOZ_NO_REMOTE': '1', 08:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:19 INFO - 'NO_EM_RESTART': '1', 08:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:19 INFO - 'PWD': '/builds/slave/test', 08:09:19 INFO - 'SHELL': '/bin/bash', 08:09:19 INFO - 'SHLVL': '1', 08:09:19 INFO - 'TERM': 'linux', 08:09:19 INFO - 'TMOUT': '86400', 08:09:19 INFO - 'USER': 'cltbld', 08:09:19 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:19 INFO - '_': '/tools/buildbot/bin/python'} 08:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:19 INFO - Downloading/unpacking psutil>=0.7.1 08:09:19 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 08:09:19 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 08:09:19 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 08:09:19 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 08:09:19 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 08:09:19 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 08:09:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:21 INFO - Installing collected packages: psutil 08:09:21 INFO - Running setup.py install for psutil 08:09:21 INFO - building 'psutil._psutil_linux' extension 08:09:21 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 08:09:21 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 08:09:21 INFO - building 'psutil._psutil_posix' extension 08:09:21 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 08:09:21 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 08:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:21 INFO - Successfully installed psutil 08:09:21 INFO - Cleaning up... 08:09:21 INFO - Return code: 0 08:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:21 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:21 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 08:09:21 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 08:09:21 INFO - Using env: {'DISPLAY': ':0', 08:09:21 INFO - 'HOME': '/home/cltbld', 08:09:21 INFO - 'LANG': 'en_US.UTF-8', 08:09:21 INFO - 'LANGUAGE': 'en_US:en', 08:09:21 INFO - 'LOGNAME': 'cltbld', 08:09:21 INFO - 'MAIL': '/var/mail/cltbld', 08:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:21 INFO - 'MOZ_NO_REMOTE': '1', 08:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:21 INFO - 'NO_EM_RESTART': '1', 08:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:21 INFO - 'PWD': '/builds/slave/test', 08:09:21 INFO - 'SHELL': '/bin/bash', 08:09:21 INFO - 'SHLVL': '1', 08:09:21 INFO - 'TERM': 'linux', 08:09:21 INFO - 'TMOUT': '86400', 08:09:21 INFO - 'USER': 'cltbld', 08:09:21 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:21 INFO - '_': '/tools/buildbot/bin/python'} 08:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:22 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 08:09:22 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 08:09:22 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 08:09:22 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 08:09:22 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 08:09:22 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 08:09:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:09:23 INFO - Installing collected packages: mozsystemmonitor 08:09:23 INFO - Running setup.py install for mozsystemmonitor 08:09:24 INFO - Successfully installed mozsystemmonitor 08:09:24 INFO - Cleaning up... 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:24 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')]} 08:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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')]} 08:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:24 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 08:09:24 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 08:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:24 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 08:09:24 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 08:09:24 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 08:09:24 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 08:09:24 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 08:09:24 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 08:09:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 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 08:09:26 INFO - Downloading docopt-0.6.1.tar.gz 08:09:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:26 INFO - Running setup.py install for blobuploader 08:09:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:26 INFO - Running setup.py install for requests 08:09:27 INFO - Running setup.py install for docopt 08:09:27 INFO - Successfully installed blobuploader requests docopt 08:09:27 INFO - Cleaning up... 08:09:27 INFO - Return code: 0 08:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:27 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')]} 08:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 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')]} 08:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:27 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 08:09:27 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 08:09:27 INFO - Using env: {'DISPLAY': ':0', 08:09:27 INFO - 'HOME': '/home/cltbld', 08:09:27 INFO - 'LANG': 'en_US.UTF-8', 08:09:27 INFO - 'LANGUAGE': 'en_US:en', 08:09:27 INFO - 'LOGNAME': 'cltbld', 08:09:27 INFO - 'MAIL': '/var/mail/cltbld', 08:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:27 INFO - 'MOZ_NO_REMOTE': '1', 08:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:27 INFO - 'NO_EM_RESTART': '1', 08:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:27 INFO - 'PWD': '/builds/slave/test', 08:09:27 INFO - 'SHELL': '/bin/bash', 08:09:27 INFO - 'SHLVL': '1', 08:09:27 INFO - 'TERM': 'linux', 08:09:27 INFO - 'TMOUT': '86400', 08:09:27 INFO - 'USER': 'cltbld', 08:09:27 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:27 INFO - '_': '/tools/buildbot/bin/python'} 08:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:27 INFO - Running setup.py (path:/tmp/pip-kdIa9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 INFO - Running setup.py (path:/tmp/pip-zgMKJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Running setup.py (path:/tmp/pip-THZyb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Running setup.py (path:/tmp/pip-mQgRtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Running setup.py (path:/tmp/pip-I9Iyol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Running setup.py (path:/tmp/pip-joVtPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Running setup.py (path:/tmp/pip-AM8yWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:27 INFO - Running setup.py (path:/tmp/pip-aXPFJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:28 INFO - Running setup.py (path:/tmp/pip-Wg3xwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:28 INFO - Running setup.py (path:/tmp/pip-YzVA9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:28 INFO - Running setup.py (path:/tmp/pip-KtMQ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 INFO - Running setup.py (path:/tmp/pip-M9VGMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 INFO - Running setup.py (path:/tmp/pip-Yz4SML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 INFO - Running setup.py (path:/tmp/pip-Y3re_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 INFO - Running setup.py (path:/tmp/pip-Bb5En1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Running setup.py (path:/tmp/pip-8JVK_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Running setup.py (path:/tmp/pip-OnYjF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:28 INFO - Running setup.py install for manifestparser 08:09:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozcrash 08:09:28 INFO - Running setup.py install for mozdebug 08:09:28 INFO - Running setup.py install for mozdevice 08:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozfile 08:09:29 INFO - Running setup.py install for mozhttpd 08:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozinfo 08:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozInstall 08:09:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozleak 08:09:29 INFO - Running setup.py install for mozlog 08:09:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for moznetwork 08:09:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozprocess 08:09:29 INFO - Running setup.py install for mozprofile 08:09:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozrunner 08:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Running setup.py install for mozscreenshot 08:09:30 INFO - Running setup.py install for moztest 08:09:30 INFO - Running setup.py install for mozversion 08:09:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:30 INFO - Cleaning up... 08:09:30 INFO - Return code: 0 08:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:30 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:30 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 08:09:30 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 08:09:30 INFO - Using env: {'DISPLAY': ':0', 08:09:30 INFO - 'HOME': '/home/cltbld', 08:09:30 INFO - 'LANG': 'en_US.UTF-8', 08:09:30 INFO - 'LANGUAGE': 'en_US:en', 08:09:30 INFO - 'LOGNAME': 'cltbld', 08:09:30 INFO - 'MAIL': '/var/mail/cltbld', 08:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:30 INFO - 'MOZ_NO_REMOTE': '1', 08:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:30 INFO - 'NO_EM_RESTART': '1', 08:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:30 INFO - 'PWD': '/builds/slave/test', 08:09:30 INFO - 'SHELL': '/bin/bash', 08:09:30 INFO - 'SHLVL': '1', 08:09:30 INFO - 'TERM': 'linux', 08:09:30 INFO - 'TMOUT': '86400', 08:09:30 INFO - 'USER': 'cltbld', 08:09:30 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:30 INFO - '_': '/tools/buildbot/bin/python'} 08:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:30 INFO - Running setup.py (path:/tmp/pip-uU2Bab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:30 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)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:30 INFO - Running setup.py (path:/tmp/pip-kp5BNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:30 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)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:30 INFO - Running setup.py (path:/tmp/pip-5j7LJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:30 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)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:30 INFO - Running setup.py (path:/tmp/pip-hvINU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:30 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)) 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:30 INFO - Running setup.py (path:/tmp/pip-pFP6Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:31 INFO - Running setup.py (path:/tmp/pip-RoRLHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:31 INFO - Running setup.py (path:/tmp/pip-5Mp4ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:31 INFO - Running setup.py (path:/tmp/pip-izgUoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:31 INFO - Running setup.py (path:/tmp/pip-0Q5dkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:31 INFO - Running setup.py (path:/tmp/pip-VKMWm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:31 INFO - Running setup.py (path:/tmp/pip-tHPSB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:31 INFO - Running setup.py (path:/tmp/pip-Bx7G95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:31 INFO - Running setup.py (path:/tmp/pip-39Es7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:31 INFO - Running setup.py (path:/tmp/pip-1StJFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:31 INFO - Running setup.py (path:/tmp/pip-_c5vkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:31 INFO - Running setup.py (path:/tmp/pip-aNsdtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:31 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)) 08:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:31 INFO - Running setup.py (path:/tmp/pip-uzXSLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 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)) 08:09:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:31 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 08:09:33 INFO - Downloading blessings-1.5.1.tar.gz 08:09:33 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 08:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:33 INFO - Installing collected packages: blessings 08:09:33 INFO - Running setup.py install for blessings 08:09:33 INFO - Successfully installed blessings 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:33 INFO - Reading from file tmpfile_stdout 08:09:33 INFO - Current package versions: 08:09:33 INFO - argparse == 1.2.1 08:09:33 INFO - blessings == 1.5.1 08:09:33 INFO - blobuploader == 1.2.4 08:09:33 INFO - docopt == 0.6.1 08:09:33 INFO - manifestparser == 1.1 08:09:33 INFO - mozInstall == 1.12 08:09:33 INFO - mozcrash == 0.16 08:09:33 INFO - mozdebug == 0.1 08:09:33 INFO - mozdevice == 0.47 08:09:33 INFO - mozfile == 1.2 08:09:33 INFO - mozhttpd == 0.7 08:09:33 INFO - mozinfo == 0.9 08:09:33 INFO - mozleak == 0.1 08:09:33 INFO - mozlog == 3.0 08:09:33 INFO - moznetwork == 0.27 08:09:33 INFO - mozprocess == 0.22 08:09:33 INFO - mozprofile == 0.27 08:09:33 INFO - mozrunner == 6.11 08:09:33 INFO - mozscreenshot == 0.1 08:09:33 INFO - mozsystemmonitor == 0.0 08:09:33 INFO - moztest == 0.7 08:09:33 INFO - mozversion == 1.4 08:09:33 INFO - psutil == 3.1.1 08:09:33 INFO - requests == 1.2.3 08:09:33 INFO - wsgiref == 0.1.2 08:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09: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')]} 08:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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')]} 08:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 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 0x7fc998a8ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21436c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, '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': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', '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 08:09:33 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 08:09:33 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 08:09:33 INFO - Using env: {'DISPLAY': ':0', 08:09:33 INFO - 'HOME': '/home/cltbld', 08:09:33 INFO - 'LANG': 'en_US.UTF-8', 08:09:33 INFO - 'LANGUAGE': 'en_US:en', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MAIL': '/var/mail/cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SHLVL': '1', 08:09:33 INFO - 'TERM': 'linux', 08:09:33 INFO - 'TMOUT': '86400', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - '_': '/tools/buildbot/bin/python'} 08:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 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)) 08:09:34 INFO - Cleaning up... 08:09:34 INFO - Return code: 0 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - Running post-action listener: _start_resource_monitoring 08:09:34 INFO - Starting resource monitoring. 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running install step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: install 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Output received: 08:09:34 INFO - Usage: mozinstall [options] installer 08:09:34 INFO - Options: 08:09:34 INFO - -h, --help show this help message and exit 08:09:34 INFO - -d DEST, --destination=DEST 08:09:34 INFO - Directory to install application into. [default: 08:09:34 INFO - "/builds/slave/test"] 08:09:34 INFO - --app=APP Application being installed. [default: firefox] 08:09:34 INFO - mkdir: /builds/slave/test/build/application 08:09:34 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'] 08:09:34 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 08:09:48 INFO - Reading from file tmpfile_stdout 08:09:48 INFO - Output received: 08:09:48 INFO - /builds/slave/test/build/application/firefox/firefox 08:09:48 INFO - Running post-action listener: _resource_record_post_action 08:09:48 INFO - ##### 08:09:48 INFO - ##### Running run-tests step. 08:09:48 INFO - ##### 08:09:48 INFO - Running pre-action listener: _resource_record_pre_action 08:09:48 INFO - Running main action method: run_tests 08:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:09:48 INFO - Python 2.7.3 08:09:48 INFO - Return code: 0 08:09:48 INFO - grabbing minidump binary from tooltool 08:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:48 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 0x223ab70>, '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 0x228bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228c250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:09:48 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 08:09:48 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 08:09:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:48 INFO - Return code: 0 08:09:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:09:48 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/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 08:09:48 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/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 08:09:48 INFO - Using env: {'DISPLAY': ':0', 08:09:48 INFO - 'HOME': '/home/cltbld', 08:09:48 INFO - 'LANG': 'en_US.UTF-8', 08:09:48 INFO - 'LANGUAGE': 'en_US:en', 08:09:48 INFO - 'LOGNAME': 'cltbld', 08:09:48 INFO - 'MAIL': '/var/mail/cltbld', 08:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:48 INFO - 'MOZ_NO_REMOTE': '1', 08:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:48 INFO - 'NO_EM_RESTART': '1', 08:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:48 INFO - 'PWD': '/builds/slave/test', 08:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:09:48 INFO - 'SHELL': '/bin/bash', 08:09:48 INFO - 'SHLVL': '1', 08:09:48 INFO - 'TERM': 'linux', 08:09:48 INFO - 'TMOUT': '86400', 08:09:48 INFO - 'USER': 'cltbld', 08:09:48 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314', 08:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:48 INFO - '_': '/tools/buildbot/bin/python'} 08:09:48 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/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 08:09:48 INFO - mozversion INFO | application_buildid: 20151120065338 08:09:48 INFO - mozversion INFO | application_changeset: 8cab032fa1e931b6eb294000cb8af0b2393dff0c 08:09:48 INFO - mozversion INFO | application_display_name: Nightly 08:09:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:48 INFO - mozversion INFO | application_name: Firefox 08:09:48 INFO - mozversion INFO | application_remotingname: firefox 08:09:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:09:48 INFO - mozversion INFO | application_vendor: Mozilla 08:09:48 INFO - mozversion INFO | application_version: 45.0a1 08:09:48 INFO - mozversion INFO | platform_buildid: 20151120065338 08:09:48 INFO - mozversion INFO | platform_changeset: 8cab032fa1e931b6eb294000cb8af0b2393dff0c 08:09:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:09:48 INFO - mozversion INFO | platform_version: 45.0a1 08:09:48 INFO - 2015-11-20 08:09:48,917 DEBUG : using testdate: 1448035788 08:09:48 INFO - 2015-11-20 08:09:48,917 DEBUG : actual date: 1448035788 08:09:48 INFO - 2015-11-20 08:09:48,925 INFO : starting webserver on 'localhost:55043' 08:09:48 INFO - 2015-11-20 08:09:48,926 INFO : Starting test suite talos-linux64-ix-014 08:09:48 INFO - 2015-11-20 08:09:48,926 INFO : Starting test dromaeo_css 08:09:48 INFO - 2015-11-20 08:09:48,926 DEBUG : operating with platform_type : linux_ 08:09:48 INFO - 2015-11-20 08:09:48,927 INFO : Initialising browser for dromaeo_css test... 08:09:48 INFO - 2015-11-20 08:09:48,941 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ36FGG/profile http://localhost:55043/getInfo.html 08:09:54 INFO - 2015-11-20 08:09:54,130 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:09:54 INFO - 2015-11-20 08:09:54,130 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:09:54 INFO - 2015-11-20 08:09:54,130 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:09:54 INFO - 2015-11-20 08:09:54,130 DEBUG : BROWSER_OUTPUT: __metrics 08:09:54 INFO - 2015-11-20 08:09:54,292 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:55 INFO - 2015-11-20 08:09:55,611 INFO : Browser initialized. 08:09:55 INFO - 2015-11-20 08:09:55,612 INFO : Running cycle 1/1 for dromaeo_css test... 08:09:55 INFO - 2015-11-20 08:09:55,612 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ36FGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:10:07 INFO - 2015-11-20 08:10:07,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 141643776 08:10:07 INFO - 2015-11-20 08:10:07,497 DEBUG : BROWSER_OUTPUT: 08:10:58 INFO - 2015-11-20 08:10:58,760 DEBUG : BROWSER_OUTPUT: 1448035858759 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] 08:13:10 INFO - 2015-11-20 08:13:10,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55043/tests/dromaeo/cssquery-ext.html) 08:13:12 INFO - 2015-11-20 08:13:12,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 239419392 08:13:12 INFO - 2015-11-20 08:13:12,136 DEBUG : BROWSER_OUTPUT: 08:16:14 INFO - 2015-11-20 08:16:14,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-ext.html (next: http://localhost:55043/tests/dromaeo/cssquery-jquery.html) 08:16:15 INFO - 2015-11-20 08:16:15,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 225107968 08:16:15 INFO - 2015-11-20 08:16:15,163 DEBUG : BROWSER_OUTPUT: 08:19:17 INFO - 2015-11-20 08:19:17,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55043/tests/dromaeo/cssquery-mootools.html) 08:19:17 INFO - 2015-11-20 08:19:17,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 213929984 08:19:17 INFO - 2015-11-20 08:19:17,749 DEBUG : BROWSER_OUTPUT: 08:22:19 INFO - 2015-11-20 08:22:19,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55043/tests/dromaeo/cssquery-prototype.html) 08:22:20 INFO - 2015-11-20 08:22:20,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 198602752 08:22:20 INFO - 2015-11-20 08:22:20,322 DEBUG : BROWSER_OUTPUT: 08:25:23 INFO - 2015-11-20 08:25:23,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55043/tests/dromaeo/cssquery-yui.html) 08:25:23 INFO - 2015-11-20 08:25:23,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 206430208 08:25:23 INFO - 2015-11-20 08:25:23,734 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/dromaeo/cssquery-yui.html (next: http://localhost:55043/tests/dromaeo/cssquery-dojo.html) 08:28:26 INFO - 2015-11-20 08:28:26,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 242614272 08:28:26 INFO - 2015-11-20 08:28:26,453 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,453 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:28:26 INFO - 2015-11-20 08:28:26,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:28:26 INFO - 2015-11-20 08:28:26,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:28:26 INFO - 2015-11-20 08:28:26,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:28:26 INFO - 2015-11-20 08:28:26,456 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2676.1302576662583;2748.8075834691567;2752.064298138635;2769.3492029373083;2784.5405508091167;4606.3781389512405;4742.97628511857;4813.470518242995;4837.201861692821;4842.588379987701;4686.437627484706;4723.740194289313;4777.8805529861775;4783.904321913559;4829.348038014867;4456.108778244356;4483.708558943675;4490.842820501283;4506.616937560295;4549.431321084864;4349.43457350544;4555.3850230218995;4596.126735920165;4637.211674015409;4651.3255577941345;4424.712393694432;4450.821967121327;4526.683132180716;4528.3886675298745;4542.795574199136;4474.77626118696;4486.932696009562;4495.280755079204;4499.4150760400935;4517.299818528133;4266.1254442839145;4486.327050942352;4500.09998000398;4502.009557897258;4507.819687212507;4625.306204069383;4675.812967481296;4701.247800351962;4708.646851486153;4751.382320298339;5154.433012368637;5166.689998600058;5183;5215;5219.321488206509;4996.525330093636;5202.3497062867145;5202.817901373472;5208.5312321891215;5263.552598029172;4716.221823399169;4733.763311834429;4752.097101550694;4767.547083027107;4799.18413869643;5336.279602253724;5399.217113518518;5403.459654034644;5412.134058550691;5430.5927055471;4899.265110233422;5161.303224064778;5175.430702622709;5176.301199338116;5217.399999000164;5061.670991385548;5066.113430149783;5136.717480538531;5233.476652334736;5284.339457567804;5153.922691159635;5156.1750119980625;5156.458571849977;5162.586993040548;5201.713905735145;4962.727050012212;5131.384233891957;5145.3568303962;5146.536811686891;5150.201718733602;4246.087091275391;4268.87193384199;4286.828526858953;4366.3013917773005;4408.845690400884;3796.354619714655;3799.316123097869;3820.465134881119;3828.2917660232947;3839.2705385976574;4271.722338048079;4437.06821567468;4439.866803995886;4445.888852778642;4482.8655140345845;5017.096922553976;5023.070731914534;5032.672876263105;5112.693238405707;5216.765245563959;4420.778961051935;4428.955710442854;4446.555344465528;4455.042165934275;4456.131054444417;4613.861584152413;4615.053913947632;4620.052889157714;4620.1221767864;4659.347691323217;4711.905761884675;4814.398200224972;4818.590419814215;4886.682365646222;4893.902121957541;5046.268291097844;5106.285120083266;5108.974455127701;5120.231965205249;5168.508991645787;4874.439439464507;4921.704697718148;4931.679440836478;4931.852044438672;4964.751762411937;4864.659473836798;4928.112939670894;4974.726390048582;5090.338256026693;5106.285120083117;4990.900181996412;5001.24981252815;5134.10153223177;5236.0575096483;5254.290670759551;4972.353594032753;5014.17266151081;5027.3464449621315;5030.673006254582;5070.518300761421;5030.723310217973;5037.874053148554;5046.142155833591;5046.899062018812;5052.520010598987;4732.834350797705;4795.568398844121;4837.588804951619;4839.443464001544;4922.827701030446;5000.574951129195;5058.494150584912;5061.367329083864;5069.467705890828;5072.949270507248;4914.164592019437;4933.851984440473;4941.407031156141;4947.529984651453;4993.675411098267 08:28:26 INFO - 2015-11-20 08:28:26,458 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.4067769519698;572.0989441629433;575.7178982298673;577.2149876168413;582.5630776917312;27885.302867428323;28747.425051498958;37520.62479375202;38504.614953850454;38573.228535429276;40970.59029409705;41423.58576414235;41450.17099658013;41463.79268103655;41580;7007.614581198032;7119.110111236096;7863.724769633064;8039.196080391973;8048.959755201216;9958.452285124315;10140.391576505397;10152.746181345488;10159.695209143738;10165.695029149138;10194.898051019507;10293.48532573372;10295.845562316572;10300.896991030106;10318.380897146159;7214.855702885965;7378;7378.852422951511;7383.261673832628;10116.595336186581;10283.177345812392;10514.78970420595;10520.94739526305;10523.73690657732;10535.10451611614;37599.62400375988;38031.61968380308;38116;38145;38150.23699526022;3005.7445117165066;3051.2371907023244;3064.233941514621;3104.674009229044;3618.077390265492;29596.55605165924;29780.553291700424;29832.254193645116;29919.70080299191;30188.54717179244;3165.4618714818534;3188.473901806199;3292.6378098409155;3310.4041272570926;3431.605365382988;221052;221603;221701;223328;223858;51878;52994.470055299724;56855;56918.71540642353;62561.37438625556;59026.40973590209;59179;59206;59313.703431482565;59455.40544594498;13133.474661013452;13277.66805829862;13319.600411987461;13323.933380333036;13338.73322533544;9819.36174148678;9878.357906736039;9901.851472227921;9956.601735930482;9965.40207587547;19139.175001243857;19513.414597562096;19655.606887862163;19671.508212294808;19732.802671973383;7675.923240767521;7690.769276921701;7847.84304313922;7929;7988.161243069394;771.8726410142264;866.3502373220085;896.6368620708623;903.6264877386336;922.8569571716395;25046.87476562642;26004.479910401686;26125.869370653025;26151.215463536126;26217.475650486882;951.752544338477;975.8243516167016;1006.8187726209353;1011.5195282240877;1012.5241136665755;14168.574942751733;14718.190499522414;14819.184944827923;14936.029158104688;15027.924860375628;315830;320315;322083;322323;325355;48630.51369486331;49006.264906025724;49171;49243.50756492461;49255.50744492509;1236.7155554222759;1242.2981015726086;1262.678017105632;1266.6580023393817;1279.181323952671;24111.51776964486;31483;32061.82996758913;32077;32296.35407291794;44251.77874110737;44999.775001126094;45005.774971124934;45043.0991380164;45047.32429013633;248974;252238;252918;253429;253790;24516.754832451446;25648;25686.743132568434;27443.588346174423;30246;34371;34868.302633947686;35120.824395877855;35154.296914061066;35333.29333413369;30911.845440772653;32132.83933580317;32801.34397312088;33240.66759332376;33375.83312083424;31974;32217.194570135933;32269.838650806596;32388.514172287905;32839.50740738843;31840.36319273648;32451.350972979937;32652.673473265913;32734.34531309408;32792.83603582062;29178;29329.706702932697;29498.852505737334;29619.85190074036;29703.108906732832;23074.269429793167;23105.19131830378;23255;23444.179453719036;23473.647895281927 08:28:26 INFO - 2015-11-20 08:28:26,459 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.6352475801376;341.5491551152478;344.6364085889386;345.15437178911657;345.4196949125469;12012.45943932523;12357.814632780515;15008.474703385384;15087.698246035086;15928.44250451233;13486.662833429169;13722.862771372309;13856.307184640753;14011.579652610413;14152.29238538074;4486.461624605052;4944.357233559641;5173.068847607429;5174;6006;3683.1712864605515;3787.507624008875;5793.855153621172;5846.970765146169;5918.260217472816;5892.998190307637;5898.911516327258;5899;5912.467877890989;5940.70296485174;5795.507381872525;5959.523238140939;6020.096985452174;6033.276006879159;6035.275766907977;5250.291210686547;5254.369475662907;5261.394939581959;5264.315638966948;5282.603804714623;18520;19105.713414298796;19481.610367792706;21159.04784284711;21466.570668586697;1859.711744679577;1907.5898681783483;2003.7395138631884;2047.600717860018;2075.802798734118;13116.344182790917;13547.59357219285;13577.11748736329;13830.446782128703;14063.718725625431;1816.4096668582763;1828.1133650179652;1854.2860998515534;1860.4418674397762;1861.2648004038465;58612.41387586112;62865.37134628687;63338.68330658363;63926;64408.677956609914;15061.246937653073;15156.924215378853;15161.166135862633;15172.772408413883;15173.924130379277;22667.433314167276;22716.318510444715;22867.428314291945;22881.796548483224;22916.312510624706;8080.43436959419;8183.95908020468;8211.8357632847;8252.876206856901;8269.751907442786;6820.624865632339;6841.253932182826;6846.5892046477375;6852.931470685329;6892.414144797648;7467.1039475263315;7506.474546781673;7536.585487798114;7621.961890190513;7654.770356889302;1628.894121882074;1632.8938618989728;1642.2117383655911;1657.1300067464435;2138.871667699943;844.362506307746;847.766864112374;907.2560500389617;937.2548823685187;943.9076183987349;14607.561773146823;15147.166905820066;15470.303836327392;15498.845011549965;16059.598510037342;849.392684230778;871.1897934920459;873.3275377958936;885.8272636835756;891.9777005574783;7279.490435669452;8477.448965817202;8504.23461888433;8713.956430217808;9058.184763371328;289886;290727;291291;292304;294844;52944;59019.40980590139;62066;62891;64573.354266456736;1065.9680209593726;1067.1356201476829;1067.4182570499252;1099.433791597328;1100.356291569425;13966.930165349515;14110.435582576993;14157.292135392983;14353;14395.136291822524;28222.576661349685;28996.42007159803;29218.561721574617;31417.957832740798;31982;35101.297974039866;35588.466173007946;36221.0944726384;36877.815610922844;38191.23617527689;8363.665453381796;8429.662813487392;8651.95674021626;8799.648014079621;8800.075992020746;14748.48380306727;14790.926045369704;14888.702225955203;15186.3295037548;15423.305951231998;12604.621861344174;12847.871521284667;13004.47982080744;13297.66755831112;13730.45078196861;13054.608361749162;13270.601881943558;13330.800037999245;13563.660908476972;13631.591052268448;13933.651658708208;14102.647433814236;14238.501652442115;14338.784918226444;14396.20820854863;6890.586564806128;8766.693165739169;9014.368994170607;9035.909640903506;9050.773730656787;9633.518324083627;9737.707868763948;12122.393880306126;13582.185068895898;14034.228117453229 08:28:26 INFO - 2015-11-20 08:28:26,462 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1455.570606671032;1605.1011433597182;1664.1263336748207;1669.8163202047772;1699.6685646298977;5964.493018093456;6103.603265787732;6775.322467753228;7154.964225178874;7159.53463024903;6807.523473356867;6942.791716248508;7010.579365238089;7011.2638172991865;7011.509194356384;2042.0708577597195;2082.4065141434694;2085.593309304686;2085.780992995736;2087.5929193807215;1770.8229177082253;1819.818018198176;2023.7773844877051;2079.00207900208;2106;2008.036142651528;2012.909419076145;2013.3657897762232;2014.8690335128242;2015.0327842635543;1999.6600577901718;2068.1210485543734;2069.9379018629465;2071.3785864240817;2073;2018.162462578043;2031.8679285846372;2037.134217957377;2039.1741344755399;2057.506198512361;6989.33601307875;7046.894296585555;7073.080499535027;7076.115485564304;7077.504574679774;4109.198706252282;4218.388333691628;4221.91556168878;4223.303154979425;4231.661467082626;2688.1801050679537;2718.6465759451344;2738;2743.903963361273;2806.9157925262275;856.3748463621529;863.8056437301619;874.9256313213384;884.1423818895661;901.6844104563415;9619.56711947964;9686.128248457673;9691.370060946016;9700.660476883346;9713.271504637181;3841.058940559525;3908.3194226482883;3955.723099383073;3961.623645753649;3968.8015599220503;8374.623141958626;8391.916080839235;8402.327813774884;8404.8319033619;8409.369297302726;4134.607212314825;4136.21411931732;4137.46212992309;4141.937870931938;4143.875683729432;3686.299603075407;3690.1881586051027;3692.5753538342897;3693.2059607184583;3693.372126738461;3488.2674638326234;3493.9126521837156;3496.9125771855906;3532.717382609385;3538.1862171700654;975.1564896364594;1017.6743442098457;1116.665000499863;1128.2440764687515;1135.5117299561268;879.5250564695122;884.7920738626418;885.5173930208052;900.7973206028591;930.6417029443713;6780.796576102724;6797.048413222054;6816.07982922309;6840.657967101625;6846.349596788297;940.2431043010442;956.3305686019814;1021.1473419694638;1050.2333296693457;1055.7413433708791;5313.973430132824;5441.483059109379;5442.2380866678695;5444.1017232156255;5445.128779395357;8433.662653493791;8474;8576.228139467477;8595.226429621363;8735.868961965576;8549.829003419896;8558.486490810572;8599.78500537479;8609.870851937227;8663.653453861774;6647.202335719745;6675.966620166868;6773.796786096425;6775.017622444718;6803.48973826965;6403.423691867568;6430.3891130342545;6480.70836812354;6502.707378168088;6507.056476810931;7537.8115547111765;7591.089069311718;7675.5010924289745;7684.6926122954455;7786.610669466618;7628.275313845176;7775.805604859697;7883.921160788319;7938.3252423542335;7981;5913.497352724895;5924.289085309791;5937.762489500372;5944.108383742473;5945.554083443845;5894.646321220741;6659.567128136656;6687.264400915993;6875;6899.379055884994;5837.270341207349;6015.39846015395;6240.563160578716;6414.198225221848;6468.611883287018;6306.369363063657;6349.333320001333;6359.96820015897;6392.296847346695;6498.707558159988;6214.2853571838;6394.200724909387;6421.935780642134;6461.709223084878;6505.251896032017;5909.025010873158;5922;5926.881462370815;5929.318128415115;5940.79207227745;6053.909191362045;6061.424164704346;6073.574849760651;6082.148499210202;6091.299500557493 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.93921215756853;303.9817610943345;306.18554644645246;313.81014486235824;315.61179748908836;5287.41838397776;5327.89344213116;5446.400895901447;5455.290812194414;5541.418151094133;5255.947440525603;5384.973075134619;5398.352197736277;5401.972990135044;5402.432744561814;3997.8001099944886;4186.6859985501205;4188.58114188581;4195.160967806436;4201.894952626179;4077.143799802045;4201.411802347674;4226.598473145046;4254.404383386328;4301.913961720779;4206.284931561627;4242.936355954663;4246.97876510617;4259.552746961571;4260.403543503912;4243.363495475688;4256.4679415073115;4258.53156152823;4258.9999999999845;4270.359446083081;3756.1548651553453;3764.0401697566945;3767.2088861339153;3768.679662228714;3769.8869033929027;5075.314832497639;5163.199704045879;5236.764345604457;5238.449962753933;5238.842834714965;4879.707217566957;4889.315495830587;4891.144049791273;4892.290617860426;4895.755212239374;5495.313085864267;5696.458836410535;5737.225474560964;5742.569307301969;5755.769769209227;3964.108075682977;3984.2828290907623;3991.0621004064024;4090.1819636072905;4096.672266218725;5966.731497082642;6029.909551356734;6036.305824830157;6039.54703397247;6046.395360464006;4155.085881106152;4164.354525048622;4168.083021735274;4171.416001759695;4174.144300418407;4130.938035929464;4217.746935183899;4233.216854881856;4242.151569686075;4243.087736136746;4883.389576302962;4887.975560122177;4896.559309662076;4903.779329930162;4907.312976183337;5775.5668324875805;5784.50831679312;5785.450382213683;5793.8551536211935;5799.159121927297;1516.4540765324475;1528.9464868729542;1531.1808182622244;1532.0271627516606;1534.8541888520572;1033.9793204135874;1039.8856125826153;1048.3028785857318;1056.1920131099714;1067.114295135036;4999;5014.874628134253;5017.698938063655;5018.247262910592;5018.799248030111;5944.7324870380935;5954.434328738763;5956.76172953077;5963.821085367446;5969.611975221684;5008.474110218447;5009;5010.3737032870895;5019.247112933016;5021.5229553192385;3151.2594540283017;3195.952060719091;3226.7418606511424;3229.4994275887275;3234.3531293741344;5589.469000444951;5604.495595396353;5621.0444224481935;5624.521915637135;5626.915596266059;6124.173236613;6130.724117414727;6135.263768347827;6135.7852475164045;6138.294096178907;5483.4516548344845;5588.30146231721;5625.6905870176715;5630.71846407678;5640.85897852557;5737.196792449144;5957.791477298274;5962.135490353788;5962.761489540369;5966.791162309299;5736.397678243724;5785.161151633074;5884.588078834612;5885.264341957255;5899.91150132757;5646.830595082154;5662.490375866192;5672.290963629546;5674.404187560247;5686.545076393796;4160.271952408256;4161.833526659021;4169.145325208265;4169.45797046382;4169.624733773975;5871.266091738533;6009.909851352146;6017.18767966319;6025.397460254115;6030.246219222598;5707.771689132388;5767.942320576741;5785.132230165509;5791.189233507228;5794.449527294901;5732.111522713986;5781.4507621775865;5786;5789.826305210682;5791.8552036199435;5442.074847275893;5591.496765291144;5599.496045355938;5654.547636189012;5662.688552129673;5795.478406943395;5796.797112101056;5800.50695690871;5804.100364443518;5814.127880817742;5644.6613203207935;5647.85880352978;5667.829965100888;5670.631408958405;5682.6306290091015 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: |5;yui.html;703.1175874277781;704.060079793476;773.4624436016967;777.898873146491;780.7735756630577;11970.880291197085;12187.451564679588;12187.57343492978;12189.146759726811;14066.156030638169;14026.859731402683;14144.575662730109;14150.575482735509;14160.50438234662;14172;622.7228883147002;632.0140580694109;781.1797612506873;815.4495715392087;821.9095899451056;788.4323287233211;795.7254747112237;801.8356236971435;802.314021511608;802.3380710913519;789.8775689768095;828.9378296627747;836.2557323981662;842.1199846160746;842.9747107586752;645.3481983196981;654.9050387693782;833.9624716887755;840.2605706977881;854.478767951549;627.5889292513411;628.0485065126337;628.6668065925068;628.7202195023217;628.7516431009772;12216.755664886741;12337.50649974009;12358.876411235862;12369;12371.938140309241;10592.41741704206;10888.891111088946;10937;11019.449027548671;11293.233157876291;8929.73210803677;9181.816363672757;9232.076792320782;9266.351355405124;9491.620335186653;3143.2613335866054;3166.319241363118;3199.23218427578;3204.983975080133;3206.983965080183;39777.40333894994;40752;40973.79513102475;41625.37561936573;42124.157516849795;8783.121687831293;9098.135677110797;9209.677661281823;9253.213476854542;9279.118483744034;16201.59496012609;16206.59483512898;16222.918885405497;16234.83765162357;16268.51194464168;5485.094959331665;5747.798827041033;6563.245226798979;6677.065210870482;6812.046313516112;3481.4603736420895;3487.6512348764923;3536.9469457958153;3589.6769290763955;3657.030886814996;2694.353355194739;2714.9457010859674;2716.1308381318186;2719.1706529508688;2719.3881376690088;473.4555261449292;477.8638088144862;479.95440433158797;493.6174464789745;493.71117896030506;528.6484487815636;596.427429667524;610.3926593039954;617.9227596550431;632.9461995730322;7218.8917166242545;7350.4119670426235;7430.925690743024;7644.464887457936;7661.387089032864;460.4750584333862;504.2008416659562;563.5041163775851;568.2300482845685;571.5027925704663;3410.687947876244;3532.6114127445962;3590.2998915211806;3592.8023958682525;3655.8903232903053;48061.759691202016;48836.267455988185;48940.26589601159;53721.73139134279;53773;43595.34606980898;44215.778921105186;44715.776421117684;44784.55215447869;46151.076978460915;41828.79085604614;42617.786911065865;42620.3606945896;42889.14221715548;43263.13473730508;7801.648925798239;7924.841503169789;7978.122406535393;8042.798930026796;8308.5430301334;31681.683183168796;32482.512762309056;32617.879837810466;32703;33030.33939321248;38845.61154388533;39119.60880391159;41022.38466423066;41045.794771025954;41347.1730565393;9696.806063878825;9778.022197780165;10191.898081019095;10202.744931376776;10242.334248273839;11685.123615728684;11774.823377649513;11838.644840654793;11885.16803823724;11955;10514.789704206027;10672.050764349347;10752.462376880969;11024.118070554498;11185.88814111881;10268.794624107326;10319.845202321821;10443.321184123008;10622;10800.945995269973;9882.654107106217;10041.648542300984;10078.344907580984;10275.7431064221;10354.482275886025;8843.91156088431;8936.86594701067;8980.101989800967;9041.412308199946;9434.716958491255;8591.484510929364;8648.870266946127;8800.779980500283;8838.602262898057;8889.288856891562 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: __startTimestamp1448036906452__endTimestamp 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,464 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4760.44 Median:4864.66 stddev:491.06 (10.1%) stddev-sans-first:464.54 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: Values: 2676.1 2748.8 2752.1 2769.3 2784.5 4606.4 4743.0 4813.5 4837.2 4842.6 4686.4 4723.7 4777.9 4783.9 4829.3 4456.1 4483.7 4490.8 4506.6 4549.4 4349.4 4555.4 4596.1 4637.2 4651.3 4424.7 4450.8 4526.7 4528.4 4542.8 4474.8 4486.9 4495.3 4499.4 4517.3 4266.1 4486.3 4500.1 4502.0 4507.8 4625.3 4675.8 4701.2 4708.6 4751.4 5154.4 5166.7 5183.0 5215.0 5219.3 4996.5 5202.3 5202.8 5208.5 5263.6 4716.2 4733.8 4752.1 4767.5 4799.2 5336.3 5399.2 5403.5 5412.1 5430.6 4899.3 5161.3 5175.4 5176.3 5217.4 5061.7 5066.1 5136.7 5233.5 5284.3 5153.9 5156.2 5156.5 5162.6 5201.7 4962.7 5131.4 5145.4 5146.5 5150.2 4246.1 4268.9 4286.8 4366.3 4408.8 3796.4 3799.3 3820.5 3828.3 3839.3 4271.7 4437.1 4439.9 4445.9 4482.9 5017.1 5023.1 5032.7 5112.7 5216.8 4420.8 4429.0 4446.6 4455.0 4456.1 4613.9 4615.1 4620.1 4620.1 4659.3 4711.9 4814.4 4818.6 4886.7 4893.9 5046.3 5106.3 5109.0 5120.2 5168.5 4874.4 4921.7 4931.7 4931.9 4964.8 4864.7 4928.1 4974.7 5090.3 5106.3 4990.9 5001.2 5134.1 5236.1 5254.3 4972.4 5014.2 5027.3 5030.7 5070.5 5030.7 5037.9 5046.1 5046.9 5052.5 4732.8 4795.6 4837.6 4839.4 4922.8 5000.6 5058.5 5061.4 5069.5 5072.9 4914.2 4933.9 4941.4 4947.5 4993.7 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42736.91 Median:177107.92 stddev:70184.42 (39.6%) stddev-sans-first:70309.89 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: Values: 570.4 572.1 575.7 577.2 582.6 27885.3 28747.4 37520.6 38504.6 38573.2 40970.6 41423.6 41450.2 41463.8 41580.0 7007.6 7119.1 7863.7 8039.2 8049.0 9958.5 10140.4 10152.7 10159.7 10165.7 10194.9 10293.5 10295.8 10300.9 10318.4 7214.9 7378.0 7378.9 7383.3 10116.6 10283.2 10514.8 10520.9 10523.7 10535.1 37599.6 38031.6 38116.0 38145.0 38150.2 3005.7 3051.2 3064.2 3104.7 3618.1 29596.6 29780.6 29832.3 29919.7 30188.5 3165.5 3188.5 3292.6 3310.4 3431.6 221052.0 221603.0 221701.0 223328.0 223858.0 51878.0 52994.5 56855.0 56918.7 62561.4 59026.4 59179.0 59206.0 59313.7 59455.4 13133.5 13277.7 13319.6 13323.9 13338.7 9819.4 9878.4 9901.9 9956.6 9965.4 19139.2 19513.4 19655.6 19671.5 19732.8 7675.9 7690.8 7847.8 7929.0 7988.2 771.9 866.4 896.6 903.6 922.9 25046.9 26004.5 26125.9 26151.2 26217.5 951.8 975.8 1006.8 1011.5 1012.5 14168.6 14718.2 14819.2 14936.0 15027.9 315830.0 320315.0 322083.0 322323.0 325355.0 48630.5 49006.3 49171.0 49243.5 49255.5 1236.7 1242.3 1262.7 1266.7 1279.2 24111.5 31483.0 32061.8 32077.0 32296.4 44251.8 44999.8 45005.8 45043.1 45047.3 248974.0 252238.0 252918.0 253429.0 253790.0 24516.8 25648.0 25686.7 27443.6 30246.0 34371.0 34868.3 35120.8 35154.3 35333.3 30911.8 32132.8 32801.3 33240.7 33375.8 31974.0 32217.2 32269.8 32388.5 32839.5 31840.4 32451.4 32652.7 32734.3 32792.8 29178.0 29329.7 29498.9 29619.9 29703.1 23074.3 23105.2 23255.0 23444.2 23473.6 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,466 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21162.29 Median:163130.98 stddev:47999.00 (29.4%) stddev-sans-first:48108.18 08:28:26 INFO - 2015-11-20 08:28:26,467 DEBUG : BROWSER_OUTPUT: Values: 334.6 341.5 344.6 345.2 345.4 12012.5 12357.8 15008.5 15087.7 15928.4 13486.7 13722.9 13856.3 14011.6 14152.3 4486.5 4944.4 5173.1 5174.0 6006.0 3683.2 3787.5 5793.9 5847.0 5918.3 5893.0 5898.9 5899.0 5912.5 5940.7 5795.5 5959.5 6020.1 6033.3 6035.3 5250.3 5254.4 5261.4 5264.3 5282.6 18520.0 19105.7 19481.6 21159.0 21466.6 1859.7 1907.6 2003.7 2047.6 2075.8 13116.3 13547.6 13577.1 13830.4 14063.7 1816.4 1828.1 1854.3 1860.4 1861.3 58612.4 62865.4 63338.7 63926.0 64408.7 15061.2 15156.9 15161.2 15172.8 15173.9 22667.4 22716.3 22867.4 22881.8 22916.3 8080.4 8184.0 8211.8 8252.9 8269.8 6820.6 6841.3 6846.6 6852.9 6892.4 7467.1 7506.5 7536.6 7622.0 7654.8 1628.9 1632.9 1642.2 1657.1 2138.9 844.4 847.8 907.3 937.3 943.9 14607.6 15147.2 15470.3 15498.8 16059.6 849.4 871.2 873.3 885.8 892.0 7279.5 8477.4 8504.2 8714.0 9058.2 289886.0 290727.0 291291.0 292304.0 294844.0 52944.0 59019.4 62066.0 62891.0 64573.4 1066.0 1067.1 1067.4 1099.4 1100.4 13966.9 14110.4 14157.3 14353.0 14395.1 28222.6 28996.4 29218.6 31418.0 31982.0 35101.3 35588.5 36221.1 36877.8 38191.2 8363.7 8429.7 8652.0 8799.6 8800.1 14748.5 14790.9 14888.7 15186.3 15423.3 12604.6 12847.9 13004.5 13297.7 13730.5 13054.6 13270.6 13330.8 13563.7 13631.6 13933.7 14102.6 14238.5 14338.8 14396.2 6890.6 8766.7 9014.4 9035.9 9050.8 9633.5 9737.7 12122.4 13582.2 14034.2 08:28:26 INFO - 2015-11-20 08:28:26,467 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,467 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4948.33 Median:6097.45 stddev:2573.69 (42.2%) stddev-sans-first:2567.52 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: Values: 1455.6 1605.1 1664.1 1669.8 1699.7 5964.5 6103.6 6775.3 7155.0 7159.5 6807.5 6942.8 7010.6 7011.3 7011.5 2042.1 2082.4 2085.6 2085.8 2087.6 1770.8 1819.8 2023.8 2079.0 2106.0 2008.0 2012.9 2013.4 2014.9 2015.0 1999.7 2068.1 2069.9 2071.4 2073.0 2018.2 2031.9 2037.1 2039.2 2057.5 6989.3 7046.9 7073.1 7076.1 7077.5 4109.2 4218.4 4221.9 4223.3 4231.7 2688.2 2718.6 2738.0 2743.9 2806.9 856.4 863.8 874.9 884.1 901.7 9619.6 9686.1 9691.4 9700.7 9713.3 3841.1 3908.3 3955.7 3961.6 3968.8 8374.6 8391.9 8402.3 8404.8 8409.4 4134.6 4136.2 4137.5 4141.9 4143.9 3686.3 3690.2 3692.6 3693.2 3693.4 3488.3 3493.9 3496.9 3532.7 3538.2 975.2 1017.7 1116.7 1128.2 1135.5 879.5 884.8 885.5 900.8 930.6 6780.8 6797.0 6816.1 6840.7 6846.3 940.2 956.3 1021.1 1050.2 1055.7 5314.0 5441.5 5442.2 5444.1 5445.1 8433.7 8474.0 8576.2 8595.2 8735.9 8549.8 8558.5 8599.8 8609.9 8663.7 6647.2 6676.0 6773.8 6775.0 6803.5 6403.4 6430.4 6480.7 6502.7 6507.1 7537.8 7591.1 7675.5 7684.7 7786.6 7628.3 7775.8 7883.9 7938.3 7981.0 5913.5 5924.3 5937.8 5944.1 5945.6 5894.6 6659.6 6687.3 6875.0 6899.4 5837.3 6015.4 6240.6 6414.2 6468.6 6306.4 6349.3 6360.0 6392.3 6498.7 6214.3 6394.2 6421.9 6461.7 6505.3 5909.0 5922.0 5926.9 5929.3 5940.8 6053.9 6061.4 6073.6 6082.1 6091.3 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4774.77 Median:5271.68 stddev:1389.33 (26.4%) stddev-sans-first:1352.09 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: Values: 303.9 304.0 306.2 313.8 315.6 5287.4 5327.9 5446.4 5455.3 5541.4 5255.9 5385.0 5398.4 5402.0 5402.4 3997.8 4186.7 4188.6 4195.2 4201.9 4077.1 4201.4 4226.6 4254.4 4301.9 4206.3 4242.9 4247.0 4259.6 4260.4 4243.4 4256.5 4258.5 4259.0 4270.4 3756.2 3764.0 3767.2 3768.7 3769.9 5075.3 5163.2 5236.8 5238.4 5238.8 4879.7 4889.3 4891.1 4892.3 4895.8 5495.3 5696.5 5737.2 5742.6 5755.8 3964.1 3984.3 3991.1 4090.2 4096.7 5966.7 6029.9 6036.3 6039.5 6046.4 4155.1 4164.4 4168.1 4171.4 4174.1 4130.9 4217.7 4233.2 4242.2 4243.1 4883.4 4888.0 4896.6 4903.8 4907.3 5775.6 5784.5 5785.5 5793.9 5799.2 1516.5 1528.9 1531.2 1532.0 1534.9 1034.0 1039.9 1048.3 1056.2 1067.1 4999.0 5014.9 5017.7 5018.2 5018.8 5944.7 5954.4 5956.8 5963.8 5969.6 5008.5 5009.0 5010.4 5019.2 5021.5 3151.3 3196.0 3226.7 3229.5 3234.4 5589.5 5604.5 5621.0 5624.5 5626.9 6124.2 6130.7 6135.3 6135.8 6138.3 5483.5 5588.3 5625.7 5630.7 5640.9 5737.2 5957.8 5962.1 5962.8 5966.8 5736.4 5785.2 5884.6 5885.3 5899.9 5646.8 5662.5 5672.3 5674.4 5686.5 4160.3 4161.8 4169.1 4169.5 4169.6 5871.3 6009.9 6017.2 6025.4 6030.2 5707.8 5767.9 5785.1 5791.2 5794.4 5732.1 5781.5 5786.0 5789.8 5791.9 5442.1 5591.5 5599.5 5654.5 5662.7 5795.5 5796.8 5800.5 5804.1 5814.1 5644.7 5647.9 5667.8 5670.6 5682.6 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: 08:28:26 INFO - 2015-11-20 08:28:26,468 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12452.29 Median:22622.51 stddev:14151.98 (62.6%) stddev-sans-first:14164.18 08:28:26 INFO - 2015-11-20 08:28:26,469 DEBUG : BROWSER_OUTPUT: Values: 703.1 704.1 773.5 777.9 780.8 11970.9 12187.5 12187.6 12189.1 14066.2 14026.9 14144.6 14150.6 14160.5 14172.0 622.7 632.0 781.2 815.4 821.9 788.4 795.7 801.8 802.3 802.3 789.9 828.9 836.3 842.1 843.0 645.3 654.9 834.0 840.3 854.5 627.6 628.0 628.7 628.7 628.8 12216.8 12337.5 12358.9 12369.0 12371.9 10592.4 10888.9 10937.0 11019.4 11293.2 8929.7 9181.8 9232.1 9266.4 9491.6 3143.3 3166.3 3199.2 3205.0 3207.0 39777.4 40752.0 40973.8 41625.4 42124.2 8783.1 9098.1 9209.7 9253.2 9279.1 16201.6 16206.6 16222.9 16234.8 16268.5 5485.1 5747.8 6563.2 6677.1 6812.0 3481.5 3487.7 3536.9 3589.7 3657.0 2694.4 2714.9 2716.1 2719.2 2719.4 473.5 477.9 480.0 493.6 493.7 528.6 596.4 610.4 617.9 632.9 7218.9 7350.4 7430.9 7644.5 7661.4 460.5 504.2 563.5 568.2 571.5 3410.7 3532.6 3590.3 3592.8 3655.9 48061.8 48836.3 48940.3 53721.7 53773.0 43595.3 44215.8 44715.8 44784.6 46151.1 41828.8 42617.8 42620.4 42889.1 43263.1 7801.6 7924.8 7978.1 8042.8 8308.5 31681.7 32482.5 32617.9 32703.0 33030.3 38845.6 39119.6 41022.4 41045.8 41347.2 9696.8 9778.0 10191.9 10202.7 10242.3 11685.1 11774.8 11838.6 11885.2 11955.0 10514.8 10672.1 10752.5 11024.1 11185.9 10268.8 10319.8 10443.3 10622.0 10800.9 9882.7 10041.6 10078.3 10275.7 10354.5 8843.9 8936.9 8980.1 9041.4 9434.7 8591.5 8648.9 8800.8 8838.6 8889.3 08:28:26 INFO - 2015-11-20 08:28:26,469 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:28:26 INFO - 2015-11-20 08:28:26,469 DEBUG : BROWSER_OUTPUT: 08:28:27 INFO - 2015-11-20 08:28:27,171 INFO : Browser exited with error code: 0 08:28:27 INFO - 2015-11-20 08:28:27,190 INFO : Completed test dromaeo_css (00:18:38) 08:28:27 INFO - 2015-11-20 08:28:27,190 INFO : Starting test kraken 08:28:27 INFO - 2015-11-20 08:28:27,190 DEBUG : operating with platform_type : linux_ 08:28:27 INFO - 2015-11-20 08:28:27,190 INFO : Initialising browser for kraken test... 08:28:27 INFO - 2015-11-20 08:28:27,196 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sYmt6/profile http://localhost:55043/getInfo.html 08:28:31 INFO - 2015-11-20 08:28:31,232 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:28:31 INFO - 2015-11-20 08:28:31,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:28:31 INFO - 2015-11-20 08:28:31,233 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:28:31 INFO - 2015-11-20 08:28:31,233 DEBUG : BROWSER_OUTPUT: __metrics 08:28:31 INFO - 2015-11-20 08:28:31,317 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:32 INFO - 2015-11-20 08:28:32,766 INFO : Browser initialized. 08:28:32 INFO - 2015-11-20 08:28:32,767 INFO : Running cycle 1/1 for kraken test... 08:28:32 INFO - 2015-11-20 08:28:32,767 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sYmt6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:28:44 INFO - 2015-11-20 08:28:44,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 142249984 08:28:44 INFO - 2015-11-20 08:28:44,750 DEBUG : BROWSER_OUTPUT: 08:28:47 INFO - 2015-11-20 08:28:47,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55043/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:47 INFO - 2015-11-20 08:28:47,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 176631808 08:28:47 INFO - 2015-11-20 08:28:47,959 DEBUG : BROWSER_OUTPUT: 08:28:50 INFO - 2015-11-20 08:28:50,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55043/tests/kraken/driver.html?testName=audio-dft) 08:28:51 INFO - 2015-11-20 08:28:51,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 167317504 08:28:51 INFO - 2015-11-20 08:28:51,288 DEBUG : BROWSER_OUTPUT: 08:28:54 INFO - 2015-11-20 08:28:54,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55043/tests/kraken/driver.html?testName=audio-fft) 08:28:54 INFO - 2015-11-20 08:28:54,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 151945216 08:28:54 INFO - 2015-11-20 08:28:54,873 DEBUG : BROWSER_OUTPUT: 08:28:56 INFO - 2015-11-20 08:28:56,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55043/tests/kraken/driver.html?testName=audio-oscillator) 08:28:57 INFO - 2015-11-20 08:28:57,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 154820608 08:28:57 INFO - 2015-11-20 08:28:57,471 DEBUG : BROWSER_OUTPUT: 08:28:59 INFO - 2015-11-20 08:28:59,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:00 INFO - 2015-11-20 08:29:00,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 156024832 08:29:00 INFO - 2015-11-20 08:29:00,264 DEBUG : BROWSER_OUTPUT: 08:29:03 INFO - 2015-11-20 08:29:03,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55043/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:03 INFO - 2015-11-20 08:29:03,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 157904896 08:29:03 INFO - 2015-11-20 08:29:03,764 DEBUG : BROWSER_OUTPUT: 08:29:07 INFO - 2015-11-20 08:29:07,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55043/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:07 INFO - 2015-11-20 08:29:07,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 158035968 08:29:07 INFO - 2015-11-20 08:29:07,801 DEBUG : BROWSER_OUTPUT: 08:29:10 INFO - 2015-11-20 08:29:10,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55043/tests/kraken/driver.html?testName=json-parse-financial) 08:29:11 INFO - 2015-11-20 08:29:11,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 156086272 08:29:11 INFO - 2015-11-20 08:29:11,234 DEBUG : BROWSER_OUTPUT: 08:29:12 INFO - 2015-11-20 08:29:12,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:13 INFO - 2015-11-20 08:29:13,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 162942976 08:29:13 INFO - 2015-11-20 08:29:13,521 DEBUG : BROWSER_OUTPUT: 08:29:15 INFO - 2015-11-20 08:29:15,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:15 INFO - 2015-11-20 08:29:15,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 163606528 08:29:15 INFO - 2015-11-20 08:29:15,982 DEBUG : BROWSER_OUTPUT: 08:29:18 INFO - 2015-11-20 08:29:18,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:18 INFO - 2015-11-20 08:29:18,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 171802624 08:29:18 INFO - 2015-11-20 08:29:18,701 DEBUG : BROWSER_OUTPUT: 08:29:21 INFO - 2015-11-20 08:29:21,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:21 INFO - 2015-11-20 08:29:21,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 177856512 08:29:21 INFO - 2015-11-20 08:29:21,763 DEBUG : BROWSER_OUTPUT: 08:29:24 INFO - 2015-11-20 08:29:24,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:24 INFO - 2015-11-20 08:29:24,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 176844800 08:29:24 INFO - 2015-11-20 08:29:24,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55043/tests/kraken/driver.html?testName=ai-astar) 08:29:26 INFO - 2015-11-20 08:29:26,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 235900928 08:29:26 INFO - 2015-11-20 08:29:26,907 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;106;112;112;112;102;111;104;113 08:29:26 INFO - 2015-11-20 08:29:26,911 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;131;154;167;136;153;152;132;173;139 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;165;161;162;160;163;162;163;161 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;85;94;72;72;73;95;94;72 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;91;131;92;93;92;128;92;92;127 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;109;112;110;109;109;109 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;147;147;148;146;148;146;147 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;95 08:29:26 INFO - 2015-11-20 08:29:26,912 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;68;68;68;70;70;68;76;65;67 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;68;68;68;69;68;68;69 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;92;83;84;84;85;83;92;87;83 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;120;125;117;121;124;122;120;127;120 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;145;144;147;134;152;134;144;136 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;70;69;69;69;69;68;68;68 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:29:26 INFO - 2015-11-20 08:29:26,913 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 08:29:26 INFO - 2015-11-20 08:29:26,914 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:29:26 INFO - 2015-11-20 08:29:26,914 DEBUG : BROWSER_OUTPUT: __startTimestamp1448036966910__endTimestamp 08:29:26 INFO - 2015-11-20 08:29:26,914 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,921 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 106.0 112.0 112.0 112.0 102.0 111.0 104.0 113.0 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.00 Median:153.50 stddev:14.97 (9.8%) stddev-sans-first:15.13 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Values: 163.0 131.0 154.0 167.0 136.0 153.0 152.0 132.0 173.0 139.0 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 165.0 161.0 162.0 160.0 163.0 162.0 163.0 161.0 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:79.50 stddev:10.45 (13.1%) stddev-sans-first:10.64 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 85.0 94.0 72.0 72.0 73.0 95.0 94.0 72.0 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:92.00 stddev:17.68 (19.2%) stddev-sans-first:18.37 08:29:26 INFO - 2015-11-20 08:29:26,922 DEBUG : BROWSER_OUTPUT: Values: 93.0 91.0 131.0 92.0 93.0 92.0 128.0 92.0 92.0 127.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 109.0 112.0 110.0 109.0 109.0 109.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 147.0 147.0 148.0 146.0 148.0 146.0 147.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.90 Median:68.50 stddev:2.88 (4.2%) stddev-sans-first:3.06 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 70.0 70.0 68.0 76.0 65.0 67.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 08:29:26 INFO - 2015-11-20 08:29:26,923 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:3.48 (4.1%) stddev-sans-first:3.69 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: Values: 86.0 92.0 83.0 84.0 84.0 85.0 83.0 92.0 87.0 83.0 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:2.95 (2.4%) stddev-sans-first:3.07 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 125.0 117.0 121.0 124.0 122.0 120.0 127.0 120.0 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.50 stddev:6.13 (4.2%) stddev-sans-first:6.33 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 145.0 144.0 147.0 134.0 152.0 134.0 144.0 136.0 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 68.0 68.0 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:29:26 INFO - 2015-11-20 08:29:26,924 DEBUG : BROWSER_OUTPUT: 08:29:27 INFO - 2015-11-20 08:29:27,899 INFO : Browser exited with error code: 0 08:29:27 INFO - 2015-11-20 08:29:27,953 INFO : Completed test kraken (00:01:00) 08:29:27 INFO - 2015-11-20 08:29:27,953 INFO : Starting test v8_7 08:29:27 INFO - 2015-11-20 08:29:27,953 DEBUG : operating with platform_type : linux_ 08:29:27 INFO - 2015-11-20 08:29:27,953 INFO : Initialising browser for v8_7 test... 08:29:27 INFO - 2015-11-20 08:29:27,959 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWiaRPO/profile http://localhost:55043/getInfo.html 08:29:32 INFO - 2015-11-20 08:29:32,081 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:29:32 INFO - 2015-11-20 08:29:32,081 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:29:32 INFO - 2015-11-20 08:29:32,081 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:29:32 INFO - 2015-11-20 08:29:32,081 DEBUG : BROWSER_OUTPUT: __metrics 08:29:32 INFO - 2015-11-20 08:29:32,224 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:33 INFO - 2015-11-20 08:29:33,579 INFO : Browser initialized. 08:29:33 INFO - 2015-11-20 08:29:33,580 INFO : Running cycle 1/1 for v8_7 test... 08:29:33 INFO - 2015-11-20 08:29:33,580 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWiaRPO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:29:45 INFO - 2015-11-20 08:29:45,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 142434304 08:29:45 INFO - 2015-11-20 08:29:45,459 DEBUG : BROWSER_OUTPUT: 08:30:06 INFO - 2015-11-20 08:30:06,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55043/tests/v8_7/run.html (next: http://localhost:55043/tests/v8_7/run.html) 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 444534784 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |0;Richards;164.41959881617888 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.80328181644725 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 08:30:07 INFO - 2015-11-20 08:30:07,131 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: |8;Splay;616.5228113440197 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: __startTimestamp1448037007124__endTimestamp 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,132 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.42 Median:164.42 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: Values: 164.4 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.80 Median:190.80 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: Values: 190.8 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: Values: 279.7 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,133 DEBUG : BROWSER_OUTPUT: Values: 5020.0 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: Values: 1980.2 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: Values: 795.5 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: Values: 12084.3 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: Values: 26815.8 08:30:07 INFO - 2015-11-20 08:30:07,134 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.52 Median:616.52 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: Values: 616.5 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: Values: 4854.4 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:30:07 INFO - 2015-11-20 08:30:07,135 DEBUG : BROWSER_OUTPUT: 08:30:08 INFO - 2015-11-20 08:30:08,047 INFO : Browser exited with error code: 0 08:30:08 INFO - 2015-11-20 08:30:08,059 INFO : Completed test v8_7 (00:00:40) 08:30:08 INFO - 2015-11-20 08:30:08,165 INFO : Completed test suite (00:20:19) 08:30:08 INFO - 2015-11-20 08:30:08,165 DEBUG : Working with test: dromaeo_css 08:30:08 INFO - 2015-11-20 08:30:08,165 DEBUG : Generating results file: dromaeo_css 08:30:08 INFO - 2015-11-20 08:30:08,166 DEBUG : Working with test: kraken 08:30:08 INFO - 2015-11-20 08:30:08,166 DEBUG : Generating results file: kraken 08:30:08 INFO - 2015-11-20 08:30:08,167 INFO : javascript benchmark 08:30:08 INFO - 2015-11-20 08:30:08,167 DEBUG : Working with test: v8_7 08:30:08 INFO - 2015-11-20 08:30:08,167 DEBUG : Generating results file: v8_7 08:30:08 INFO - 2015-11-20 08:30:08,167 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:08 INFO - 2015-11-20 08:30:08,352 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:30:08 INFO - 2015-11-20 08:30:08,352 DEBUG : process_Request line: dromaeo_css 6443.24 graph.html#tests=[[72,132,35]] 08:30:08 INFO - 2015-11-20 08:30:08,352 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:08 INFO - 2015-11-20 08:30:08,492 DEBUG : process_Request line: kraken 1513.10 graph.html#tests=[[232,132,35]] 08:30:08 INFO - 2015-11-20 08:30:08,493 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:08 INFO - 2015-11-20 08:30:08,615 DEBUG : process_Request line: v8_7 19797.03 graph.html#tests=[[230,132,35]] 08:30:08 INFO - 2015-11-20 08:30:08,616 INFO : javascript benchmark 08:30:08 INFO - 2015-11-20 08:30:08,619 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2676.1302576662583, 2748.8075834691567, 2752.064298138635, 2769.3492029373083, 2784.5405508091167, 4606.3781389512405, 4742.97628511857, 4813.470518242995, 4837.201861692821, 4842.588379987701, 4686.437627484706, 4723.740194289313, 4777.8805529861775, 4783.904321913559, 4829.348038014867, 4456.108778244356, 4483.708558943675, 4490.842820501283, 4506.616937560295, 4549.431321084864, 4349.43457350544, 4555.3850230218995, 4596.126735920165, 4637.211674015409, 4651.3255577941345, 4424.712393694432, 4450.821967121327, 4526.683132180716, 4528.3886675298745, 4542.795574199136, 4474.77626118696, 4486.932696009562, 4495.280755079204, 4499.4150760400935, 4517.299818528133, 4266.1254442839145, 4486.327050942352, 4500.09998000398, 4502.009557897258, 4507.819687212507, 4625.306204069383, 4675.812967481296, 4701.247800351962, 4708.646851486153, 4751.382320298339, 5154.433012368637, 5166.689998600058, 5183.0, 5215.0, 5219.321488206509, 4996.525330093636, 5202.3497062867145, 5202.817901373472, 5208.5312321891215, 5263.552598029172, 4716.221823399169, 4733.763311834429, 4752.097101550694, 4767.547083027107, 4799.18413869643, 5336.279602253724, 5399.217113518518, 5403.459654034644, 5412.134058550691, 5430.5927055471, 4899.265110233422, 5161.303224064778, 5175.430702622709, 5176.301199338116, 5217.399999000164, 5061.670991385548, 5066.113430149783, 5136.717480538531, 5233.476652334736, 5284.339457567804, 5153.922691159635, 5156.1750119980625, 5156.458571849977, 5162.586993040548, 5201.713905735145, 4962.727050012212, 5131.384233891957, 5145.3568303962, 5146.536811686891, 5150.201718733602, 4246.087091275391, 4268.87193384199, 4286.828526858953, 4366.3013917773005, 4408.845690400884, 3796.354619714655, 3799.316123097869, 3820.465134881119, 3828.2917660232947, 3839.2705385976574, 4271.722338048079, 4437.06821567468, 4439.866803995886, 4445.888852778642, 4482.8655140345845, 5017.096922553976, 5023.070731914534, 5032.672876263105, 5112.693238405707, 5216.765245563959, 4420.778961051935, 4428.955710442854, 4446.555344465528, 4455.042165934275, 4456.131054444417, 4613.861584152413, 4615.053913947632, 4620.052889157714, 4620.1221767864, 4659.347691323217, 4711.905761884675, 4814.398200224972, 4818.590419814215, 4886.682365646222, 4893.902121957541, 5046.268291097844, 5106.285120083266, 5108.974455127701, 5120.231965205249, 5168.508991645787, 4874.439439464507, 4921.704697718148, 4931.679440836478, 4931.852044438672, 4964.751762411937, 4864.659473836798, 4928.112939670894, 4974.726390048582, 5090.338256026693, 5106.285120083117, 4990.900181996412, 5001.24981252815, 5134.10153223177, 5236.0575096483, 5254.290670759551, 4972.353594032753, 5014.17266151081, 5027.3464449621315, 5030.673006254582, 5070.518300761421, 5030.723310217973, 5037.874053148554, 5046.142155833591, 5046.899062018812, 5052.520010598987, 4732.834350797705, 4795.568398844121, 4837.588804951619, 4839.443464001544, 4922.827701030446, 5000.574951129195, 5058.494150584912, 5061.367329083864, 5069.467705890828, 5072.949270507248, 4914.164592019437, 4933.851984440473, 4941.407031156141, 4947.529984651453, 4993.675411098267], "unit": "ms", "name": "dojo.html", "value": 4730.150335039585}, {"lowerIsBetter": false, "replicates": [570.4067769519698, 572.0989441629433, 575.7178982298673, 577.2149876168413, 582.5630776917312, 27885.302867428323, 28747.425051498958, 37520.62479375202, 38504.614953850454, 38573.228535429276, 40970.59029409705, 41423.58576414235, 41450.17099658013, 41463.79268103655, 41580.0, 7007.614581198032, 7119.110111236096, 7863.724769633064, 8039.196080391973, 8048.959755201216, 9958.452285124315, 10140.391576505397, 10152.746181345488, 10159.695209143738, 10165.695029149138, 10194.898051019507, 10293.48532573372, 10295.845562316572, 10300.896991030106, 10318.380897146159, 7214.855702885965, 7378.0, 7378.852422951511, 7383.261673832628, 10116.595336186581, 10283.177345812392, 10514.78970420595, 10520.94739526305, 10523.73690657732, 10535.10451611614, 37599.62400375988, 38031.61968380308, 38116.0, 38145.0, 38150.23699526022, 3005.7445117165066, 3051.2371907023244, 3064.233941514621, 3104.674009229044, 3618.077390265492, 29596.55605165924, 29780.553291700424, 29832.254193645116, 29919.70080299191, 30188.54717179244, 3165.4618714818534, 3188.473901806199, 3292.6378098409155, 3310.4041272570926, 3431.605365382988, 221052.0, 221603.0, 221701.0, 223328.0, 223858.0, 51878.0, 52994.470055299724, 56855.0, 56918.71540642353, 62561.37438625556, 59026.40973590209, 59179.0, 59206.0, 59313.703431482565, 59455.40544594498, 13133.474661013452, 13277.66805829862, 13319.600411987461, 13323.933380333036, 13338.73322533544, 9819.36174148678, 9878.357906736039, 9901.851472227921, 9956.601735930482, 9965.40207587547, 19139.175001243857, 19513.414597562096, 19655.606887862163, 19671.508212294808, 19732.802671973383, 7675.923240767521, 7690.769276921701, 7847.84304313922, 7929.0, 7988.161243069394, 771.8726410142264, 866.3502373220085, 896.6368620708623, 903.6264877386336, 922.8569571716395, 25046.87476562642, 26004.479910401686, 26125.869370653025, 26151.215463536126, 26217.475650486882, 951.752544338477, 975.8243516167016, 1006.8187726209353, 1011.5195282240877, 1012.5241136665755, 14168.574942751733, 14718.190499522414, 14819.184944827923, 14936.029158104688, 15027.924860375628, 315830.0, 320315.0, 322083.0, 322323.0, 325355.0, 48630.51369486331, 49006.264906025724, 49171.0, 49243.50756492461, 49255.50744492509, 1236.7155554222759, 1242.2981015726086, 1262.678017105632, 1266.6580023393817, 1279.181323952671, 24111.51776964486, 31483.0, 32061.82996758913, 32077.0, 32296.35407291794, 44251.77874110737, 44999.775001126094, 45005.774971124934, 45043.0991380164, 45047.32429013633, 248974.0, 252238.0, 252918.0, 253429.0, 253790.0, 24516.754832451446, 25648.0, 25686.743132568434, 27443.588346174423, 30246.0, 34371.0, 34868.302633947686, 35120.824395877855, 35154.296914061066, 35333.29333413369, 30911.845440772653, 32132.83933580317, 32801.34397312088, 33240.66759332376, 33375.83312083424, 31974.0, 32217.194570135933, 32269.838650806596, 32388.514172287905, 32839.50740738843, 31840.36319273648, 32451.350972979937, 32652.673473265913, 32734.34531309408, 32792.83603582062, 29178.0, 29329.706702932697, 29498.852505737334, 29619.85190074036, 29703.108906732832, 23074.269429793167, 23105.19131830378, 23255.0, 23444.179453719036, 23473.647895281927], "unit": "ms", "name": "ext.html", "value": 17407.706872681996}, {"lowerIsBetter": false, "replicates": [334.6352475801376, 341.5491551152478, 344.6364085889386, 345.15437178911657, 345.4196949125469, 12012.45943932523, 12357.814632780515, 15008.474703385384, 15087.698246035086, 15928.44250451233, 13486.662833429169, 13722.862771372309, 13856.307184640753, 14011.579652610413, 14152.29238538074, 4486.461624605052, 4944.357233559641, 5173.068847607429, 5174.0, 6006.0, 3683.1712864605515, 3787.507624008875, 5793.855153621172, 5846.970765146169, 5918.260217472816, 5892.998190307637, 5898.911516327258, 5899.0, 5912.467877890989, 5940.70296485174, 5795.507381872525, 5959.523238140939, 6020.096985452174, 6033.276006879159, 6035.275766907977, 5250.291210686547, 5254.369475662907, 5261.394939581959, 5264.315638966948, 5282.603804714623, 18520.0, 19105.713414298796, 19481.610367792706, 21159.04784284711, 21466.570668586697, 1859.711744679577, 1907.5898681783483, 2003.7395138631884, 2047.600717860018, 2075.802798734118, 13116.344182790917, 13547.59357219285, 13577.11748736329, 13830.446782128703, 14063.718725625431, 1816.4096668582763, 1828.1133650179652, 1854.2860998515534, 1860.4418674397762, 1861.2648004038465, 58612.41387586112, 62865.37134628687, 63338.68330658363, 63926.0, 64408.677956609914, 15061.246937653073, 15156.924215378853, 15161.166135862633, 15172.772408413883, 15173.924130379277, 22667.433314167276, 22716.318510444715, 22867.428314291945, 22881.796548483224, 22916.312510624706, 8080.43436959419, 8183.95908020468, 8211.8357632847, 8252.876206856901, 8269.751907442786, 6820.624865632339, 6841.253932182826, 6846.5892046477375, 6852.931470685329, 6892.414144797648, 7467.1039475263315, 7506.474546781673, 7536.585487798114, 7621.961890190513, 7654.770356889302, 1628.894121882074, 1632.8938618989728, 1642.2117383655911, 1657.1300067464435, 2138.871667699943, 844.362506307746, 847.766864112374, 907.2560500389617, 937.2548823685187, 943.9076183987349, 14607.561773146823, 15147.166905820066, 15470.303836327392, 15498.845011549965, 16059.598510037342, 849.392684230778, 871.1897934920459, 873.3275377958936, 885.8272636835756, 891.9777005574783, 7279.490435669452, 8477.448965817202, 8504.23461888433, 8713.956430217808, 9058.184763371328, 289886.0, 290727.0, 291291.0, 292304.0, 294844.0, 52944.0, 59019.40980590139, 62066.0, 62891.0, 64573.354266456736, 1065.9680209593726, 1067.1356201476829, 1067.4182570499252, 1099.433791597328, 1100.356291569425, 13966.930165349515, 14110.435582576993, 14157.292135392983, 14353.0, 14395.136291822524, 28222.576661349685, 28996.42007159803, 29218.561721574617, 31417.957832740798, 31982.0, 35101.297974039866, 35588.466173007946, 36221.0944726384, 36877.815610922844, 38191.23617527689, 8363.665453381796, 8429.662813487392, 8651.95674021626, 8799.648014079621, 8800.075992020746, 14748.48380306727, 14790.926045369704, 14888.702225955203, 15186.3295037548, 15423.305951231998, 12604.621861344174, 12847.871521284667, 13004.47982080744, 13297.66755831112, 13730.45078196861, 13054.608361749162, 13270.601881943558, 13330.800037999245, 13563.660908476972, 13631.591052268448, 13933.651658708208, 14102.647433814236, 14238.501652442115, 14338.784918226444, 14396.20820854863, 6890.586564806128, 8766.693165739169, 9014.368994170607, 9035.909640903506, 9050.773730656787, 9633.518324083627, 9737.707868763948, 12122.393880306126, 13582.185068895898, 14034.228117453229], "unit": "ms", "name": "jquery.html", "value": 8628.080520437627}, {"lowerIsBetter": false, "replicates": [1455.570606671032, 1605.1011433597182, 1664.1263336748207, 1669.8163202047772, 1699.6685646298977, 5964.493018093456, 6103.603265787732, 6775.322467753228, 7154.964225178874, 7159.53463024903, 6807.523473356867, 6942.791716248508, 7010.579365238089, 7011.2638172991865, 7011.509194356384, 2042.0708577597195, 2082.4065141434694, 2085.593309304686, 2085.780992995736, 2087.5929193807215, 1770.8229177082253, 1819.818018198176, 2023.7773844877051, 2079.00207900208, 2106.0, 2008.036142651528, 2012.909419076145, 2013.3657897762232, 2014.8690335128242, 2015.0327842635543, 1999.6600577901718, 2068.1210485543734, 2069.9379018629465, 2071.3785864240817, 2073.0, 2018.162462578043, 2031.8679285846372, 2037.134217957377, 2039.1741344755399, 2057.506198512361, 6989.33601307875, 7046.894296585555, 7073.080499535027, 7076.115485564304, 7077.504574679774, 4109.198706252282, 4218.388333691628, 4221.91556168878, 4223.303154979425, 4231.661467082626, 2688.1801050679537, 2718.6465759451344, 2738.0, 2743.903963361273, 2806.9157925262275, 856.3748463621529, 863.8056437301619, 874.9256313213384, 884.1423818895661, 901.6844104563415, 9619.56711947964, 9686.128248457673, 9691.370060946016, 9700.660476883346, 9713.271504637181, 3841.058940559525, 3908.3194226482883, 3955.723099383073, 3961.623645753649, 3968.8015599220503, 8374.623141958626, 8391.916080839235, 8402.327813774884, 8404.8319033619, 8409.369297302726, 4134.607212314825, 4136.21411931732, 4137.46212992309, 4141.937870931938, 4143.875683729432, 3686.299603075407, 3690.1881586051027, 3692.5753538342897, 3693.2059607184583, 3693.372126738461, 3488.2674638326234, 3493.9126521837156, 3496.9125771855906, 3532.717382609385, 3538.1862171700654, 975.1564896364594, 1017.6743442098457, 1116.665000499863, 1128.2440764687515, 1135.5117299561268, 879.5250564695122, 884.7920738626418, 885.5173930208052, 900.7973206028591, 930.6417029443713, 6780.796576102724, 6797.048413222054, 6816.07982922309, 6840.657967101625, 6846.349596788297, 940.2431043010442, 956.3305686019814, 1021.1473419694638, 1050.2333296693457, 1055.7413433708791, 5313.973430132824, 5441.483059109379, 5442.2380866678695, 5444.1017232156255, 5445.128779395357, 8433.662653493791, 8474.0, 8576.228139467477, 8595.226429621363, 8735.868961965576, 8549.829003419896, 8558.486490810572, 8599.78500537479, 8609.870851937227, 8663.653453861774, 6647.202335719745, 6675.966620166868, 6773.796786096425, 6775.017622444718, 6803.48973826965, 6403.423691867568, 6430.3891130342545, 6480.70836812354, 6502.707378168088, 6507.056476810931, 7537.8115547111765, 7591.089069311718, 7675.5010924289745, 7684.6926122954455, 7786.610669466618, 7628.275313845176, 7775.805604859697, 7883.921160788319, 7938.3252423542335, 7981.0, 5913.497352724895, 5924.289085309791, 5937.762489500372, 5944.108383742473, 5945.554083443845, 5894.646321220741, 6659.567128136656, 6687.264400915993, 6875.0, 6899.379055884994, 5837.270341207349, 6015.39846015395, 6240.563160578716, 6414.198225221848, 6468.611883287018, 6306.369363063657, 6349.333320001333, 6359.96820015897, 6392.296847346695, 6498.707558159988, 6214.2853571838, 6394.200724909387, 6421.935780642134, 6461.709223084878, 6505.251896032017, 5909.025010873158, 5922.0, 5926.881462370815, 5929.318128415115, 5940.79207227745, 6053.909191362045, 6061.424164704346, 6073.574849760651, 6082.148499210202, 6091.299500557493], "unit": "ms", "name": "mootools.html", "value": 4054.277647720514}, {"lowerIsBetter": false, "replicates": [303.93921215756853, 303.9817610943345, 306.18554644645246, 313.81014486235824, 315.61179748908836, 5287.41838397776, 5327.89344213116, 5446.400895901447, 5455.290812194414, 5541.418151094133, 5255.947440525603, 5384.973075134619, 5398.352197736277, 5401.972990135044, 5402.432744561814, 3997.8001099944886, 4186.6859985501205, 4188.58114188581, 4195.160967806436, 4201.894952626179, 4077.143799802045, 4201.411802347674, 4226.598473145046, 4254.404383386328, 4301.913961720779, 4206.284931561627, 4242.936355954663, 4246.97876510617, 4259.552746961571, 4260.403543503912, 4243.363495475688, 4256.4679415073115, 4258.53156152823, 4258.9999999999845, 4270.359446083081, 3756.1548651553453, 3764.0401697566945, 3767.2088861339153, 3768.679662228714, 3769.8869033929027, 5075.314832497639, 5163.199704045879, 5236.764345604457, 5238.449962753933, 5238.842834714965, 4879.707217566957, 4889.315495830587, 4891.144049791273, 4892.290617860426, 4895.755212239374, 5495.313085864267, 5696.458836410535, 5737.225474560964, 5742.569307301969, 5755.769769209227, 3964.108075682977, 3984.2828290907623, 3991.0621004064024, 4090.1819636072905, 4096.672266218725, 5966.731497082642, 6029.909551356734, 6036.305824830157, 6039.54703397247, 6046.395360464006, 4155.085881106152, 4164.354525048622, 4168.083021735274, 4171.416001759695, 4174.144300418407, 4130.938035929464, 4217.746935183899, 4233.216854881856, 4242.151569686075, 4243.087736136746, 4883.389576302962, 4887.975560122177, 4896.559309662076, 4903.779329930162, 4907.312976183337, 5775.5668324875805, 5784.50831679312, 5785.450382213683, 5793.8551536211935, 5799.159121927297, 1516.4540765324475, 1528.9464868729542, 1531.1808182622244, 1532.0271627516606, 1534.8541888520572, 1033.9793204135874, 1039.8856125826153, 1048.3028785857318, 1056.1920131099714, 1067.114295135036, 4999.0, 5014.874628134253, 5017.698938063655, 5018.247262910592, 5018.799248030111, 5944.7324870380935, 5954.434328738763, 5956.76172953077, 5963.821085367446, 5969.611975221684, 5008.474110218447, 5009.0, 5010.3737032870895, 5019.247112933016, 5021.5229553192385, 3151.2594540283017, 3195.952060719091, 3226.7418606511424, 3229.4994275887275, 3234.3531293741344, 5589.469000444951, 5604.495595396353, 5621.0444224481935, 5624.521915637135, 5626.915596266059, 6124.173236613, 6130.724117414727, 6135.263768347827, 6135.7852475164045, 6138.294096178907, 5483.4516548344845, 5588.30146231721, 5625.6905870176715, 5630.71846407678, 5640.85897852557, 5737.196792449144, 5957.791477298274, 5962.135490353788, 5962.761489540369, 5966.791162309299, 5736.397678243724, 5785.161151633074, 5884.588078834612, 5885.264341957255, 5899.91150132757, 5646.830595082154, 5662.490375866192, 5672.290963629546, 5674.404187560247, 5686.545076393796, 4160.271952408256, 4161.833526659021, 4169.145325208265, 4169.45797046382, 4169.624733773975, 5871.266091738533, 6009.909851352146, 6017.18767966319, 6025.397460254115, 6030.246219222598, 5707.771689132388, 5767.942320576741, 5785.132230165509, 5791.189233507228, 5794.449527294901, 5732.111522713986, 5781.4507621775865, 5786.0, 5789.826305210682, 5791.8552036199435, 5442.074847275893, 5591.496765291144, 5599.496045355938, 5654.547636189012, 5662.688552129673, 5795.478406943395, 5796.797112101056, 5800.50695690871, 5804.100364443518, 5814.127880817742, 5644.6613203207935, 5647.85880352978, 5667.829965100888, 5670.631408958405, 5682.6306290091015], "unit": "ms", "name": "prototype.html", "value": 4331.122881777612}, {"lowerIsBetter": false, "replicates": [703.1175874277781, 704.060079793476, 773.4624436016967, 777.898873146491, 780.7735756630577, 11970.880291197085, 12187.451564679588, 12187.57343492978, 12189.146759726811, 14066.156030638169, 14026.859731402683, 14144.575662730109, 14150.575482735509, 14160.50438234662, 14172.0, 622.7228883147002, 632.0140580694109, 781.1797612506873, 815.4495715392087, 821.9095899451056, 788.4323287233211, 795.7254747112237, 801.8356236971435, 802.314021511608, 802.3380710913519, 789.8775689768095, 828.9378296627747, 836.2557323981662, 842.1199846160746, 842.9747107586752, 645.3481983196981, 654.9050387693782, 833.9624716887755, 840.2605706977881, 854.478767951549, 627.5889292513411, 628.0485065126337, 628.6668065925068, 628.7202195023217, 628.7516431009772, 12216.755664886741, 12337.50649974009, 12358.876411235862, 12369.0, 12371.938140309241, 10592.41741704206, 10888.891111088946, 10937.0, 11019.449027548671, 11293.233157876291, 8929.73210803677, 9181.816363672757, 9232.076792320782, 9266.351355405124, 9491.620335186653, 3143.2613335866054, 3166.319241363118, 3199.23218427578, 3204.983975080133, 3206.983965080183, 39777.40333894994, 40752.0, 40973.79513102475, 41625.37561936573, 42124.157516849795, 8783.121687831293, 9098.135677110797, 9209.677661281823, 9253.213476854542, 9279.118483744034, 16201.59496012609, 16206.59483512898, 16222.918885405497, 16234.83765162357, 16268.51194464168, 5485.094959331665, 5747.798827041033, 6563.245226798979, 6677.065210870482, 6812.046313516112, 3481.4603736420895, 3487.6512348764923, 3536.9469457958153, 3589.6769290763955, 3657.030886814996, 2694.353355194739, 2714.9457010859674, 2716.1308381318186, 2719.1706529508688, 2719.3881376690088, 473.4555261449292, 477.8638088144862, 479.95440433158797, 493.6174464789745, 493.71117896030506, 528.6484487815636, 596.427429667524, 610.3926593039954, 617.9227596550431, 632.9461995730322, 7218.8917166242545, 7350.4119670426235, 7430.925690743024, 7644.464887457936, 7661.387089032864, 460.4750584333862, 504.2008416659562, 563.5041163775851, 568.2300482845685, 571.5027925704663, 3410.687947876244, 3532.6114127445962, 3590.2998915211806, 3592.8023958682525, 3655.8903232903053, 48061.759691202016, 48836.267455988185, 48940.26589601159, 53721.73139134279, 53773.0, 43595.34606980898, 44215.778921105186, 44715.776421117684, 44784.55215447869, 46151.076978460915, 41828.79085604614, 42617.786911065865, 42620.3606945896, 42889.14221715548, 43263.13473730508, 7801.648925798239, 7924.841503169789, 7978.122406535393, 8042.798930026796, 8308.5430301334, 31681.683183168796, 32482.512762309056, 32617.879837810466, 32703.0, 33030.33939321248, 38845.61154388533, 39119.60880391159, 41022.38466423066, 41045.794771025954, 41347.1730565393, 9696.806063878825, 9778.022197780165, 10191.898081019095, 10202.744931376776, 10242.334248273839, 11685.123615728684, 11774.823377649513, 11838.644840654793, 11885.16803823724, 11955.0, 10514.789704206027, 10672.050764349347, 10752.462376880969, 11024.118070554498, 11185.88814111881, 10268.794624107326, 10319.845202321821, 10443.321184123008, 10622.0, 10800.945995269973, 9882.654107106217, 10041.648542300984, 10078.344907580984, 10275.7431064221, 10354.482275886025, 8843.91156088431, 8936.86594701067, 8980.101989800967, 9041.412308199946, 9434.716958491255, 8591.484510929364, 8648.870266946127, 8800.779980500283, 8838.602262898057, 8889.288856891562], "unit": "ms", "name": "yui.html", "value": 5735.035209462175}], "name": "dromaeo_css", "value": 6443.241766058924}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 112.0, 112.0, 112.0, 102.0, 111.0, 104.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [163.0, 131.0, 154.0, 167.0, 136.0, 153.0, 152.0, 132.0, 173.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 165.0, 161.0, 162.0, 160.0, 163.0, 162.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 85.0, 94.0, 72.0, 72.0, 73.0, 95.0, 94.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 131.0, 92.0, 93.0, 92.0, 128.0, 92.0, 92.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 103.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 112.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 148.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 70.0, 70.0, 68.0, 76.0, 65.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 68.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 83.0, 84.0, 84.0, 85.0, 83.0, 92.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 125.0, 117.0, 121.0, 124.0, 122.0, 120.0, 127.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 145.0, 144.0, 147.0, 134.0, 152.0, 134.0, 144.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1513.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.41959881617888], "unit": "score", "name": "Richards", "value": 214.70676399999994}, {"lowerIsBetter": false, "replicates": [190.80328181644725], "unit": "score", "name": "DeltaBlue", "value": 346.5244380000001}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [616.5228113440197], "unit": "score", "name": "Splay", "value": 132.17840199999998}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19797.032800852965}]} 08:30:08 INFO - RETURN: dromaeo_css: 6443.24 08:30:08 INFO - RETURN: kraken: 1513.10 08:30:08 INFO - RETURN: v8_7: 19797.03 08:30:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19797.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1513.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6443.24"}}} 08:30:08 INFO - Return code: 0 08:30:08 INFO - # TBPL SUCCESS # 08:30:08 INFO - Running post-action listener: _resource_record_post_action 08:30:08 INFO - Running post-run listener: _resource_record_post_run 08:30:09 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 503894016; Read time: 0; Write time: 526476 08:30:09 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 215674880; Read time: 0; Write time: 265252 08:30:09 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 288219136; Read time: 0; Write time: 261224 08:30:09 INFO - Running post-run listener: _upload_blobber_files 08:30:09 INFO - Blob upload gear active. 08:30:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:30:09 INFO - Copying logs to upload dir... 08:30:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1289.141497 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-20 08:30:09.630598) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:30:09.634437) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008746 build_url: 'https://queue.taskcluster.net/v1/task/Vx7ItbThRJWHB-rN1aTsvw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:30:09.683258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:30:09.683750) ========= 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=01deea79d00cc2c334834894000001d2-1448034677.398146-1034299314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:30:09.733895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 08:30:09.734241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 08:30:09.734538) ========= ========= Total master_lag: 0.21 =========