builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1448000166.49 results: success (0) buildid: 20151119211036 builduid: dcd87b7a8c9b4a67a2ac813c610d7193 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.486504) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.487031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.487354) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009220 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.574127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.574439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.588154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.588549) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.637790) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.638114) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.638499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.638795) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 22:16:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.4M=0s 2015-11-19 22:16:07 (97.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172816 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.824374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.824705) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:06.874792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 22:16:06.875159) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --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 1b2e15608f34fef0f23369731c80138f55f00cf2 --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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 22:16:07,698 truncating revision to first 12 chars 2015-11-19 22:16:07,698 Setting DEBUG logging. 2015-11-19 22:16:07,698 attempt 1/10 2015-11-19 22:16:07,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 22:16:08,914 unpacking tar archive at: fx-team-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 22:16:08.393869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:08.394203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:08.402705) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:08.403064) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:16:08.403500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:16:08.403811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:16:09 INFO - MultiFileLogger online at 20151119 22:16:09 in /builds/slave/test 22:16:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:16:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:16:09 INFO - {'append_to_log': False, 22:16:09 INFO - 'base_work_dir': '/builds/slave/test', 22:16:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:16:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:16:09 INFO - 'branch': 'Fx-Team-Non-PGO', 22:16:09 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:09 INFO - 'config_files': ('talos/linux_config.py',), 22:16:09 INFO - 'default_actions': ('clobber', 22:16:09 INFO - 'read-buildbot-config', 22:16:09 INFO - 'download-and-extract', 22:16:09 INFO - 'populate-webroot', 22:16:09 INFO - 'create-virtualenv', 22:16:09 INFO - 'install', 22:16:09 INFO - 'run-tests'), 22:16:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:09 INFO - 'download_minidump_stackwalk': True, 22:16:09 INFO - 'download_symbols': 'ondemand', 22:16:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:09 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:09 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:09 INFO - 'installer_path': 'installer.exe', 22:16:09 INFO - 'log_level': 'info', 22:16:09 INFO - 'log_name': 'talos', 22:16:09 INFO - 'log_to_console': True, 22:16:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:16:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:16:09 INFO - 'opt_config_files': (), 22:16:09 INFO - 'pip_index': False, 22:16:09 INFO - 'sps_profile': False, 22:16:09 INFO - 'sps_profile_interval': 0, 22:16:09 INFO - 'suite': 'dromaeojs-e10s', 22:16:09 INFO - 'system_bits': '64', 22:16:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:09 INFO - 'title': 'talos-linux64-ix-051', 22:16:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:09 INFO - 'use_talos_json': True, 22:16:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:16:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:09 INFO - 'work_dir': 'build'} 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running clobber step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: clobber 22:16:09 INFO - rmtree: /builds/slave/test/build 22:16:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:16:09 INFO - Running post-action listener: _resource_record_post_action 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running read-buildbot-config step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: read_buildbot_config 22:16:09 INFO - Using buildbot properties: 22:16:09 INFO - { 22:16:09 INFO - "properties": { 22:16:09 INFO - "buildnumber": 432, 22:16:09 INFO - "product": "firefox", 22:16:09 INFO - "script_repo_revision": "production", 22:16:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:16:09 INFO - "repository": "", 22:16:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:16:09 INFO - "buildid": "20151119211036", 22:16:09 INFO - "slavename": "talos-linux64-ix-051", 22:16:09 INFO - "pgo_build": "False", 22:16:09 INFO - "basedir": "/builds/slave/test", 22:16:09 INFO - "project": "", 22:16:09 INFO - "platform": "ubuntu64_hw", 22:16:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:16:09 INFO - "slavebuilddir": "test", 22:16:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:16:09 INFO - "branch": "fx-team", 22:16:09 INFO - "repo_path": "integration/fx-team", 22:16:09 INFO - "stage_platform": "linux64", 22:16:09 INFO - "builduid": "dcd87b7a8c9b4a67a2ac813c610d7193", 22:16:09 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:16:09 INFO - }, 22:16:09 INFO - "sourcestamp": { 22:16:09 INFO - "repository": "", 22:16:09 INFO - "hasPatch": false, 22:16:09 INFO - "project": "", 22:16:09 INFO - "branch": "fx-team-linux64-talos", 22:16:09 INFO - "changes": [ 22:16:09 INFO - { 22:16:09 INFO - "category": null, 22:16:09 INFO - "files": [ 22:16:09 INFO - { 22:16:09 INFO - "url": null, 22:16:09 INFO - "name": "https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:16:09 INFO - } 22:16:09 INFO - ], 22:16:09 INFO - "repository": "", 22:16:09 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 22:16:09 INFO - "who": "philringnalda@gmail.com", 22:16:09 INFO - "when": 1448000103, 22:16:09 INFO - "number": 6686988, 22:16:09 INFO - "comments": "Merge m-c to f-t", 22:16:09 INFO - "project": "", 22:16:09 INFO - "at": "Thu 19 Nov 2015 22:15:03", 22:16:09 INFO - "branch": "fx-team-linux64-talos", 22:16:09 INFO - "revlink": "", 22:16:09 INFO - "properties": [ 22:16:09 INFO - [ 22:16:09 INFO - "buildid", 22:16:09 INFO - "20151119211036", 22:16:09 INFO - "Change" 22:16:09 INFO - ], 22:16:09 INFO - [ 22:16:09 INFO - "builduid", 22:16:09 INFO - "dcd87b7a8c9b4a67a2ac813c610d7193", 22:16:09 INFO - "Change" 22:16:09 INFO - ], 22:16:09 INFO - [ 22:16:09 INFO - "pgo_build", 22:16:09 INFO - "False", 22:16:09 INFO - "Change" 22:16:09 INFO - ] 22:16:09 INFO - ], 22:16:09 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:16:09 INFO - } 22:16:09 INFO - ], 22:16:09 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:16:09 INFO - } 22:16:09 INFO - } 22:16:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:16:09 INFO - Running post-action listener: _resource_record_post_action 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running download-and-extract step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: download_and_extract 22:16:09 INFO - mkdir: /builds/slave/test/build/tests 22:16:09 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')]} 22:16:09 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json 22:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json 22:16:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:16:10 INFO - Downloaded 1302 bytes. 22:16:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:16:10 INFO - Using the following test package requirements: 22:16:10 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:16:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'jsshell-linux-x86_64.zip'], 22:16:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:16:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:16:10 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:16:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:16:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:16:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:10 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:16:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:14 INFO - Downloaded 21339275 bytes. 22:16:14 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 22:16:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:14 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 22:16:15 INFO - Return code: 0 22:16:15 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 22:16: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')]} 22:16:15 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:17 INFO - Downloaded 21339275 bytes. 22:16:17 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 22:16:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:16:17 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 22:16:18 INFO - Return code: 0 22:16:18 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')]} 22:16:18 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:19 INFO - Downloaded 11130997 bytes. 22:16:19 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 22:16:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:19 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 22:16:19 INFO - Return code: 0 22:16: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')]} 22:16:19 INFO - https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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 22:16:22 INFO - Downloaded 55783644 bytes. 22:16:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:16:22 INFO - mkdir: /builds/slave/test/properties 22:16:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:16:22 INFO - Writing to file /builds/slave/test/properties/build_url 22:16:22 INFO - Contents: 22:16:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:16:22 INFO - Running post-action listener: _resource_record_post_action 22:16:22 INFO - Running post-action listener: set_extra_try_arguments 22:16:22 INFO - ##### 22:16:22 INFO - ##### Running populate-webroot step. 22:16:22 INFO - ##### 22:16:22 INFO - Running pre-action listener: _resource_record_pre_action 22:16:22 INFO - Running main action method: populate_webroot 22:16:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:16:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:16:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:16:22 INFO - '../fennec_ids.txt'], 22:16:22 INFO - 'tests': ['tcheck2']}, 22:16:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:16:22 INFO - '--tppagecycles', 22:16:22 INFO - '7'], 22:16:22 INFO - 'tests': ['tsvgm']}}, 22:16:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:16:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:16:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:16:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:16:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['damp', 'tps']}, 22:16:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['damp', 'tps']}, 22:16:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:16:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:16:22 INFO - 'other': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other_l64': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other_nol64': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'svgr': {'tests': ['tsvgx', 22:16:22 INFO - 'tsvgr_opacity', 22:16:22 INFO - 'tart', 22:16:22 INFO - 'tscrollx', 22:16:22 INFO - 'cart']}, 22:16:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tsvgx', 22:16:22 INFO - 'tsvgr_opacity', 22:16:22 INFO - 'tart', 22:16:22 INFO - 'tscrollx', 22:16:22 INFO - 'cart']}, 22:16:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['tp5o']}, 22:16:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tp5o']}, 22:16:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--xperf_path', 22:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:22 INFO - 'tests': ['tp5n']}, 22:16:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s', 22:16:22 INFO - '--xperf_path', 22:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:22 INFO - 'tests': ['tp5n']}}, 22:16:22 INFO - 'talos.zip': {'path': '', 22:16:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:16:22 INFO - Running post-action listener: _resource_record_post_action 22:16:22 INFO - ##### 22:16:22 INFO - ##### Running create-virtualenv step. 22:16:22 INFO - ##### 22:16:22 INFO - Running pre-action listener: _resource_record_pre_action 22:16:22 INFO - Running main action method: create_virtualenv 22:16:22 INFO - Creating virtualenv /builds/slave/test/build/venv 22:16:22 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 22:16:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:16:22 INFO - Using real prefix '/usr' 22:16:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:16:24 INFO - Installing pip.................done. 22:16:25 INFO - Return code: 0 22:16:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:16:25 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')]} 22:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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')]} 22:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:25 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 22:16:25 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 22:16:25 INFO - Using env: {'DISPLAY': ':0', 22:16:25 INFO - 'HOME': '/home/cltbld', 22:16:25 INFO - 'LANG': 'en_US.UTF-8', 22:16:25 INFO - 'LANGUAGE': 'en_US:en', 22:16:25 INFO - 'LOGNAME': 'cltbld', 22:16:25 INFO - 'MAIL': '/var/mail/cltbld', 22:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:25 INFO - 'MOZ_NO_REMOTE': '1', 22:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:25 INFO - 'NO_EM_RESTART': '1', 22:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:25 INFO - 'PWD': '/builds/slave/test', 22:16:25 INFO - 'SHELL': '/bin/bash', 22:16:25 INFO - 'SHLVL': '1', 22:16:25 INFO - 'TERM': 'linux', 22:16:25 INFO - 'TMOUT': '86400', 22:16:25 INFO - 'USER': 'cltbld', 22:16:25 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:25 INFO - '_': '/tools/buildbot/bin/python'} 22:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:25 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 22:16:25 INFO - Cleaning up... 22:16:25 INFO - Return code: 0 22:16:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:16:25 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')]} 22:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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')]} 22:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:25 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 22:16:25 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 22:16:25 INFO - Using env: {'DISPLAY': ':0', 22:16:25 INFO - 'HOME': '/home/cltbld', 22:16:25 INFO - 'LANG': 'en_US.UTF-8', 22:16:25 INFO - 'LANGUAGE': 'en_US:en', 22:16:25 INFO - 'LOGNAME': 'cltbld', 22:16:25 INFO - 'MAIL': '/var/mail/cltbld', 22:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:25 INFO - 'MOZ_NO_REMOTE': '1', 22:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:25 INFO - 'NO_EM_RESTART': '1', 22:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:25 INFO - 'PWD': '/builds/slave/test', 22:16:25 INFO - 'SHELL': '/bin/bash', 22:16:25 INFO - 'SHLVL': '1', 22:16:25 INFO - 'TERM': 'linux', 22:16:25 INFO - 'TMOUT': '86400', 22:16:25 INFO - 'USER': 'cltbld', 22:16:25 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:25 INFO - '_': '/tools/buildbot/bin/python'} 22:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:25 INFO - Downloading/unpacking psutil>=0.7.1 22:16:25 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 22:16:25 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 22:16:25 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 22:16:25 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 22:16:25 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 22:16:25 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 22:16:27 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:16:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:27 INFO - Installing collected packages: psutil 22:16:27 INFO - Running setup.py install for psutil 22:16:27 INFO - building 'psutil._psutil_linux' extension 22:16:27 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 22:16:27 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 22:16:27 INFO - building 'psutil._psutil_posix' extension 22:16:27 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 22:16:27 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 22:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:27 INFO - Successfully installed psutil 22:16:27 INFO - Cleaning up... 22:16:27 INFO - Return code: 0 22:16:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:16: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')]} 22:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:27 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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:27 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 22:16:27 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 22:16:27 INFO - Using env: {'DISPLAY': ':0', 22:16:27 INFO - 'HOME': '/home/cltbld', 22:16:27 INFO - 'LANG': 'en_US.UTF-8', 22:16:27 INFO - 'LANGUAGE': 'en_US:en', 22:16:27 INFO - 'LOGNAME': 'cltbld', 22:16:27 INFO - 'MAIL': '/var/mail/cltbld', 22:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:27 INFO - 'MOZ_NO_REMOTE': '1', 22:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:27 INFO - 'NO_EM_RESTART': '1', 22:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:27 INFO - 'PWD': '/builds/slave/test', 22:16:27 INFO - 'SHELL': '/bin/bash', 22:16:27 INFO - 'SHLVL': '1', 22:16:27 INFO - 'TERM': 'linux', 22:16:27 INFO - 'TMOUT': '86400', 22:16:27 INFO - 'USER': 'cltbld', 22:16:27 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:27 INFO - '_': '/tools/buildbot/bin/python'} 22:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:16:28 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 22:16:28 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 22:16:28 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 22:16:28 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 22:16:28 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 22:16:28 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 22:16:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:16:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:16:29 INFO - Installing collected packages: mozsystemmonitor 22:16:29 INFO - Running setup.py install for mozsystemmonitor 22:16:29 INFO - Successfully installed mozsystemmonitor 22:16:29 INFO - Cleaning up... 22:16:30 INFO - Return code: 0 22:16:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:16: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')]} 22:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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', '--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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:30 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 22:16:30 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 22:16:30 INFO - Using env: {'DISPLAY': ':0', 22:16:30 INFO - 'HOME': '/home/cltbld', 22:16:30 INFO - 'LANG': 'en_US.UTF-8', 22:16:30 INFO - 'LANGUAGE': 'en_US:en', 22:16:30 INFO - 'LOGNAME': 'cltbld', 22:16:30 INFO - 'MAIL': '/var/mail/cltbld', 22:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:30 INFO - 'MOZ_NO_REMOTE': '1', 22:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:30 INFO - 'NO_EM_RESTART': '1', 22:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:30 INFO - 'PWD': '/builds/slave/test', 22:16:30 INFO - 'SHELL': '/bin/bash', 22:16:30 INFO - 'SHLVL': '1', 22:16:30 INFO - 'TERM': 'linux', 22:16:30 INFO - 'TMOUT': '86400', 22:16:30 INFO - 'USER': 'cltbld', 22:16:30 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:30 INFO - '_': '/tools/buildbot/bin/python'} 22:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:30 INFO - Downloading/unpacking blobuploader==1.2.4 22:16:30 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 22:16:30 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 22:16:30 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 22:16:30 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 22:16:30 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 22:16:30 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 22:16:31 INFO - Downloading blobuploader-1.2.4.tar.gz 22:16:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:16:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:16: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 22:16: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 22:16: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 22:16: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 22:16: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 22:16: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 22:16:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:16:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:16:32 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 22:16:32 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 22:16:32 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 22:16:32 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 22:16:32 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 22:16:32 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 22:16:32 INFO - Downloading docopt-0.6.1.tar.gz 22:16:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:16:32 INFO - Installing collected packages: blobuploader, requests, docopt 22:16:32 INFO - Running setup.py install for blobuploader 22:16:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:16:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:16:32 INFO - Running setup.py install for requests 22:16:33 INFO - Running setup.py install for docopt 22:16:33 INFO - Successfully installed blobuploader requests docopt 22:16:33 INFO - Cleaning up... 22:16:33 INFO - Return code: 0 22:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:16: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')]} 22:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:33 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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:33 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 22:16:33 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 22:16:33 INFO - Using env: {'DISPLAY': ':0', 22:16:33 INFO - 'HOME': '/home/cltbld', 22:16:33 INFO - 'LANG': 'en_US.UTF-8', 22:16:33 INFO - 'LANGUAGE': 'en_US:en', 22:16:33 INFO - 'LOGNAME': 'cltbld', 22:16:33 INFO - 'MAIL': '/var/mail/cltbld', 22:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:33 INFO - 'MOZ_NO_REMOTE': '1', 22:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:33 INFO - 'NO_EM_RESTART': '1', 22:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:33 INFO - 'PWD': '/builds/slave/test', 22:16:33 INFO - 'SHELL': '/bin/bash', 22:16:33 INFO - 'SHLVL': '1', 22:16:33 INFO - 'TERM': 'linux', 22:16:33 INFO - 'TMOUT': '86400', 22:16:33 INFO - 'USER': 'cltbld', 22:16:33 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:33 INFO - '_': '/tools/buildbot/bin/python'} 22:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:16:33 INFO - Running setup.py (path:/tmp/pip-IvMFle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:16:33 INFO - Running setup.py (path:/tmp/pip-jTVhJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:16:33 INFO - Running setup.py (path:/tmp/pip-ckDsBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:16:33 INFO - Running setup.py (path:/tmp/pip-t3SnaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:16:33 INFO - Running setup.py (path:/tmp/pip-_lEyPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:16:33 INFO - Running setup.py (path:/tmp/pip-q8bZef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:16:33 INFO - Running setup.py (path:/tmp/pip-s5YO1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:16:33 INFO - Running setup.py (path:/tmp/pip-nVVJZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:16:33 INFO - Running setup.py (path:/tmp/pip-mLy2y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:16:34 INFO - Running setup.py (path:/tmp/pip-WwkJU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:16:34 INFO - Running setup.py (path:/tmp/pip-W8X2FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:16:34 INFO - Running setup.py (path:/tmp/pip-eJGRo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:16:34 INFO - Running setup.py (path:/tmp/pip-UhRNAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:16:34 INFO - Running setup.py (path:/tmp/pip-AOUWm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:34 INFO - Running setup.py (path:/tmp/pip-OD1YP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:16:34 INFO - Running setup.py (path:/tmp/pip-EtdGEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:16:34 INFO - Running setup.py (path:/tmp/pip-Y4q6tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:16:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:16:34 INFO - Running setup.py install for manifestparser 22:16:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:16:34 INFO - Running setup.py install for mozcrash 22:16:34 INFO - Running setup.py install for mozdebug 22:16:34 INFO - Running setup.py install for mozdevice 22:16:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozfile 22:16:35 INFO - Running setup.py install for mozhttpd 22:16:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozinfo 22:16:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozInstall 22:16:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozleak 22:16:35 INFO - Running setup.py install for mozlog 22:16:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for moznetwork 22:16:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozprocess 22:16:35 INFO - Running setup.py install for mozprofile 22:16:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:16:35 INFO - Running setup.py install for mozrunner 22:16:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:16:36 INFO - Running setup.py install for mozscreenshot 22:16:36 INFO - Running setup.py install for moztest 22:16:36 INFO - Running setup.py install for mozversion 22:16:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:16:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:16:36 INFO - Cleaning up... 22:16:36 INFO - Return code: 0 22:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:36 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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:36 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 22:16:36 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 22:16:36 INFO - Using env: {'DISPLAY': ':0', 22:16:36 INFO - 'HOME': '/home/cltbld', 22:16:36 INFO - 'LANG': 'en_US.UTF-8', 22:16:36 INFO - 'LANGUAGE': 'en_US:en', 22:16:36 INFO - 'LOGNAME': 'cltbld', 22:16:36 INFO - 'MAIL': '/var/mail/cltbld', 22:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:36 INFO - 'MOZ_NO_REMOTE': '1', 22:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:36 INFO - 'NO_EM_RESTART': '1', 22:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:36 INFO - 'PWD': '/builds/slave/test', 22:16:36 INFO - 'SHELL': '/bin/bash', 22:16:36 INFO - 'SHLVL': '1', 22:16:36 INFO - 'TERM': 'linux', 22:16:36 INFO - 'TMOUT': '86400', 22:16:36 INFO - 'USER': 'cltbld', 22:16:36 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:36 INFO - '_': '/tools/buildbot/bin/python'} 22:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:16:36 INFO - Running setup.py (path:/tmp/pip-Vs5Yap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:16:36 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)) 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:16:36 INFO - Running setup.py (path:/tmp/pip-eLVGyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:16:36 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)) 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:16:36 INFO - Running setup.py (path:/tmp/pip-4Q2jtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:16:36 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)) 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:16:36 INFO - Running setup.py (path:/tmp/pip-RAws0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:16:36 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)) 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:16:36 INFO - Running setup.py (path:/tmp/pip-rZ8X4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:16:36 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)) 22:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:16:37 INFO - Running setup.py (path:/tmp/pip-8jmwWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:16:37 INFO - Running setup.py (path:/tmp/pip-4xBVBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:16:37 INFO - Running setup.py (path:/tmp/pip-kjzRx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:16:37 INFO - Running setup.py (path:/tmp/pip-yXAyjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:16:37 INFO - Running setup.py (path:/tmp/pip-RE1gIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:16:37 INFO - Running setup.py (path:/tmp/pip-ibIUP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:16:37 INFO - Running setup.py (path:/tmp/pip-oqZsI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:16:37 INFO - Running setup.py (path:/tmp/pip-Gge7BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:16:37 INFO - Running setup.py (path:/tmp/pip-D6N95V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:37 INFO - Running setup.py (path:/tmp/pip-OC9ENS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:16:37 INFO - Running setup.py (path:/tmp/pip-nUSigv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:16:37 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)) 22:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:16:37 INFO - Running setup.py (path:/tmp/pip-KpNabV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:16:37 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)) 22:16:37 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)) 22:16:37 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)) 22:16:37 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)) 22:16:37 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)) 22:16:37 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)) 22:16:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:39 INFO - Downloading blessings-1.5.1.tar.gz 22:16:39 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 22:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:16:39 INFO - Installing collected packages: blessings 22:16:39 INFO - Running setup.py install for blessings 22:16:39 INFO - Successfully installed blessings 22:16:39 INFO - Cleaning up... 22:16:39 INFO - Return code: 0 22:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:16:39 INFO - Reading from file tmpfile_stdout 22:16:39 INFO - Current package versions: 22:16:40 INFO - argparse == 1.2.1 22:16:40 INFO - blessings == 1.5.1 22:16:40 INFO - blobuploader == 1.2.4 22:16:40 INFO - docopt == 0.6.1 22:16:40 INFO - manifestparser == 1.1 22:16:40 INFO - mozInstall == 1.12 22:16:40 INFO - mozcrash == 0.16 22:16:40 INFO - mozdebug == 0.1 22:16:40 INFO - mozdevice == 0.47 22:16:40 INFO - mozfile == 1.2 22:16:40 INFO - mozhttpd == 0.7 22:16:40 INFO - mozinfo == 0.9 22:16:40 INFO - mozleak == 0.1 22:16:40 INFO - mozlog == 3.0 22:16:40 INFO - moznetwork == 0.27 22:16:40 INFO - mozprocess == 0.22 22:16:40 INFO - mozprofile == 0.27 22:16:40 INFO - mozrunner == 6.11 22:16:40 INFO - mozscreenshot == 0.1 22:16:40 INFO - mozsystemmonitor == 0.0 22:16:40 INFO - moztest == 0.7 22:16:40 INFO - mozversion == 1.4 22:16:40 INFO - psutil == 3.1.1 22:16:40 INFO - requests == 1.2.3 22:16:40 INFO - wsgiref == 0.1.2 22:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f471fd46c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12886c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1339900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, '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': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', '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 22:16:40 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 22:16:40 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 22:16:40 INFO - Using env: {'DISPLAY': ':0', 22:16:40 INFO - 'HOME': '/home/cltbld', 22:16:40 INFO - 'LANG': 'en_US.UTF-8', 22:16:40 INFO - 'LANGUAGE': 'en_US:en', 22:16:40 INFO - 'LOGNAME': 'cltbld', 22:16:40 INFO - 'MAIL': '/var/mail/cltbld', 22:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:40 INFO - 'MOZ_NO_REMOTE': '1', 22:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:40 INFO - 'NO_EM_RESTART': '1', 22:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:40 INFO - 'PWD': '/builds/slave/test', 22:16:40 INFO - 'SHELL': '/bin/bash', 22:16:40 INFO - 'SHLVL': '1', 22:16:40 INFO - 'TERM': 'linux', 22:16:40 INFO - 'TMOUT': '86400', 22:16:40 INFO - 'USER': 'cltbld', 22:16:40 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:40 INFO - '_': '/tools/buildbot/bin/python'} 22:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 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)) 22:16:40 INFO - Cleaning up... 22:16:40 INFO - Return code: 0 22:16:40 INFO - Running post-action listener: _resource_record_post_action 22:16:40 INFO - Running post-action listener: _start_resource_monitoring 22:16:40 INFO - Starting resource monitoring. 22:16:40 INFO - ##### 22:16:40 INFO - ##### Running install step. 22:16:40 INFO - ##### 22:16:40 INFO - Running pre-action listener: _resource_record_pre_action 22:16:40 INFO - Running main action method: install 22:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:16:40 INFO - Reading from file tmpfile_stdout 22:16:40 INFO - Detecting whether we're running mozinstall >=1.0... 22:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:16:40 INFO - Reading from file tmpfile_stdout 22:16:40 INFO - Output received: 22:16:40 INFO - Usage: mozinstall [options] installer 22:16:40 INFO - Options: 22:16:40 INFO - -h, --help show this help message and exit 22:16:40 INFO - -d DEST, --destination=DEST 22:16:40 INFO - Directory to install application into. [default: 22:16:40 INFO - "/builds/slave/test"] 22:16:40 INFO - --app=APP Application being installed. [default: firefox] 22:16:40 INFO - mkdir: /builds/slave/test/build/application 22:16:40 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'] 22:16:40 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 22:16:54 INFO - Reading from file tmpfile_stdout 22:16:54 INFO - Output received: 22:16:54 INFO - /builds/slave/test/build/application/firefox/firefox 22:16:54 INFO - Running post-action listener: _resource_record_post_action 22:16:54 INFO - ##### 22:16:54 INFO - ##### Running run-tests step. 22:16:54 INFO - ##### 22:16:54 INFO - Running pre-action listener: _resource_record_pre_action 22:16:54 INFO - Running main action method: run_tests 22:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:16:54 INFO - Python 2.7.3 22:16:54 INFO - Return code: 0 22:16:54 INFO - grabbing minidump binary from tooltool 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:54 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 0x137fb70>, '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 0x13d0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d1250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:16:54 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 22:16:54 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 22:16:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:16:54 INFO - Return code: 0 22:16:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:16:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:16:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:16:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:16:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:16:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] in /builds/slave/test/build 22:16:54 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost 22:16:54 INFO - Using env: {'DISPLAY': ':0', 22:16:54 INFO - 'HOME': '/home/cltbld', 22:16:54 INFO - 'LANG': 'en_US.UTF-8', 22:16:54 INFO - 'LANGUAGE': 'en_US:en', 22:16:54 INFO - 'LOGNAME': 'cltbld', 22:16:54 INFO - 'MAIL': '/var/mail/cltbld', 22:16:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:16:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:54 INFO - 'MOZ_NO_REMOTE': '1', 22:16:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:54 INFO - 'NO_EM_RESTART': '1', 22:16:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:16:54 INFO - 'PWD': '/builds/slave/test', 22:16:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:16:54 INFO - 'SHELL': '/bin/bash', 22:16:54 INFO - 'SHLVL': '1', 22:16:54 INFO - 'TERM': 'linux', 22:16:54 INFO - 'TMOUT': '86400', 22:16:54 INFO - 'USER': 'cltbld', 22:16:54 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192', 22:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:54 INFO - '_': '/tools/buildbot/bin/python'} 22:16:54 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] with output_timeout 3600 22:16:54 INFO - mozversion INFO | application_buildid: 20151119211036 22:16:54 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:16:54 INFO - mozversion INFO | application_display_name: Nightly 22:16:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:16:54 INFO - mozversion INFO | application_name: Firefox 22:16:54 INFO - mozversion INFO | application_remotingname: firefox 22:16:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:16:54 INFO - mozversion INFO | application_vendor: Mozilla 22:16:54 INFO - mozversion INFO | application_version: 45.0a1 22:16:54 INFO - mozversion INFO | platform_buildid: 20151119211036 22:16:54 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:16:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:16:54 INFO - mozversion INFO | platform_version: 45.0a1 22:16:54 INFO - 2015-11-19 22:16:54,982 DEBUG : using testdate: 1448000214 22:16:54 INFO - 2015-11-19 22:16:54,983 DEBUG : actual date: 1448000214 22:16:54 INFO - 2015-11-19 22:16:54,991 INFO : starting webserver on 'localhost:52219' 22:16:54 INFO - 2015-11-19 22:16:54,992 INFO : Starting test suite talos-linux64-ix-051.e 22:16:54 INFO - 2015-11-19 22:16:54,992 INFO : Starting test dromaeo_css 22:16:54 INFO - 2015-11-19 22:16:54,993 DEBUG : operating with platform_type : linux_ 22:16:54 INFO - 2015-11-19 22:16:54,993 INFO : Initialising browser for dromaeo_css test... 22:16:55 INFO - 2015-11-19 22:16:55,008 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiW8qTW/profile http://localhost:52219/getInfo.html 22:17:00 INFO - 2015-11-19 22:16:59,999 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:17:00 INFO - 2015-11-19 22:16:59,999 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:17:00 INFO - 2015-11-19 22:17:00,000 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:17:00 INFO - 2015-11-19 22:17:00,000 DEBUG : BROWSER_OUTPUT: __metrics 22:17:01 INFO - 2015-11-19 22:17:01,014 INFO : Browser initialized. 22:17:01 INFO - 2015-11-19 22:17:01,014 INFO : Running cycle 1/1 for dromaeo_css test... 22:17:01 INFO - 2015-11-19 22:17:01,015 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiW8qTW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:17:12 INFO - 2015-11-19 22:17:12,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 141545472 22:17:12 INFO - 2015-11-19 22:17:12,991 DEBUG : BROWSER_OUTPUT: 22:18:02 INFO - 2015-11-19 22:18:02,641 DEBUG : BROWSER_OUTPUT: 1448000282639 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] 22:20:14 INFO - 2015-11-19 22:20:14,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52219/tests/dromaeo/cssquery-ext.html) 22:20:15 INFO - 2015-11-19 22:20:15,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 144183296 22:20:15 INFO - 2015-11-19 22:20:15,941 DEBUG : BROWSER_OUTPUT: 22:23:17 INFO - 2015-11-19 22:23:17,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-ext.html (next: http://localhost:52219/tests/dromaeo/cssquery-jquery.html) 22:23:18 INFO - 2015-11-19 22:23:18,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 143478784 22:23:18 INFO - 2015-11-19 22:23:18,467 DEBUG : BROWSER_OUTPUT: 22:26:20 INFO - 2015-11-19 22:26:20,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52219/tests/dromaeo/cssquery-mootools.html) 22:26:20 INFO - 2015-11-19 22:26:20,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 22:26:20 INFO - 2015-11-19 22:26:20,861 DEBUG : BROWSER_OUTPUT: 22:29:22 INFO - 2015-11-19 22:29:22,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52219/tests/dromaeo/cssquery-prototype.html) 22:29:23 INFO - 2015-11-19 22:29:23,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 140894208 22:29:23 INFO - 2015-11-19 22:29:23,245 DEBUG : BROWSER_OUTPUT: 22:32:25 INFO - 2015-11-19 22:32:25,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52219/tests/dromaeo/cssquery-yui.html) 22:32:26 INFO - 2015-11-19 22:32:26,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 140517376 22:32:26 INFO - 2015-11-19 22:32:26,406 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/dromaeo/cssquery-yui.html (next: http://localhost:52219/tests/dromaeo/cssquery-dojo.html) 22:35:28 INFO - 2015-11-19 22:35:28,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 143921152 22:35:28 INFO - 2015-11-19 22:35:28,799 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:35:28 INFO - 2015-11-19 22:35:28,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:35:28 INFO - 2015-11-19 22:35:28,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:35:28 INFO - 2015-11-19 22:35:28,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:35:28 INFO - 2015-11-19 22:35:28,802 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2724.7547720705134;2801.957970630442;2807.7613402860757;2822.195674232844;2830.1085158175174;4642.883927901804;4884.609231261499;4913.017396520697;4951.678140920838;4983;4775.976120119394;4790.898093438511;4823.734694591796;4905.509449055093;4907.067657145149;4382.758948257852;4407.867763967086;4468.664850136237;4476;4505.977470112645;4453;4531.524189960056;4577.038821847399;4605.447346318447;4664.067186562684;4299.527052024275;4390.231709450865;4396.604305612478;4505.3917721107555;4524.977375113136;4492.3710680504755;4508.977455112704;4512.052468981485;4542.454905411372;4545.795439205243;4484.372187893698;4504.1892459357305;4510.143072816154;4513.142502924434;4541.227991241497;4570.748608826513;4618.376519169903;4628.25947848346;4765.475797662254;4810.542998415145;5167.379914410257;5252.71110088945;5254.973725131388;5257.263983042339;5317.335333083364;5003.574696150831;5279.260903473517;5293.285406470154;5303.814366497193;5307.416184219733;4775.474697783241;4788.114198873254;4850.151223535867;4866.586340161055;4906.460289368167;5365.731713414391;5380.139177731544;5410.864728381822;5419.783208671609;5460.699661518575;4928.901421971541;4943.678660887031;5167.224916262516;5183.403908550489;5187.221916712448;5039.3448851649055;5143.048536020773;5156.793728250828;5168.457311982263;5225.242339860699;5111.5655169310285;5125.923111153335;5152.3044389007755;5163.509466600667;5192.662476939063;4914.262860570943;5014.147594908874;5034.0938631046765;5131.10205714006;5136.280920671109;4312.870613881589;4333.544977777351;4334.631556317685;4347.869563913087;4359.149965756647;3800.9809950950066;3801.9809900950872;3815.599362066943;3833.4824798652385;3850.249201405699;4221.113566151082;4359.215341238608;4381.101874115862;4402.3396490526675;4495.9325610115875;5174.508421699932;5262.71055091966;5307.124324486416;5308.044551980681;5345.33183352081;4420.8673739787855;4437.42313499243;4443.844465443694;4444.911101777946;4492.281235002384;4368.650507959355;4470.843520476833;4532.546745325441;4565.6119229865835;4623.9075218495445;4843.055604157155;4902.7058376497525;4909.828156014522;4915.43472500667;4948.752562371867;5143.8456846294675;5161.0968080585;5169.095408303607;5171.81898633546;5239.266502689703;4703.929441058455;4792.376990991288;4803.855884323476;4887.242477416006;4894.535019173173;5152.458991805806;5165.974170129276;5173.586113111018;5176.327077479904;5188.922166167586;5269;5285.075111855333;5304.549113325256;5305.734713264398;5307.9469205309;4834.975825120852;4904.6566740327835;4957.776900039435;5068.847934561969;5074.035933172685;5078.415982162099;5122.769475373542;5142.897142057063;5147.871303217449;5152.879403455937;4972.825951091694;5007.57435617962;5019.071471777733;5026.849194524024;5041.621878359065;4905.386826646669;4989.950100498949;5003.749812509433;5058.064258112261;5083.771230294572;4956.851294461172;5005.874853128701;5013.849584512471;5030.496950304941;5049.974750126225 22:35:28 INFO - 2015-11-19 22:35:28,802 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.2370661460336;572.5276646766418;575.8474004388838;580.3094317761864;583.5623282538096;37387;38093.80953095234;38125.428118578246;38210.61789382105;38223.808880955556;41737.373939390935;42283.36574951371;42308.36537451941;42321.57678423215;42323.788381058126;8014.358851291897;8165.265126138646;8177.959110204441;8183.140770219131;8202.384821138408;7853.821926710982;8005;8008.919910800905;8040.155783642721;8057.113717491071;7962.124166341698;7986.800329991738;8045.436819422643;8072.19278072191;8097.473664211837;7930.286274235317;8046.798830029267;8068.314193293577;8095.878561821577;8115.75652730419;7979.321757650607;8052.919470805334;8112.594370281462;8118.472299300585;8121.269085782308;37151.81424092862;37152.62847371519;37503.62496375056;37594.624053759384;37775.81112094422;2720.143154906218;2923.254570084615;2937.4859399604984;2996.895108671186;3421.9144521386916;27816;27889.860550697318;28230.294242643893;28239.85880070607;28254.576181357297;3253.755968302387;3278.4918337657464;3313.072339744875;3390.135515443571;3402.6427225141497;216753;217945.99999999843;218457;218870;218944;52932.206016909775;53890.46109538933;56421.43578564244;64038.67980660067;65211.673941630936;59328.703356483806;59644;60127;60156;60224;14596.759275461705;15025.474108406372;15028.474003409829;15031.549053528412;15044;11119.72200694989;11400.429978501208;11417.885821141848;11479;11479.196456247982;19520.414387568395;19933.700994485094;20129.194832206842;20141.697874531892;20161.19355225804;7732.265434783687;7890.408219383455;7893.1712170222445;7927.137122776143;7952.840943181104;739.4528049243521;739.4675833399943;777.809436688015;793.7777422321759;797.0117054851942;20429.69355459669;20719.378418647466;20828.062737176864;20951;30450.238744031132;917.2524392619994;917.2845180759018;1034.8706411698538;1037.6679462572056;1058.3279617442824;13872.722545549033;13964.790528142086;14107.717845643236;14158.50445234412;14215.715685686435;315027;321298;321817;322611;322902;48536;49051;49066.50933490619;49080.75459622679;49470.752646236535;1144.5650652751901;1145.524607287983;1177.8527684039495;1180.6635108993896;1335.9599212023654;26144.215673529823;26331.21006369812;26467.60298595484;26544.070957516393;26767.732322676526;41384.172316554104;42137.789311053246;42163.7891810539;42227.57772422236;42233.1553368937;246561;247437;249061;249252;249694;29622.703772961995;42787.57212427836;43071.56928430676;43632.56367436412;44387.33418998653;39561.80219098886;39636.21637026398;39834.800825995684;40671.18657626772;40802;34045.65954340425;34458.82770586131;34513.48229776606;34789;35052.82473587616;34565;34567.96296111121;34831;34871.47692784661;35067.47398789071;34252.14369640779;34280.31439371149;34356.312873742885;34395.31209375848;34665.480017800255;30388.24029399283;30845.22886927755;31600.683993159775;31653.683463165074;31778.682213178497;24647.876760616084;24703.50592988166;25061.749382505943;25179.622305665795;27453.588196177472 22:35:28 INFO - 2015-11-19 22:35:28,804 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.1546663740779;333;335.2824954597161;339.4653420862142;343.62716452648874;10396.844047339297;10851.348919064862;15190.848091519081;15302.770458443132;16176.27206775695;16213.108279044647;16268.593285167846;16750.916245418786;16766.245518951648;16785.748213776773;5407.107827208516;5664.915026274609;5668.461496157879;5672.829815105553;5705.172749951254;5705;5778.306603207621;5785.103308987113;5785.16115163301;5812.389699081599;6085.756569737206;6226.097215903714;6282.811515654537;6297.842553936142;6422.197225346832;6141.263048434172;6146.385361463863;6164;6720.697568609376;6727.428168605675;6363.809085727436;6401.935980640227;6432.421082102586;6438.3883531064475;6452.806415807533;20061.297854575165;20728.5854282915;20928.37214883556;21550.461238469008;22273.888630556743;1834.9816501834944;1837.843783278423;1918.5779128591687;2009.2264478176007;2093.1731965873546;13711;13772.655683607889;13776.655583610389;13917.791233131511;14164.29178541079;1885.2491720863484;1887.7734671839467;1913;1948.6492431362349;1960.862739608228;56221.43778562203;56447.43552564463;56774.432255677326;60620.696896515234;63476;15661.530154095395;15762.605934851721;15801.841981580266;15807.841921580866;15853.762193567105;23152.88423557905;23251.3024609262;23265.883670581537;23392.298231053097;23605;8448;8638.870416943751;8712.259457946018;8719.825603487894;8758.956205219061;7074.22183559808;7319.817004574928;7379.741709040265;7409.8147546311775;7463.962680186564;7691.115521714963;7843.568603726736;7855.175206603224;7885.1326354101;7911.485753426009;1759.744836998628;1792.97310540342;3113.112762862573;3117.0960421477516;3129.5462157986963;809.6842231529708;825.4964471672275;871.0940621753432;957.6791774755535;969.1519920069939;15016.549503514912;15051;15182.848171518364;15270.694586108215;16269.755953660704;796.2117503671324;806.6652339279134;816.5631387207816;870.4603146049363;925.9814204375268;7795;8205.302549283379;8612.61243244043;9365.859512107323;9390.483523406141;462027;469954;473388;473945;475352;68471;70714;70752.64623676849;70819.2918070823;71600.64199678968;1098.5715570927346;1112.365951407706;1112.8775834658181;1114.8606424196976;1114.9777004459866;14940.925295373454;15057.096574205145;15095.54713358601;15198.544043678707;15375.077495350315;29913.85043074858;30017.5497367544;31133.06600801889;31364.05907822769;32614;39450.40824387694;45765.542344576126;45792.54207458016;46120.07759844717;46188;8366.87449688243;8451.83096338082;8589.613467394107;8636.17956294151;8639.438436501607;10005.09954104105;10110.44392558387;10141.442220677933;10165.44090075053;12377.814332785196;11000.449977501254;13400.128991615515;13504.189748615114;13518.864811352154;13840.377183026989;12935.094543381872;12957.611271661865;13022.739545209231;13423.194608323533;13866.098703584235;13282.468701251843;13720.108192967426;13815.309234538032;13914.234717090252;13990.230537320545;8649.264812491008;8855.114488551093;8860.158284963176;9243.21432678203;9243.584038718409;9534.761630959281;13758.380872860946;13941.721165576835;14080.32473829969;14138.08102473336 22:35:28 INFO - 2015-11-19 22:35:28,807 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1373.81453503777;1440.510226522982;1558.5558115936954;1613.6691978144481;1717.9727921053168;7103.4672399570045;7201.207867134611;7217.458690598207;7391.521695660876;7651.770446886589;7566.659500322485;7590.165081841007;7702.845943081135;7715.922840771591;7732.961335193316;2132.8187104096132;2151.075037733774;2158.179891641182;2174.999500229896;2177.357679484548;2129.073852874005;2179.411558879102;2199.9560008799813;2206.0844749428966;2208.083645287204;2072.1504183284856;2080.251109600543;2099.433153048676;2127.372425134589;2130.084063852543;2107.4204593736767;2107.7470703515523;2128.521082756383;2128.9467763305965;2136.9786302136936;2177.6951226828255;2183.094015983365;2186.387811412807;2188.3544354415326;2198.4613769626544;7255.09311336083;7326.633668316616;7364.484486085976;7370.705171793122;7395.85208295831;4371.846985355529;4434.06884554244;4444.066745983348;4457.665675074382;4460.776961151962;2912.359280958186;2997.5203967365337;2998.415309014743;3008.9247768805735;3015.2914065194664;956.9186619137382;964.5563041001147;970.7961328121103;974.2644303550844;1008.6318493749802;10011.399316041061;10144.594216231342;10169.59321627134;10174.847377289347;10175.898241017496;4170.249355116048;4183.6653067754505;4242.300020496646;4250.468691413574;4288.035192081757;8727.869081963776;8758.343124265706;8780.121987801169;8805.383623146317;8816.382853200214;4508.481524624644;4510.706804057726;4536.047430039663;4539.750313732777;4572.565606267399;4103.589641035873;4104.651104656078;4111.60939710727;4116.773577453268;4135.359019352005;3460.325236578843;3496.1609213788506;3524.665156810099;3535.5934067582043;3549.2723991581665;1071.9035286824223;1087.9292845964987;1091.3779145886767;1116.0402054233352;1127.2222166705112;877.7586163805005;881.625309243569;902.8871391076116;1036.8030074285862;1190.8392367030513;6542.34576542342;6607.405333520006;6615.86768264632;6622.701978410983;6684.465242780566;1062.5802807890993;1103.9558417663204;1157.791597512439;1159.7854396936593;1164.7088227943013;5109.540141387293;5159.2003239497935;5223.869403264949;5250.7637156328055;5262.421133675292;8620.396572240008;8760.123987601317;8806.735797926072;8836.734897953073;8881.200691937756;8496.872546911802;8696.869546956801;8723.825523489622;8750.081241469554;8827.470351778913;6829.214640316427;6933.965330173317;6955.93044069563;7001.754938577125;7005.614691192033;6688.665566721742;6697.631630260383;6777.356151165632;6780.932190678227;6786.932130678828;7795.4543181976715;7827.25641064098;7966.083900351534;8041.236082572146;8044.557549334842;7435.442341824493;7566;8068.556229407204;8115;8179.0594081681365;6093.9390606093375;6107.755689772359;6136.754529818936;6158.261008678987;6161.4146656067605;6867.690953906987;6874.862502749817;6936.687849046704;7051.929480705127;7052.612106334201;6529.444997175293;6557.409833115043;6629.138212032405;6629.834254143492;6694.430973367318;6598.60408375499;6643.634600096848;6665.233498147775;6675.666216689243;6749.595024298558;6309.463695585927;6500.512461565496;6518.663673946735;6569.835754106186;6693.631850248283;5935.9109613356695;6175.073738939195;6183.536234782319;6242.438180563771;6254.312025677081;6156.445919867234;6359.046143078575;6389.616623002635;6416.262129855127;6419.6790160490855 22:35:28 INFO - 2015-11-19 22:35:28,807 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.23869854301864;316.2678399505146;329.39062733942194;330.01819586729476;332.9816860072695;5498.0653288940875;5570;5581.776728930843;5643.068893632556;5709.343425506068;5416.052190866592;5598.4961353478175;5600.467955544217;5603.467670571299;5607.102863541834;4371.781410929457;4373.956260437387;4383.232934236512;4388.89027774305;4389.473263208403;4386.934195987063;4387.6928614996805;4388.100439409914;4388.100439409914;4402.7578483183415;4258.957410425903;4357.498887627916;4357.542458041908;4360.825566977317;4361.3457981302745;4355.978220108895;4357.128574285124;4362;4363.170997510463;4373.1909596724545;3850.7111966602615;3851.0757418219705;3852.7880966546827;3854.9229015419533;3857.402102674062;5287.894242115136;5446.7276636168035;5472.425395333512;5475.534579560742;5481.205225242317;4966.826161084381;4983.377077865231;4986.5013498650205;4988.775505102243;4995.150824359867;5917.881642367129;5936.851578710567;5940.673262970535;5958.046712525975;5966.194563733884;3997.420374045776;4055.513338399411;4088.3049881520215;4096.8566100186645;4100.91798164035;6086.269647642267;6226.439620434183;6247.500199983991;6253.843039037838;6254.186955695731;4202.306619407764;4205.1589682063095;4214.852480163241;4219.641330486943;4232.0054787125;4268.509121451073;4279.101388708406;4281;4296.82812687489;4302.82788688449;4827.710337379768;4909.70541767488;4926.8275610354185;4932.457429682732;4936.136176169156;5902.527797776168;5910.497607703307;5917.5857689961285;5921.881562368729;5926.585139040226;1472.5435115114349;1495.3271028037427;1497.9251037448084;1500.197394393994;1501.6996600679909;977.5747549815853;996.2750985639595;1004.2969921055291;1006.2503434941016;1006.9395836249848;5057.898842023139;5073.239014147834;5079.111155547765;5089.745512724349;5106.693598384109;6088.543359248074;6115.571909966348;6120.234970628671;6121.785737499166;6143.293521245025;5075.7969681212335;5081.796728130834;5084.161113416245;5091.41448733393;5093.668911520739;3215.9839200803845;3283.047916104351;3291.308825146746;3296.4396052671104;3318.867245310209;5658.151277308354;5793.304803423532;5829.8251052468495;5849.239598852207;5861.3845546217035;6364.331745166691;6371.076193951851;6391.169148010729;6400.455961243347;6402.679866006681;5794.739236734357;5811.854703632358;5826.388229235954;5829.970850145722;5851.1223316502865;6106.9083963739695;6133.294671112879;6160.815175544741;6175.104609831639;6177.536684748572;5852.858692554911;6004.0693692477735;6013.699315034143;6017.518598512196;6094.603850749687;5839.883202336015;5839.912401313899;5846.123081537633;5855.619384739978;5863.091220860773;4145.54399016102;4224;4228.154369126126;4235.894102647335;4248;6005.579609427473;6146.385361463997;6165.753369865155;6169.444749972345;6189.442950134509;5866.354700982974;5912.142739302691;5922.555808314308;5928.940710593011;5930.080837470199;5909.8227053188475;5914.763409463573;5930.318013428338;5930.555208359304;5940.435658612425;5597.104463285855;5752.33848107473;5802.042662960733;5821.185034095315;5827.776167004977;5903.173555702291;5913.172155898264;6000.69996500182;6004.159417681441;6008.399160083956;5810.041343178328;5816.098504731774;5824.650520968756;5827.5629327801435;5830.5044071254415 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: |5;yui.html;734.8126227811907;760.186600337639;761.2919984414496;763.1071646173978;772.6329993253205;11572.132090093246;11929.105317101208;11960.641180764569;11960.64118076459;11979.460924258408;11495.137864660142;11502.309861408321;11574.131940104506;11928.165028447991;12095.092868034888;771.2904128202067;779.2908453307491;787.0594639405912;787.2875048081467;795.6141271483326;803.4094940218935;803.6142651527271;805.6575955219038;807.5195258820992;812.4434762187921;824.1634740738156;832.9000519937616;837.1670188162786;842.7766641839918;844.877492763549;825.0676735289115;831.9376046796484;832.11795496773;832.2967092806568;834.1450013735939;620.7703149834545;620.8385819686869;622.2999125983268;623.3050149083739;624.073251221935;11788.705282367924;11911.642650720492;11915.582954596633;11926.224795388358;11938;10957.945210273978;11183.217174797768;11183.888161118366;11471.311721296748;11794.292342459394;9147.496887671176;9184.31117666171;9301.162895339452;9385.5307234638;9499.38254013487;3185.2514659055337;3293.357795229931;3293.374258890803;3317.9834100829585;3361.1429085583263;43323;43620.78189609032;43631.12737745227;44061.77969110134;44082;8606.956965215133;8611.311095112376;8615.267702245379;8944.642214311354;9222.723318300461;16739.330426783035;16747.91626041862;16752.916235418747;16799.496015119566;16832.158392080346;6268.780592679325;6301.747930082745;6317.557770956081;6370.904436433457;6574.8356291093105;3395.864165433355;3478.7564870458823;3495.2834668892815;3533.081398836321;3561.6260292669413;2789.2190186747744;2810.1148138336357;2810.8594570271403;2824.406874556325;2826.1804076817903;502.9270755740397;508.24271834966373;519.4104691175543;519.4753299167792;550.3313474128872;492.2861850317055;533.9987523393637;553.3083645443196;579.8956187886137;588.9322727886348;7509.549427034395;7527.209642987517;7540.359069479046;7620.69517219305;7678.961605191938;579.5595347535818;596.8567543789546;598.186466405688;600.4655856287907;604.8699529601157;3449.4653328734084;3469.531613232232;3660.670539651444;3701.3152566775234;3716.349638813197;52030.73984630052;52241.7387913058;52287.73856130695;52329;52537;46354.76822615933;46494.76752616283;46571.30143047789;47098.88055037532;47290.29064564034;41730;42600.14799703989;42663;43651.12697746027;44215.77892110583;7442.553446793209;7549.811254718676;7731.38148948094;7940.325072368913;7971.521708697497;32469.94125734283;33338.16654583558;34035.319293614484;34050.489242661875;34773.13067173341;40416;40978.79510602428;41545.75362739123;41549.16901661889;41845.58154418417;10228;10245.334053286513;10287.588496460057;10393.480325983823;10742.409167495864;11387.089032877515;11408.35243695817;11460.598879039528;11698.239614425034;11718.88281117178;10671.733206669895;11003.559857605605;11027.669169924915;11072.944635277094;11727.589534366256;11044;11221.55113795439;11246.718832029264;11277.661670149908;11477.770444590895;10476.476176191312;10698.14414846826;10726.892731072589;11027.61403350879;11145.442727863736;9372.48451335156;9565.186959108554;9648.421094734338;9928.354656947275;10058.849117263393;9317.534123293945;9367.578458969227;9388.389754665925;9431.151196392357;9478.478683672463 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001328799__endTimestamp 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:35:28 INFO - 2015-11-19 22:35:28,809 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4790.30 Median:4909.83 stddev:505.67 (10.3%) stddev-sans-first:480.55 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: Values: 2724.8 2802.0 2807.8 2822.2 2830.1 4642.9 4884.6 4913.0 4951.7 4983.0 4776.0 4790.9 4823.7 4905.5 4907.1 4382.8 4407.9 4468.7 4476.0 4506.0 4453.0 4531.5 4577.0 4605.4 4664.1 4299.5 4390.2 4396.6 4505.4 4525.0 4492.4 4509.0 4512.1 4542.5 4545.8 4484.4 4504.2 4510.1 4513.1 4541.2 4570.7 4618.4 4628.3 4765.5 4810.5 5167.4 5252.7 5255.0 5257.3 5317.3 5003.6 5279.3 5293.3 5303.8 5307.4 4775.5 4788.1 4850.2 4866.6 4906.5 5365.7 5380.1 5410.9 5419.8 5460.7 4928.9 4943.7 5167.2 5183.4 5187.2 5039.3 5143.0 5156.8 5168.5 5225.2 5111.6 5125.9 5152.3 5163.5 5192.7 4914.3 5014.1 5034.1 5131.1 5136.3 4312.9 4333.5 4334.6 4347.9 4359.1 3801.0 3802.0 3815.6 3833.5 3850.2 4221.1 4359.2 4381.1 4402.3 4495.9 5174.5 5262.7 5307.1 5308.0 5345.3 4420.9 4437.4 4443.8 4444.9 4492.3 4368.7 4470.8 4532.5 4565.6 4623.9 4843.1 4902.7 4909.8 4915.4 4948.8 5143.8 5161.1 5169.1 5171.8 5239.3 4703.9 4792.4 4803.9 4887.2 4894.5 5152.5 5166.0 5173.6 5176.3 5188.9 5269.0 5285.1 5304.5 5305.7 5307.9 4835.0 4904.7 4957.8 5068.8 5074.0 5078.4 5122.8 5142.9 5147.9 5152.9 4972.8 5007.6 5019.1 5026.8 5041.6 4905.4 4990.0 5003.7 5058.1 5083.8 4956.9 5005.9 5013.8 5030.5 5050.0 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43090.55 Median:34851.24 stddev:69528.77 (199.5%) stddev-sans-first:69650.51 22:35:28 INFO - 2015-11-19 22:35:28,810 DEBUG : BROWSER_OUTPUT: Values: 567.2 572.5 575.8 580.3 583.6 37387.0 38093.8 38125.4 38210.6 38223.8 41737.4 42283.4 42308.4 42321.6 42323.8 8014.4 8165.3 8178.0 8183.1 8202.4 7853.8 8005.0 8008.9 8040.2 8057.1 7962.1 7986.8 8045.4 8072.2 8097.5 7930.3 8046.8 8068.3 8095.9 8115.8 7979.3 8052.9 8112.6 8118.5 8121.3 37151.8 37152.6 37503.6 37594.6 37775.8 2720.1 2923.3 2937.5 2996.9 3421.9 27816.0 27889.9 28230.3 28239.9 28254.6 3253.8 3278.5 3313.1 3390.1 3402.6 216753.0 217946.0 218457.0 218870.0 218944.0 52932.2 53890.5 56421.4 64038.7 65211.7 59328.7 59644.0 60127.0 60156.0 60224.0 14596.8 15025.5 15028.5 15031.5 15044.0 11119.7 11400.4 11417.9 11479.0 11479.2 19520.4 19933.7 20129.2 20141.7 20161.2 7732.3 7890.4 7893.2 7927.1 7952.8 739.5 739.5 777.8 793.8 797.0 20429.7 20719.4 20828.1 20951.0 30450.2 917.3 917.3 1034.9 1037.7 1058.3 13872.7 13964.8 14107.7 14158.5 14215.7 315027.0 321298.0 321817.0 322611.0 322902.0 48536.0 49051.0 49066.5 49080.8 49470.8 1144.6 1145.5 1177.9 1180.7 1336.0 26144.2 26331.2 26467.6 26544.1 26767.7 41384.2 42137.8 42163.8 42227.6 42233.2 246561.0 247437.0 249061.0 249252.0 249694.0 29622.7 42787.6 43071.6 43632.6 44387.3 39561.8 39636.2 39834.8 40671.2 40802.0 34045.7 34458.8 34513.5 34789.0 35052.8 34565.0 34568.0 34831.0 34871.5 35067.5 34252.1 34280.3 34356.3 34395.3 34665.5 30388.2 30845.2 31600.7 31653.7 31778.7 24647.9 24703.5 25061.7 25179.6 27453.6 22:35:28 INFO - 2015-11-19 22:35:28,811 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,811 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26785.34 Median:334.14 stddev:76801.70 (22984.8%) stddev-sans-first:76991.46 22:35:28 INFO - 2015-11-19 22:35:28,812 DEBUG : BROWSER_OUTPUT: Values: 332.2 333.0 335.3 339.5 343.6 10396.8 10851.3 15190.8 15302.8 16176.3 16213.1 16268.6 16750.9 16766.2 16785.7 5407.1 5664.9 5668.5 5672.8 5705.2 5705.0 5778.3 5785.1 5785.2 5812.4 6085.8 6226.1 6282.8 6297.8 6422.2 6141.3 6146.4 6164.0 6720.7 6727.4 6363.8 6401.9 6432.4 6438.4 6452.8 20061.3 20728.6 20928.4 21550.5 22273.9 1835.0 1837.8 1918.6 2009.2 2093.2 13711.0 13772.7 13776.7 13917.8 14164.3 1885.2 1887.8 1913.0 1948.6 1960.9 56221.4 56447.4 56774.4 60620.7 63476.0 15661.5 15762.6 15801.8 15807.8 15853.8 23152.9 23251.3 23265.9 23392.3 23605.0 8448.0 8638.9 8712.3 8719.8 8759.0 7074.2 7319.8 7379.7 7409.8 7464.0 7691.1 7843.6 7855.2 7885.1 7911.5 1759.7 1793.0 3113.1 3117.1 3129.5 809.7 825.5 871.1 957.7 969.2 15016.5 15051.0 15182.8 15270.7 16269.8 796.2 806.7 816.6 870.5 926.0 7795.0 8205.3 8612.6 9365.9 9390.5 462027.0 469954.0 473388.0 473945.0 475352.0 68471.0 70714.0 70752.6 70819.3 71600.6 1098.6 1112.4 1112.9 1114.9 1115.0 14940.9 15057.1 15095.5 15198.5 15375.1 29913.9 30017.5 31133.1 31364.1 32614.0 39450.4 45765.5 45792.5 46120.1 46188.0 8366.9 8451.8 8589.6 8636.2 8639.4 10005.1 10110.4 10141.4 10165.4 12377.8 11000.4 13400.1 13504.2 13518.9 13840.4 12935.1 12957.6 13022.7 13423.2 13866.1 13282.5 13720.1 13815.3 13914.2 13990.2 8649.3 8855.1 8860.2 9243.2 9243.6 9534.8 13758.4 13941.7 14080.3 14138.1 22:35:28 INFO - 2015-11-19 22:35:28,812 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,812 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5158.28 Median:6179.30 stddev:2650.63 (42.9%) stddev-sans-first:2642.80 22:35:28 INFO - 2015-11-19 22:35:28,813 DEBUG : BROWSER_OUTPUT: Values: 1373.8 1440.5 1558.6 1613.7 1718.0 7103.5 7201.2 7217.5 7391.5 7651.8 7566.7 7590.2 7702.8 7715.9 7733.0 2132.8 2151.1 2158.2 2175.0 2177.4 2129.1 2179.4 2200.0 2206.1 2208.1 2072.2 2080.3 2099.4 2127.4 2130.1 2107.4 2107.7 2128.5 2128.9 2137.0 2177.7 2183.1 2186.4 2188.4 2198.5 7255.1 7326.6 7364.5 7370.7 7395.9 4371.8 4434.1 4444.1 4457.7 4460.8 2912.4 2997.5 2998.4 3008.9 3015.3 956.9 964.6 970.8 974.3 1008.6 10011.4 10144.6 10169.6 10174.8 10175.9 4170.2 4183.7 4242.3 4250.5 4288.0 8727.9 8758.3 8780.1 8805.4 8816.4 4508.5 4510.7 4536.0 4539.8 4572.6 4103.6 4104.7 4111.6 4116.8 4135.4 3460.3 3496.2 3524.7 3535.6 3549.3 1071.9 1087.9 1091.4 1116.0 1127.2 877.8 881.6 902.9 1036.8 1190.8 6542.3 6607.4 6615.9 6622.7 6684.5 1062.6 1104.0 1157.8 1159.8 1164.7 5109.5 5159.2 5223.9 5250.8 5262.4 8620.4 8760.1 8806.7 8836.7 8881.2 8496.9 8696.9 8723.8 8750.1 8827.5 6829.2 6934.0 6955.9 7001.8 7005.6 6688.7 6697.6 6777.4 6780.9 6786.9 7795.5 7827.3 7966.1 8041.2 8044.6 7435.4 7566.0 8068.6 8115.0 8179.1 6093.9 6107.8 6136.8 6158.3 6161.4 6867.7 6874.9 6936.7 7051.9 7052.6 6529.4 6557.4 6629.1 6629.8 6694.4 6598.6 6643.6 6665.2 6675.7 6749.6 6309.5 6500.5 6518.7 6569.8 6693.6 5935.9 6175.1 6183.5 6242.4 6254.3 6156.4 6359.0 6389.6 6416.3 6419.7 22:35:28 INFO - 2015-11-19 22:35:28,813 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,813 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4905.00 Median:5575.89 stddev:1448.88 (26.0%) stddev-sans-first:1411.40 22:35:28 INFO - 2015-11-19 22:35:28,814 DEBUG : BROWSER_OUTPUT: Values: 315.2 316.3 329.4 330.0 333.0 5498.1 5570.0 5581.8 5643.1 5709.3 5416.1 5598.5 5600.5 5603.5 5607.1 4371.8 4374.0 4383.2 4388.9 4389.5 4386.9 4387.7 4388.1 4388.1 4402.8 4259.0 4357.5 4357.5 4360.8 4361.3 4356.0 4357.1 4362.0 4363.2 4373.2 3850.7 3851.1 3852.8 3854.9 3857.4 5287.9 5446.7 5472.4 5475.5 5481.2 4966.8 4983.4 4986.5 4988.8 4995.2 5917.9 5936.9 5940.7 5958.0 5966.2 3997.4 4055.5 4088.3 4096.9 4100.9 6086.3 6226.4 6247.5 6253.8 6254.2 4202.3 4205.2 4214.9 4219.6 4232.0 4268.5 4279.1 4281.0 4296.8 4302.8 4827.7 4909.7 4926.8 4932.5 4936.1 5902.5 5910.5 5917.6 5921.9 5926.6 1472.5 1495.3 1497.9 1500.2 1501.7 977.6 996.3 1004.3 1006.3 1006.9 5057.9 5073.2 5079.1 5089.7 5106.7 6088.5 6115.6 6120.2 6121.8 6143.3 5075.8 5081.8 5084.2 5091.4 5093.7 3216.0 3283.0 3291.3 3296.4 3318.9 5658.2 5793.3 5829.8 5849.2 5861.4 6364.3 6371.1 6391.2 6400.5 6402.7 5794.7 5811.9 5826.4 5830.0 5851.1 6106.9 6133.3 6160.8 6175.1 6177.5 5852.9 6004.1 6013.7 6017.5 6094.6 5839.9 5839.9 5846.1 5855.6 5863.1 4145.5 4224.0 4228.2 4235.9 4248.0 6005.6 6146.4 6165.8 6169.4 6189.4 5866.4 5912.1 5922.6 5928.9 5930.1 5909.8 5914.8 5930.3 5930.6 5940.4 5597.1 5752.3 5802.0 5821.2 5827.8 5903.2 5913.2 6000.7 6004.2 6008.4 5810.0 5816.1 5824.7 5827.6 5830.5 22:35:28 INFO - 2015-11-19 22:35:28,814 DEBUG : BROWSER_OUTPUT: 22:35:28 INFO - 2015-11-19 22:35:28,815 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12717.17 Median:45285.27 stddev:14657.77 (32.4%) stddev-sans-first:14671.27 22:35:28 INFO - 2015-11-19 22:35:28,815 DEBUG : BROWSER_OUTPUT: Values: 734.8 760.2 761.3 763.1 772.6 11572.1 11929.1 11960.6 11960.6 11979.5 11495.1 11502.3 11574.1 11928.2 12095.1 771.3 779.3 787.1 787.3 795.6 803.4 803.6 805.7 807.5 812.4 824.2 832.9 837.2 842.8 844.9 825.1 831.9 832.1 832.3 834.1 620.8 620.8 622.3 623.3 624.1 11788.7 11911.6 11915.6 11926.2 11938.0 10957.9 11183.2 11183.9 11471.3 11794.3 9147.5 9184.3 9301.2 9385.5 9499.4 3185.3 3293.4 3293.4 3318.0 3361.1 43323.0 43620.8 43631.1 44061.8 44082.0 8607.0 8611.3 8615.3 8944.6 9222.7 16739.3 16747.9 16752.9 16799.5 16832.2 6268.8 6301.7 6317.6 6370.9 6574.8 3395.9 3478.8 3495.3 3533.1 3561.6 2789.2 2810.1 2810.9 2824.4 2826.2 502.9 508.2 519.4 519.5 550.3 492.3 534.0 553.3 579.9 588.9 7509.5 7527.2 7540.4 7620.7 7679.0 579.6 596.9 598.2 600.5 604.9 3449.5 3469.5 3660.7 3701.3 3716.3 52030.7 52241.7 52287.7 52329.0 52537.0 46354.8 46494.8 46571.3 47098.9 47290.3 41730.0 42600.1 42663.0 43651.1 44215.8 7442.6 7549.8 7731.4 7940.3 7971.5 32469.9 33338.2 34035.3 34050.5 34773.1 40416.0 40978.8 41545.8 41549.2 41845.6 10228.0 10245.3 10287.6 10393.5 10742.4 11387.1 11408.4 11460.6 11698.2 11718.9 10671.7 11003.6 11027.7 11072.9 11727.6 11044.0 11221.6 11246.7 11277.7 11477.8 10476.5 10698.1 10726.9 11027.6 11145.4 9372.5 9565.2 9648.4 9928.4 10058.8 9317.5 9367.6 9388.4 9431.2 9478.5 22:35:28 INFO - 2015-11-19 22:35:28,815 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:35:28 INFO - 2015-11-19 22:35:28,815 DEBUG : BROWSER_OUTPUT: 22:35:29 INFO - 2015-11-19 22:35:29,519 INFO : Browser exited with error code: 0 22:35:29 INFO - 2015-11-19 22:35:29,542 INFO : Completed test dromaeo_css (00:18:34) 22:35:29 INFO - 2015-11-19 22:35:29,542 INFO : Starting test kraken 22:35:29 INFO - 2015-11-19 22:35:29,542 DEBUG : operating with platform_type : linux_ 22:35:29 INFO - 2015-11-19 22:35:29,542 INFO : Initialising browser for kraken test... 22:35:29 INFO - 2015-11-19 22:35:29,548 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIBnbM/profile http://localhost:52219/getInfo.html 22:35:34 INFO - 2015-11-19 22:35:34,231 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:35:34 INFO - 2015-11-19 22:35:34,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:35:34 INFO - 2015-11-19 22:35:34,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:35:34 INFO - 2015-11-19 22:35:34,232 DEBUG : BROWSER_OUTPUT: __metrics 22:35:35 INFO - 2015-11-19 22:35:35,310 INFO : Browser initialized. 22:35:35 INFO - 2015-11-19 22:35:35,311 INFO : Running cycle 1/1 for kraken test... 22:35:35 INFO - 2015-11-19 22:35:35,311 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIBnbM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:35:47 INFO - 2015-11-19 22:35:47,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 22:35:47 INFO - 2015-11-19 22:35:47,319 DEBUG : BROWSER_OUTPUT: 22:35:49 INFO - 2015-11-19 22:35:49,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52219/tests/kraken/driver.html?testName=audio-beat-detection) 22:35:50 INFO - 2015-11-19 22:35:50,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 141660160 22:35:50 INFO - 2015-11-19 22:35:50,565 DEBUG : BROWSER_OUTPUT: 22:35:53 INFO - 2015-11-19 22:35:53,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52219/tests/kraken/driver.html?testName=audio-dft) 22:35:53 INFO - 2015-11-19 22:35:53,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 22:35:53 INFO - 2015-11-19 22:35:53,921 DEBUG : BROWSER_OUTPUT: 22:35:56 INFO - 2015-11-19 22:35:56,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52219/tests/kraken/driver.html?testName=audio-fft) 22:35:57 INFO - 2015-11-19 22:35:57,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 135553024 22:35:57 INFO - 2015-11-19 22:35:57,408 DEBUG : BROWSER_OUTPUT: 22:35:59 INFO - 2015-11-19 22:35:59,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52219/tests/kraken/driver.html?testName=audio-oscillator) 22:36:00 INFO - 2015-11-19 22:36:00,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 136736768 22:36:00 INFO - 2015-11-19 22:36:00,115 DEBUG : BROWSER_OUTPUT: 22:36:02 INFO - 2015-11-19 22:36:02,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52219/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:36:02 INFO - 2015-11-19 22:36:02,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 137216000 22:36:02 INFO - 2015-11-19 22:36:02,900 DEBUG : BROWSER_OUTPUT: 22:36:05 INFO - 2015-11-19 22:36:05,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52219/tests/kraken/driver.html?testName=imaging-darkroom) 22:36:06 INFO - 2015-11-19 22:36:06,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 137629696 22:36:06 INFO - 2015-11-19 22:36:06,527 DEBUG : BROWSER_OUTPUT: 22:36:09 INFO - 2015-11-19 22:36:09,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52219/tests/kraken/driver.html?testName=imaging-desaturate) 22:36:10 INFO - 2015-11-19 22:36:10,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 139128832 22:36:10 INFO - 2015-11-19 22:36:10,560 DEBUG : BROWSER_OUTPUT: 22:36:13 INFO - 2015-11-19 22:36:13,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52219/tests/kraken/driver.html?testName=json-parse-financial) 22:36:14 INFO - 2015-11-19 22:36:14,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 139513856 22:36:14 INFO - 2015-11-19 22:36:14,088 DEBUG : BROWSER_OUTPUT: 22:36:15 INFO - 2015-11-19 22:36:15,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52219/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:36:16 INFO - 2015-11-19 22:36:16,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 140214272 22:36:16 INFO - 2015-11-19 22:36:16,448 DEBUG : BROWSER_OUTPUT: 22:36:18 INFO - 2015-11-19 22:36:18,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:36:18 INFO - 2015-11-19 22:36:18,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 22:36:18 INFO - 2015-11-19 22:36:18,972 DEBUG : BROWSER_OUTPUT: 22:36:21 INFO - 2015-11-19 22:36:21,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:36:21 INFO - 2015-11-19 22:36:21,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 22:36:21 INFO - 2015-11-19 22:36:21,730 DEBUG : BROWSER_OUTPUT: 22:36:24 INFO - 2015-11-19 22:36:24,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:36:24 INFO - 2015-11-19 22:36:24,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 139878400 22:36:24 INFO - 2015-11-19 22:36:24,900 DEBUG : BROWSER_OUTPUT: 22:36:27 INFO - 2015-11-19 22:36:27,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:36:28 INFO - 2015-11-19 22:36:28,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 139841536 22:36:28 INFO - 2015-11-19 22:36:28,130 DEBUG : BROWSER_OUTPUT: 22:36:29 INFO - 2015-11-19 22:36:29,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52219/tests/kraken/driver.html?testName=ai-astar) 22:36:30 INFO - 2015-11-19 22:36:30,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 140902400 22:36:30 INFO - 2015-11-19 22:36:30,139 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,140 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:36:30 INFO - 2015-11-19 22:36:30,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;111;112;114;123;110;114;114;112 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;134;163;169;147;167;163;135;168;132 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;164;164;166;166;164;165;164 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;81;73;73;73;149;74;73;74 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;129;91;92;91;125;92;92;129 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;110;111;110;110;112;111;110 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;149;148;149;150;147;148;149;148 22:36:30 INFO - 2015-11-19 22:36:30,141 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;96;96;96;96;96;96;96 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;75;73;74;75;73;75;71;77 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;68;70;69;70;70;70;69;69 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;83;86;93;85;83;83;85;87;92 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;126;128;128;124;125;138;119;131;120 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;161;140;151;152;149;140;147;149;147;147 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;70;70;71;74;72;70;71;69 22:36:30 INFO - 2015-11-19 22:36:30,142 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:36:30 INFO - 2015-11-19 22:36:30,143 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:36:30 INFO - 2015-11-19 22:36:30,143 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,784 22:36:30 INFO - 2015-11-19 22:36:30,143 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:36:30 INFO - 2015-11-19 22:36:30,143 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001390139__endTimestamp 22:36:30 INFO - 2015-11-19 22:36:30,143 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:3.99 (3.5%) stddev-sans-first:4.23 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 111.0 112.0 114.0 123.0 110.0 114.0 114.0 112.0 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.60 Median:163.00 stddev:15.13 (9.3%) stddev-sans-first:15.96 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: Values: 158.0 134.0 163.0 169.0 147.0 167.0 163.0 135.0 168.0 132.0 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 164.0 164.0 166.0 166.0 164.0 165.0 164.0 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,151 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.00 stddev:23.90 (32.7%) stddev-sans-first:25.15 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 81.0 73.0 73.0 73.0 149.0 74.0 73.0 74.0 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:92.00 stddev:17.34 (18.8%) stddev-sans-first:18.04 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 129.0 91.0 92.0 91.0 125.0 92.0 92.0 129.0 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 110.0 111.0 110.0 110.0 112.0 111.0 110.0 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 149.0 148.0 149.0 150.0 147.0 148.0 149.0 148.0 22:36:30 INFO - 2015-11-19 22:36:30,152 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.00 Median:74.50 stddev:1.63 (2.2%) stddev-sans-first:1.69 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 75.0 73.0 74.0 75.0 73.0 75.0 71.0 77.0 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 68.0 70.0 69.0 70.0 70.0 70.0 69.0 69.0 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:3.57 (4.1%) stddev-sans-first:3.77 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: Values: 87.0 83.0 86.0 93.0 85.0 83.0 83.0 85.0 87.0 92.0 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:128.00 stddev:5.47 (4.3%) stddev-sans-first:5.75 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: Values: 129.0 126.0 128.0 128.0 124.0 125.0 138.0 119.0 131.0 120.0 22:36:30 INFO - 2015-11-19 22:36:30,153 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:149.00 stddev:6.02 (4.0%) stddev-sans-first:4.28 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: Values: 161.0 140.0 151.0 152.0 149.0 140.0 147.0 149.0 147.0 147.0 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 70.0 70.0 71.0 74.0 72.0 70.0 71.0 69.0 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:36:30 INFO - 2015-11-19 22:36:30,154 DEBUG : BROWSER_OUTPUT: 22:36:31 INFO - 2015-11-19 22:36:31,071 INFO : Browser exited with error code: 0 22:36:31 INFO - 2015-11-19 22:36:31,124 INFO : Completed test kraken (00:01:01) 22:36:31 INFO - 2015-11-19 22:36:31,125 INFO : Starting test v8_7 22:36:31 INFO - 2015-11-19 22:36:31,125 DEBUG : operating with platform_type : linux_ 22:36:31 INFO - 2015-11-19 22:36:31,125 INFO : Initialising browser for v8_7 test... 22:36:31 INFO - 2015-11-19 22:36:31,131 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf33kOE/profile http://localhost:52219/getInfo.html 22:36:35 INFO - 2015-11-19 22:36:35,730 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:35 INFO - 2015-11-19 22:36:35,731 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:35 INFO - 2015-11-19 22:36:35,731 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:36:35 INFO - 2015-11-19 22:36:35,731 DEBUG : BROWSER_OUTPUT: __metrics 22:36:36 INFO - 2015-11-19 22:36:36,778 INFO : Browser initialized. 22:36:36 INFO - 2015-11-19 22:36:36,779 INFO : Running cycle 1/1 for v8_7 test... 22:36:36 INFO - 2015-11-19 22:36:36,779 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf33kOE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:36:48 INFO - 2015-11-19 22:36:48,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 22:36:48 INFO - 2015-11-19 22:36:48,815 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52219/tests/v8_7/run.html (next: http://localhost:52219/tests/v8_7/run.html) 22:37:10 INFO - 2015-11-19 22:37:10,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 138911744 22:37:10 INFO - 2015-11-19 22:37:10,509 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,510 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:37:10 INFO - 2015-11-19 22:37:10,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |0;Richards;163.21201240411295 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.29495718363464 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1067.2358591248667 22:37:10 INFO - 2015-11-19 22:37:10,511 DEBUG : BROWSER_OUTPUT: |5;Earley;714.7962830593281 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: |8;Splay;612.369871402327 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: __startTimestamp1448001430509__endTimestamp 22:37:10 INFO - 2015-11-19 22:37:10,512 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,513 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:37:10 INFO - 2015-11-19 22:37:10,514 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:37:10 INFO - 2015-11-19 22:37:10,514 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,514 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.21 Median:163.21 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,514 DEBUG : BROWSER_OUTPUT: Values: 163.2 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.29 Median:190.29 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: Values: 190.3 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: Values: 278.4 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,515 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: Values: 5050.5 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: Values: 1067.2 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:714.80 Median:714.80 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,516 DEBUG : BROWSER_OUTPUT: Values: 714.8 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: Values: 12419.8 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: Values: 25450.0 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,517 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:612.37 Median:612.37 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: Values: 612.4 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: Values: 4840.6 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:37:10 INFO - 2015-11-19 22:37:10,518 DEBUG : BROWSER_OUTPUT: 22:37:11 INFO - 2015-11-19 22:37:11,435 INFO : Browser exited with error code: 0 22:37:11 INFO - 2015-11-19 22:37:11,453 INFO : Completed test v8_7 (00:00:40) 22:37:11 INFO - 2015-11-19 22:37:11,496 INFO : Completed test suite (00:20:16) 22:37:11 INFO - 2015-11-19 22:37:11,496 DEBUG : Working with test: dromaeo_css 22:37:11 INFO - 2015-11-19 22:37:11,496 DEBUG : Generating results file: dromaeo_css 22:37:11 INFO - 2015-11-19 22:37:11,497 DEBUG : Working with test: kraken 22:37:11 INFO - 2015-11-19 22:37:11,497 DEBUG : Generating results file: kraken 22:37:11 INFO - 2015-11-19 22:37:11,498 INFO : javascript benchmark 22:37:11 INFO - 2015-11-19 22:37:11,498 DEBUG : Working with test: v8_7 22:37:11 INFO - 2015-11-19 22:37:11,498 DEBUG : Generating results file: v8_7 22:37:11 INFO - 2015-11-19 22:37:11,498 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:37:11 INFO - 2015-11-19 22:37:11,549 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:37:11 INFO - 2015-11-19 22:37:11,549 DEBUG : process_Request line: dromaeo_css 6606.69 graph.html#tests=[[72,132,43]] 22:37:11 INFO - 2015-11-19 22:37:11,550 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:37:11 INFO - 2015-11-19 22:37:11,584 DEBUG : process_Request line: kraken 1546.10 graph.html#tests=[[232,132,43]] 22:37:11 INFO - 2015-11-19 22:37:11,584 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:37:11 INFO - 2015-11-19 22:37:11,621 DEBUG : process_Request line: v8_7 21381.19 graph.html#tests=[[230,132,43]] 22:37:11 INFO - 2015-11-19 22:37:11,622 INFO : javascript benchmark 22:37:11 INFO - 2015-11-19 22:37:11,626 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2724.7547720705134, 2801.957970630442, 2807.7613402860757, 2822.195674232844, 2830.1085158175174, 4642.883927901804, 4884.609231261499, 4913.017396520697, 4951.678140920838, 4983.0, 4775.976120119394, 4790.898093438511, 4823.734694591796, 4905.509449055093, 4907.067657145149, 4382.758948257852, 4407.867763967086, 4468.664850136237, 4476.0, 4505.977470112645, 4453.0, 4531.524189960056, 4577.038821847399, 4605.447346318447, 4664.067186562684, 4299.527052024275, 4390.231709450865, 4396.604305612478, 4505.3917721107555, 4524.977375113136, 4492.3710680504755, 4508.977455112704, 4512.052468981485, 4542.454905411372, 4545.795439205243, 4484.372187893698, 4504.1892459357305, 4510.143072816154, 4513.142502924434, 4541.227991241497, 4570.748608826513, 4618.376519169903, 4628.25947848346, 4765.475797662254, 4810.542998415145, 5167.379914410257, 5252.71110088945, 5254.973725131388, 5257.263983042339, 5317.335333083364, 5003.574696150831, 5279.260903473517, 5293.285406470154, 5303.814366497193, 5307.416184219733, 4775.474697783241, 4788.114198873254, 4850.151223535867, 4866.586340161055, 4906.460289368167, 5365.731713414391, 5380.139177731544, 5410.864728381822, 5419.783208671609, 5460.699661518575, 4928.901421971541, 4943.678660887031, 5167.224916262516, 5183.403908550489, 5187.221916712448, 5039.3448851649055, 5143.048536020773, 5156.793728250828, 5168.457311982263, 5225.242339860699, 5111.5655169310285, 5125.923111153335, 5152.3044389007755, 5163.509466600667, 5192.662476939063, 4914.262860570943, 5014.147594908874, 5034.0938631046765, 5131.10205714006, 5136.280920671109, 4312.870613881589, 4333.544977777351, 4334.631556317685, 4347.869563913087, 4359.149965756647, 3800.9809950950066, 3801.9809900950872, 3815.599362066943, 3833.4824798652385, 3850.249201405699, 4221.113566151082, 4359.215341238608, 4381.101874115862, 4402.3396490526675, 4495.9325610115875, 5174.508421699932, 5262.71055091966, 5307.124324486416, 5308.044551980681, 5345.33183352081, 4420.8673739787855, 4437.42313499243, 4443.844465443694, 4444.911101777946, 4492.281235002384, 4368.650507959355, 4470.843520476833, 4532.546745325441, 4565.6119229865835, 4623.9075218495445, 4843.055604157155, 4902.7058376497525, 4909.828156014522, 4915.43472500667, 4948.752562371867, 5143.8456846294675, 5161.0968080585, 5169.095408303607, 5171.81898633546, 5239.266502689703, 4703.929441058455, 4792.376990991288, 4803.855884323476, 4887.242477416006, 4894.535019173173, 5152.458991805806, 5165.974170129276, 5173.586113111018, 5176.327077479904, 5188.922166167586, 5269.0, 5285.075111855333, 5304.549113325256, 5305.734713264398, 5307.9469205309, 4834.975825120852, 4904.6566740327835, 4957.776900039435, 5068.847934561969, 5074.035933172685, 5078.415982162099, 5122.769475373542, 5142.897142057063, 5147.871303217449, 5152.879403455937, 4972.825951091694, 5007.57435617962, 5019.071471777733, 5026.849194524024, 5041.621878359065, 4905.386826646669, 4989.950100498949, 5003.749812509433, 5058.064258112261, 5083.771230294572, 4956.851294461172, 5005.874853128701, 5013.849584512471, 5030.496950304941, 5049.974750126225], "unit": "ms", "name": "dojo.html", "value": 4758.919362867101}, {"lowerIsBetter": false, "replicates": [567.2370661460336, 572.5276646766418, 575.8474004388838, 580.3094317761864, 583.5623282538096, 37387.0, 38093.80953095234, 38125.428118578246, 38210.61789382105, 38223.808880955556, 41737.373939390935, 42283.36574951371, 42308.36537451941, 42321.57678423215, 42323.788381058126, 8014.358851291897, 8165.265126138646, 8177.959110204441, 8183.140770219131, 8202.384821138408, 7853.821926710982, 8005.0, 8008.919910800905, 8040.155783642721, 8057.113717491071, 7962.124166341698, 7986.800329991738, 8045.436819422643, 8072.19278072191, 8097.473664211837, 7930.286274235317, 8046.798830029267, 8068.314193293577, 8095.878561821577, 8115.75652730419, 7979.321757650607, 8052.919470805334, 8112.594370281462, 8118.472299300585, 8121.269085782308, 37151.81424092862, 37152.62847371519, 37503.62496375056, 37594.624053759384, 37775.81112094422, 2720.143154906218, 2923.254570084615, 2937.4859399604984, 2996.895108671186, 3421.9144521386916, 27816.0, 27889.860550697318, 28230.294242643893, 28239.85880070607, 28254.576181357297, 3253.755968302387, 3278.4918337657464, 3313.072339744875, 3390.135515443571, 3402.6427225141497, 216753.0, 217945.99999999843, 218457.0, 218870.0, 218944.0, 52932.206016909775, 53890.46109538933, 56421.43578564244, 64038.67980660067, 65211.673941630936, 59328.703356483806, 59644.0, 60127.0, 60156.0, 60224.0, 14596.759275461705, 15025.474108406372, 15028.474003409829, 15031.549053528412, 15044.0, 11119.72200694989, 11400.429978501208, 11417.885821141848, 11479.0, 11479.196456247982, 19520.414387568395, 19933.700994485094, 20129.194832206842, 20141.697874531892, 20161.19355225804, 7732.265434783687, 7890.408219383455, 7893.1712170222445, 7927.137122776143, 7952.840943181104, 739.4528049243521, 739.4675833399943, 777.809436688015, 793.7777422321759, 797.0117054851942, 20429.69355459669, 20719.378418647466, 20828.062737176864, 20951.0, 30450.238744031132, 917.2524392619994, 917.2845180759018, 1034.8706411698538, 1037.6679462572056, 1058.3279617442824, 13872.722545549033, 13964.790528142086, 14107.717845643236, 14158.50445234412, 14215.715685686435, 315027.0, 321298.0, 321817.0, 322611.0, 322902.0, 48536.0, 49051.0, 49066.50933490619, 49080.75459622679, 49470.752646236535, 1144.5650652751901, 1145.524607287983, 1177.8527684039495, 1180.6635108993896, 1335.9599212023654, 26144.215673529823, 26331.21006369812, 26467.60298595484, 26544.070957516393, 26767.732322676526, 41384.172316554104, 42137.789311053246, 42163.7891810539, 42227.57772422236, 42233.1553368937, 246561.0, 247437.0, 249061.0, 249252.0, 249694.0, 29622.703772961995, 42787.57212427836, 43071.56928430676, 43632.56367436412, 44387.33418998653, 39561.80219098886, 39636.21637026398, 39834.800825995684, 40671.18657626772, 40802.0, 34045.65954340425, 34458.82770586131, 34513.48229776606, 34789.0, 35052.82473587616, 34565.0, 34567.96296111121, 34831.0, 34871.47692784661, 35067.47398789071, 34252.14369640779, 34280.31439371149, 34356.312873742885, 34395.31209375848, 34665.480017800255, 30388.24029399283, 30845.22886927755, 31600.683993159775, 31653.683463165074, 31778.682213178497, 24647.876760616084, 24703.50592988166, 25061.749382505943, 25179.622305665795, 27453.588196177472], "unit": "ms", "name": "ext.html", "value": 17403.995032950574}, {"lowerIsBetter": false, "replicates": [332.1546663740779, 333.0, 335.2824954597161, 339.4653420862142, 343.62716452648874, 10396.844047339297, 10851.348919064862, 15190.848091519081, 15302.770458443132, 16176.27206775695, 16213.108279044647, 16268.593285167846, 16750.916245418786, 16766.245518951648, 16785.748213776773, 5407.107827208516, 5664.915026274609, 5668.461496157879, 5672.829815105553, 5705.172749951254, 5705.0, 5778.306603207621, 5785.103308987113, 5785.16115163301, 5812.389699081599, 6085.756569737206, 6226.097215903714, 6282.811515654537, 6297.842553936142, 6422.197225346832, 6141.263048434172, 6146.385361463863, 6164.0, 6720.697568609376, 6727.428168605675, 6363.809085727436, 6401.935980640227, 6432.421082102586, 6438.3883531064475, 6452.806415807533, 20061.297854575165, 20728.5854282915, 20928.37214883556, 21550.461238469008, 22273.888630556743, 1834.9816501834944, 1837.843783278423, 1918.5779128591687, 2009.2264478176007, 2093.1731965873546, 13711.0, 13772.655683607889, 13776.655583610389, 13917.791233131511, 14164.29178541079, 1885.2491720863484, 1887.7734671839467, 1913.0, 1948.6492431362349, 1960.862739608228, 56221.43778562203, 56447.43552564463, 56774.432255677326, 60620.696896515234, 63476.0, 15661.530154095395, 15762.605934851721, 15801.841981580266, 15807.841921580866, 15853.762193567105, 23152.88423557905, 23251.3024609262, 23265.883670581537, 23392.298231053097, 23605.0, 8448.0, 8638.870416943751, 8712.259457946018, 8719.825603487894, 8758.956205219061, 7074.22183559808, 7319.817004574928, 7379.741709040265, 7409.8147546311775, 7463.962680186564, 7691.115521714963, 7843.568603726736, 7855.175206603224, 7885.1326354101, 7911.485753426009, 1759.744836998628, 1792.97310540342, 3113.112762862573, 3117.0960421477516, 3129.5462157986963, 809.6842231529708, 825.4964471672275, 871.0940621753432, 957.6791774755535, 969.1519920069939, 15016.549503514912, 15051.0, 15182.848171518364, 15270.694586108215, 16269.755953660704, 796.2117503671324, 806.6652339279134, 816.5631387207816, 870.4603146049363, 925.9814204375268, 7795.0, 8205.302549283379, 8612.61243244043, 9365.859512107323, 9390.483523406141, 462027.0, 469954.0, 473388.0, 473945.0, 475352.0, 68471.0, 70714.0, 70752.64623676849, 70819.2918070823, 71600.64199678968, 1098.5715570927346, 1112.365951407706, 1112.8775834658181, 1114.8606424196976, 1114.9777004459866, 14940.925295373454, 15057.096574205145, 15095.54713358601, 15198.544043678707, 15375.077495350315, 29913.85043074858, 30017.5497367544, 31133.06600801889, 31364.05907822769, 32614.0, 39450.40824387694, 45765.542344576126, 45792.54207458016, 46120.07759844717, 46188.0, 8366.87449688243, 8451.83096338082, 8589.613467394107, 8636.17956294151, 8639.438436501607, 10005.09954104105, 10110.44392558387, 10141.442220677933, 10165.44090075053, 12377.814332785196, 11000.449977501254, 13400.128991615515, 13504.189748615114, 13518.864811352154, 13840.377183026989, 12935.094543381872, 12957.611271661865, 13022.739545209231, 13423.194608323533, 13866.098703584235, 13282.468701251843, 13720.108192967426, 13815.309234538032, 13914.234717090252, 13990.230537320545, 8649.264812491008, 8855.114488551093, 8860.158284963176, 9243.21432678203, 9243.584038718409, 9534.761630959281, 13758.380872860946, 13941.721165576835, 14080.32473829969, 14138.08102473336], "unit": "ms", "name": "jquery.html", "value": 9125.589408705211}, {"lowerIsBetter": false, "replicates": [1373.81453503777, 1440.510226522982, 1558.5558115936954, 1613.6691978144481, 1717.9727921053168, 7103.4672399570045, 7201.207867134611, 7217.458690598207, 7391.521695660876, 7651.770446886589, 7566.659500322485, 7590.165081841007, 7702.845943081135, 7715.922840771591, 7732.961335193316, 2132.8187104096132, 2151.075037733774, 2158.179891641182, 2174.999500229896, 2177.357679484548, 2129.073852874005, 2179.411558879102, 2199.9560008799813, 2206.0844749428966, 2208.083645287204, 2072.1504183284856, 2080.251109600543, 2099.433153048676, 2127.372425134589, 2130.084063852543, 2107.4204593736767, 2107.7470703515523, 2128.521082756383, 2128.9467763305965, 2136.9786302136936, 2177.6951226828255, 2183.094015983365, 2186.387811412807, 2188.3544354415326, 2198.4613769626544, 7255.09311336083, 7326.633668316616, 7364.484486085976, 7370.705171793122, 7395.85208295831, 4371.846985355529, 4434.06884554244, 4444.066745983348, 4457.665675074382, 4460.776961151962, 2912.359280958186, 2997.5203967365337, 2998.415309014743, 3008.9247768805735, 3015.2914065194664, 956.9186619137382, 964.5563041001147, 970.7961328121103, 974.2644303550844, 1008.6318493749802, 10011.399316041061, 10144.594216231342, 10169.59321627134, 10174.847377289347, 10175.898241017496, 4170.249355116048, 4183.6653067754505, 4242.300020496646, 4250.468691413574, 4288.035192081757, 8727.869081963776, 8758.343124265706, 8780.121987801169, 8805.383623146317, 8816.382853200214, 4508.481524624644, 4510.706804057726, 4536.047430039663, 4539.750313732777, 4572.565606267399, 4103.589641035873, 4104.651104656078, 4111.60939710727, 4116.773577453268, 4135.359019352005, 3460.325236578843, 3496.1609213788506, 3524.665156810099, 3535.5934067582043, 3549.2723991581665, 1071.9035286824223, 1087.9292845964987, 1091.3779145886767, 1116.0402054233352, 1127.2222166705112, 877.7586163805005, 881.625309243569, 902.8871391076116, 1036.8030074285862, 1190.8392367030513, 6542.34576542342, 6607.405333520006, 6615.86768264632, 6622.701978410983, 6684.465242780566, 1062.5802807890993, 1103.9558417663204, 1157.791597512439, 1159.7854396936593, 1164.7088227943013, 5109.540141387293, 5159.2003239497935, 5223.869403264949, 5250.7637156328055, 5262.421133675292, 8620.396572240008, 8760.123987601317, 8806.735797926072, 8836.734897953073, 8881.200691937756, 8496.872546911802, 8696.869546956801, 8723.825523489622, 8750.081241469554, 8827.470351778913, 6829.214640316427, 6933.965330173317, 6955.93044069563, 7001.754938577125, 7005.614691192033, 6688.665566721742, 6697.631630260383, 6777.356151165632, 6780.932190678227, 6786.932130678828, 7795.4543181976715, 7827.25641064098, 7966.083900351534, 8041.236082572146, 8044.557549334842, 7435.442341824493, 7566.0, 8068.556229407204, 8115.0, 8179.0594081681365, 6093.9390606093375, 6107.755689772359, 6136.754529818936, 6158.261008678987, 6161.4146656067605, 6867.690953906987, 6874.862502749817, 6936.687849046704, 7051.929480705127, 7052.612106334201, 6529.444997175293, 6557.409833115043, 6629.138212032405, 6629.834254143492, 6694.430973367318, 6598.60408375499, 6643.634600096848, 6665.233498147775, 6675.666216689243, 6749.595024298558, 6309.463695585927, 6500.512461565496, 6518.663673946735, 6569.835754106186, 6693.631850248283, 5935.9109613356695, 6175.073738939195, 6183.536234782319, 6242.438180563771, 6254.312025677081, 6156.445919867234, 6359.046143078575, 6389.616623002635, 6416.262129855127, 6419.6790160490855], "unit": "ms", "name": "mootools.html", "value": 4249.214192472944}, {"lowerIsBetter": false, "replicates": [315.23869854301864, 316.2678399505146, 329.39062733942194, 330.01819586729476, 332.9816860072695, 5498.0653288940875, 5570.0, 5581.776728930843, 5643.068893632556, 5709.343425506068, 5416.052190866592, 5598.4961353478175, 5600.467955544217, 5603.467670571299, 5607.102863541834, 4371.781410929457, 4373.956260437387, 4383.232934236512, 4388.89027774305, 4389.473263208403, 4386.934195987063, 4387.6928614996805, 4388.100439409914, 4388.100439409914, 4402.7578483183415, 4258.957410425903, 4357.498887627916, 4357.542458041908, 4360.825566977317, 4361.3457981302745, 4355.978220108895, 4357.128574285124, 4362.0, 4363.170997510463, 4373.1909596724545, 3850.7111966602615, 3851.0757418219705, 3852.7880966546827, 3854.9229015419533, 3857.402102674062, 5287.894242115136, 5446.7276636168035, 5472.425395333512, 5475.534579560742, 5481.205225242317, 4966.826161084381, 4983.377077865231, 4986.5013498650205, 4988.775505102243, 4995.150824359867, 5917.881642367129, 5936.851578710567, 5940.673262970535, 5958.046712525975, 5966.194563733884, 3997.420374045776, 4055.513338399411, 4088.3049881520215, 4096.8566100186645, 4100.91798164035, 6086.269647642267, 6226.439620434183, 6247.500199983991, 6253.843039037838, 6254.186955695731, 4202.306619407764, 4205.1589682063095, 4214.852480163241, 4219.641330486943, 4232.0054787125, 4268.509121451073, 4279.101388708406, 4281.0, 4296.82812687489, 4302.82788688449, 4827.710337379768, 4909.70541767488, 4926.8275610354185, 4932.457429682732, 4936.136176169156, 5902.527797776168, 5910.497607703307, 5917.5857689961285, 5921.881562368729, 5926.585139040226, 1472.5435115114349, 1495.3271028037427, 1497.9251037448084, 1500.197394393994, 1501.6996600679909, 977.5747549815853, 996.2750985639595, 1004.2969921055291, 1006.2503434941016, 1006.9395836249848, 5057.898842023139, 5073.239014147834, 5079.111155547765, 5089.745512724349, 5106.693598384109, 6088.543359248074, 6115.571909966348, 6120.234970628671, 6121.785737499166, 6143.293521245025, 5075.7969681212335, 5081.796728130834, 5084.161113416245, 5091.41448733393, 5093.668911520739, 3215.9839200803845, 3283.047916104351, 3291.308825146746, 3296.4396052671104, 3318.867245310209, 5658.151277308354, 5793.304803423532, 5829.8251052468495, 5849.239598852207, 5861.3845546217035, 6364.331745166691, 6371.076193951851, 6391.169148010729, 6400.455961243347, 6402.679866006681, 5794.739236734357, 5811.854703632358, 5826.388229235954, 5829.970850145722, 5851.1223316502865, 6106.9083963739695, 6133.294671112879, 6160.815175544741, 6175.104609831639, 6177.536684748572, 5852.858692554911, 6004.0693692477735, 6013.699315034143, 6017.518598512196, 6094.603850749687, 5839.883202336015, 5839.912401313899, 5846.123081537633, 5855.619384739978, 5863.091220860773, 4145.54399016102, 4224.0, 4228.154369126126, 4235.894102647335, 4248.0, 6005.579609427473, 6146.385361463997, 6165.753369865155, 6169.444749972345, 6189.442950134509, 5866.354700982974, 5912.142739302691, 5922.555808314308, 5928.940710593011, 5930.080837470199, 5909.8227053188475, 5914.763409463573, 5930.318013428338, 5930.555208359304, 5940.435658612425, 5597.104463285855, 5752.33848107473, 5802.042662960733, 5821.185034095315, 5827.776167004977, 5903.173555702291, 5913.172155898264, 6000.69996500182, 6004.159417681441, 6008.399160083956, 5810.041343178328, 5816.098504731774, 5824.650520968756, 5827.5629327801435, 5830.5044071254415], "unit": "ms", "name": "prototype.html", "value": 4437.520064861445}, {"lowerIsBetter": false, "replicates": [734.8126227811907, 760.186600337639, 761.2919984414496, 763.1071646173978, 772.6329993253205, 11572.132090093246, 11929.105317101208, 11960.641180764569, 11960.64118076459, 11979.460924258408, 11495.137864660142, 11502.309861408321, 11574.131940104506, 11928.165028447991, 12095.092868034888, 771.2904128202067, 779.2908453307491, 787.0594639405912, 787.2875048081467, 795.6141271483326, 803.4094940218935, 803.6142651527271, 805.6575955219038, 807.5195258820992, 812.4434762187921, 824.1634740738156, 832.9000519937616, 837.1670188162786, 842.7766641839918, 844.877492763549, 825.0676735289115, 831.9376046796484, 832.11795496773, 832.2967092806568, 834.1450013735939, 620.7703149834545, 620.8385819686869, 622.2999125983268, 623.3050149083739, 624.073251221935, 11788.705282367924, 11911.642650720492, 11915.582954596633, 11926.224795388358, 11938.0, 10957.945210273978, 11183.217174797768, 11183.888161118366, 11471.311721296748, 11794.292342459394, 9147.496887671176, 9184.31117666171, 9301.162895339452, 9385.5307234638, 9499.38254013487, 3185.2514659055337, 3293.357795229931, 3293.374258890803, 3317.9834100829585, 3361.1429085583263, 43323.0, 43620.78189609032, 43631.12737745227, 44061.77969110134, 44082.0, 8606.956965215133, 8611.311095112376, 8615.267702245379, 8944.642214311354, 9222.723318300461, 16739.330426783035, 16747.91626041862, 16752.916235418747, 16799.496015119566, 16832.158392080346, 6268.780592679325, 6301.747930082745, 6317.557770956081, 6370.904436433457, 6574.8356291093105, 3395.864165433355, 3478.7564870458823, 3495.2834668892815, 3533.081398836321, 3561.6260292669413, 2789.2190186747744, 2810.1148138336357, 2810.8594570271403, 2824.406874556325, 2826.1804076817903, 502.9270755740397, 508.24271834966373, 519.4104691175543, 519.4753299167792, 550.3313474128872, 492.2861850317055, 533.9987523393637, 553.3083645443196, 579.8956187886137, 588.9322727886348, 7509.549427034395, 7527.209642987517, 7540.359069479046, 7620.69517219305, 7678.961605191938, 579.5595347535818, 596.8567543789546, 598.186466405688, 600.4655856287907, 604.8699529601157, 3449.4653328734084, 3469.531613232232, 3660.670539651444, 3701.3152566775234, 3716.349638813197, 52030.73984630052, 52241.7387913058, 52287.73856130695, 52329.0, 52537.0, 46354.76822615933, 46494.76752616283, 46571.30143047789, 47098.88055037532, 47290.29064564034, 41730.0, 42600.14799703989, 42663.0, 43651.12697746027, 44215.77892110583, 7442.553446793209, 7549.811254718676, 7731.38148948094, 7940.325072368913, 7971.521708697497, 32469.94125734283, 33338.16654583558, 34035.319293614484, 34050.489242661875, 34773.13067173341, 40416.0, 40978.79510602428, 41545.75362739123, 41549.16901661889, 41845.58154418417, 10228.0, 10245.334053286513, 10287.588496460057, 10393.480325983823, 10742.409167495864, 11387.089032877515, 11408.35243695817, 11460.598879039528, 11698.239614425034, 11718.88281117178, 10671.733206669895, 11003.559857605605, 11027.669169924915, 11072.944635277094, 11727.589534366256, 11044.0, 11221.55113795439, 11246.718832029264, 11277.661670149908, 11477.770444590895, 10476.476176191312, 10698.14414846826, 10726.892731072589, 11027.61403350879, 11145.442727863736, 9372.48451335156, 9565.186959108554, 9648.421094734338, 9928.354656947275, 10058.849117263393, 9317.534123293945, 9367.578458969227, 9388.389754665925, 9431.151196392357, 9478.478683672463], "unit": "ms", "name": "yui.html", "value": 5834.356253311166}], "name": "dromaeo_css", "value": 6606.6910971536245}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 111.0, 112.0, 114.0, 123.0, 110.0, 114.0, 114.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 163.0, 169.0, 147.0, 167.0, 163.0, 135.0, 168.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 164.0, 166.0, 166.0, 164.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 81.0, 73.0, 73.0, 73.0, 149.0, 74.0, 73.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 129.0, 91.0, 92.0, 91.0, 125.0, 92.0, 92.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 112.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 148.0, 149.0, 150.0, 147.0, 148.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 75.0, 73.0, 74.0, 75.0, 73.0, 75.0, 71.0, 77.0], "unit": "ms", "name": "json-parse-financial", "value": 74.0}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 68.0, 70.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 93.0, 85.0, 83.0, 83.0, 85.0, 87.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 128.0, 128.0, 124.0, 125.0, 138.0, 119.0, 131.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [161.0, 140.0, 151.0, 152.0, 149.0, 140.0, 147.0, 149.0, 147.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 70.0, 70.0, 71.0, 74.0, 72.0, 70.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1546.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.21201240411295], "unit": "score", "name": "Richards", "value": 216.29535399999995}, {"lowerIsBetter": false, "replicates": [190.29495718363464], "unit": "score", "name": "DeltaBlue", "value": 347.4500900000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [714.7962830593281], "unit": "score", "name": "Earley", "value": 932.381737}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [612.369871402327], "unit": "score", "name": "Splay", "value": 133.07480300000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21381.19029057431}]} 22:37:11 INFO - RETURN: dromaeo_css: 6606.69 22:37:11 INFO - RETURN: kraken: 1546.10 22:37:11 INFO - RETURN: v8_7: 21381.19 22:37:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21381.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1546.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6606.69"}}} 22:37:11 INFO - Return code: 0 22:37:11 INFO - # TBPL SUCCESS # 22:37:11 INFO - Running post-action listener: _resource_record_post_action 22:37:11 INFO - Running post-run listener: _resource_record_post_run 22:37:12 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 511541248; Read time: 20; Write time: 467132 22:37:12 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 182861824; Read time: 0; Write time: 191464 22:37:12 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273166336; Read time: 8; Write time: 173512 22:37:12 INFO - Running post-run listener: _upload_blobber_files 22:37:12 INFO - Blob upload gear active. 22:37:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:37:12 INFO - Copying logs to upload dir... 22:37:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.611943 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 22:37:12.022805) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:37:12.028173) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009937 build_url: 'https://queue.taskcluster.net/v1/task/WmuZ4jJPRgWNloQkeeNGyQ/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-19 22:37:12.079655) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:37:12.079994) ========= 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=d333f129428bd91e5d9d687c000001bd-1447989293.465912-634059192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:37:12.129392) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:37:12.129700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:37:12.129993) ========= ========= Total master_lag: 0.27 =========