builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1447859540.24 results: success (0) buildid: 20151118055124 builduid: ce34fd181fd54a40b2bbe96e3cc9f471 revision: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:20.242602) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:20.243146) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:20.243793) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009045 basedir: '/builds/slave/test' ========= master_lag: 0.43 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:20.681556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-11-18 07:12:20.681901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-11-18 07:12:22.351374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.351720) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030654 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.401458) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.404820) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.405269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.405581) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 07:12:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-18 07:12:22 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.269626 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.760610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.760956) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.129626 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.903889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:22.904286) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 07:12:23,244 truncating revision to first 12 chars 2015-11-18 07:12:23,244 Setting DEBUG logging. 2015-11-18 07:12:23,245 attempt 1/10 2015-11-18 07:12:23,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d6155d7e6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 07:12:23,490 unpacking tar archive at: mozilla-central-1d6155d7e6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:23.446510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:23.446879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:23.458082) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:23.458330) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 07:12:23.458705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 07:12:23.458987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:23 INFO - MultiFileLogger online at 20151118 07:12:23 in /builds/slave/test 07:12:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:12:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:23 INFO - {'append_to_log': False, 07:12:23 INFO - 'base_work_dir': '/builds/slave/test', 07:12:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:12:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:24 INFO - 'branch': 'Firefox-Non-PGO', 07:12:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:24 INFO - 'config_files': ('talos/linux_config.py',), 07:12:24 INFO - 'default_actions': ('clobber', 07:12:24 INFO - 'read-buildbot-config', 07:12:24 INFO - 'download-and-extract', 07:12:24 INFO - 'populate-webroot', 07:12:24 INFO - 'create-virtualenv', 07:12:24 INFO - 'install', 07:12:24 INFO - 'run-tests'), 07:12:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:24 INFO - 'download_minidump_stackwalk': True, 07:12:24 INFO - 'download_symbols': 'ondemand', 07:12:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:24 INFO - 'installer_path': 'installer.exe', 07:12:24 INFO - 'log_level': 'info', 07:12:24 INFO - 'log_name': 'talos', 07:12:24 INFO - 'log_to_console': True, 07:12:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:24 INFO - 'opt_config_files': (), 07:12:24 INFO - 'pip_index': False, 07:12:24 INFO - 'sps_profile': False, 07:12:24 INFO - 'sps_profile_interval': 0, 07:12:24 INFO - 'suite': 'dromaeojs', 07:12:24 INFO - 'system_bits': '64', 07:12:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:24 INFO - 'title': 'talos-linux64-ix-049', 07:12:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:24 INFO - 'use_talos_json': True, 07:12:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:24 INFO - 'work_dir': 'build'} 07:12:24 INFO - ##### 07:12:24 INFO - ##### Running clobber step. 07:12:24 INFO - ##### 07:12:24 INFO - Running pre-action listener: _resource_record_pre_action 07:12:24 INFO - Running main action method: clobber 07:12:24 INFO - rmtree: /builds/slave/test/build 07:12:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:24 INFO - Running post-action listener: _resource_record_post_action 07:12:24 INFO - ##### 07:12:24 INFO - ##### Running read-buildbot-config step. 07:12:24 INFO - ##### 07:12:24 INFO - Running pre-action listener: _resource_record_pre_action 07:12:24 INFO - Running main action method: read_buildbot_config 07:12:24 INFO - Using buildbot properties: 07:12:24 INFO - { 07:12:24 INFO - "properties": { 07:12:24 INFO - "buildnumber": 327, 07:12:24 INFO - "product": "firefox", 07:12:24 INFO - "script_repo_revision": "production", 07:12:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:12:24 INFO - "repository": "", 07:12:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:12:24 INFO - "buildid": "20151118055124", 07:12:24 INFO - "slavename": "talos-linux64-ix-049", 07:12:24 INFO - "pgo_build": "False", 07:12:24 INFO - "basedir": "/builds/slave/test", 07:12:24 INFO - "project": "", 07:12:24 INFO - "platform": "ubuntu64_hw", 07:12:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:12:24 INFO - "slavebuilddir": "test", 07:12:24 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:12:24 INFO - "branch": "mozilla-central", 07:12:24 INFO - "repo_path": "mozilla-central", 07:12:24 INFO - "stage_platform": "linux64", 07:12:24 INFO - "builduid": "ce34fd181fd54a40b2bbe96e3cc9f471", 07:12:24 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:12:24 INFO - }, 07:12:24 INFO - "sourcestamp": { 07:12:24 INFO - "repository": "", 07:12:24 INFO - "hasPatch": false, 07:12:24 INFO - "project": "", 07:12:24 INFO - "branch": "mozilla-central-linux64-talos", 07:12:24 INFO - "changes": [ 07:12:24 INFO - { 07:12:24 INFO - "category": null, 07:12:24 INFO - "files": [ 07:12:24 INFO - { 07:12:24 INFO - "url": null, 07:12:24 INFO - "name": "https://queue.taskcluster.net/v1/task/BgpHMN07S32CrwMHcV_dhA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:12:24 INFO - } 07:12:24 INFO - ], 07:12:24 INFO - "repository": "", 07:12:24 INFO - "rev": "f8cc032951d3e6546c78816dc2bfae80461e1feb", 07:12:24 INFO - "who": "cbook@mozilla.com", 07:12:24 INFO - "when": 1447859534, 07:12:24 INFO - "number": 6677217, 07:12:24 INFO - "comments": "merge fx-team to mozilla-central a=merge", 07:12:24 INFO - "project": "", 07:12:24 INFO - "at": "Wed 18 Nov 2015 07:12:14", 07:12:24 INFO - "branch": "mozilla-central-linux64-talos", 07:12:24 INFO - "revlink": "", 07:12:24 INFO - "properties": [ 07:12:24 INFO - [ 07:12:24 INFO - "buildid", 07:12:24 INFO - "20151118054924", 07:12:24 INFO - "Change" 07:12:24 INFO - ], 07:12:24 INFO - [ 07:12:24 INFO - "builduid", 07:12:24 INFO - "f3a1d1c96e214e44ae8161e445967028", 07:12:24 INFO - "Change" 07:12:24 INFO - ], 07:12:24 INFO - [ 07:12:24 INFO - "pgo_build", 07:12:24 INFO - "False", 07:12:24 INFO - "Change" 07:12:24 INFO - ] 07:12:24 INFO - ], 07:12:24 INFO - "revision": "f8cc032951d3e6546c78816dc2bfae80461e1feb" 07:12:24 INFO - }, 07:12:24 INFO - { 07:12:24 INFO - "category": null, 07:12:24 INFO - "files": [ 07:12:24 INFO - { 07:12:24 INFO - "url": null, 07:12:24 INFO - "name": "https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:12:24 INFO - } 07:12:24 INFO - ], 07:12:24 INFO - "repository": "", 07:12:24 INFO - "rev": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d", 07:12:24 INFO - "who": "cbook@mozilla.com", 07:12:24 INFO - "when": 1447859514, 07:12:24 INFO - "number": 6677215, 07:12:24 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 07:12:24 INFO - "project": "", 07:12:24 INFO - "at": "Wed 18 Nov 2015 07:11:54", 07:12:24 INFO - "branch": "mozilla-central-linux64-talos", 07:12:24 INFO - "revlink": "", 07:12:24 INFO - "properties": [ 07:12:24 INFO - [ 07:12:24 INFO - "buildid", 07:12:24 INFO - "20151118055124", 07:12:24 INFO - "Change" 07:12:24 INFO - ], 07:12:24 INFO - [ 07:12:24 INFO - "builduid", 07:12:24 INFO - "ce34fd181fd54a40b2bbe96e3cc9f471", 07:12:24 INFO - "Change" 07:12:24 INFO - ], 07:12:24 INFO - [ 07:12:24 INFO - "pgo_build", 07:12:24 INFO - "False", 07:12:24 INFO - "Change" 07:12:24 INFO - ] 07:12:24 INFO - ], 07:12:24 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:12:24 INFO - } 07:12:24 INFO - ], 07:12:24 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 07:12:24 INFO - } 07:12:24 INFO - } 07:12:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:12:24 INFO - Running post-action listener: _resource_record_post_action 07:12:24 INFO - ##### 07:12:24 INFO - ##### Running download-and-extract step. 07:12:24 INFO - ##### 07:12:24 INFO - Running pre-action listener: _resource_record_pre_action 07:12:24 INFO - Running main action method: download_and_extract 07:12:24 INFO - mkdir: /builds/slave/test/build/tests 07:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:24 INFO - https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/test_packages.json 07:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/test_packages.json 07:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:12:25 INFO - Downloaded 1302 bytes. 07:12:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:12:25 INFO - Using the following test package requirements: 07:12:25 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:12:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'jsshell-linux-x86_64.zip'], 07:12:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:12:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:12:25 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:12:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:12:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:12:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:12:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:12:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:12: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')]} 07:12:25 INFO - https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:26 INFO - Downloaded 21277477 bytes. 07:12:26 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 07:12:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:26 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 07:12:27 INFO - Return code: 0 07:12:27 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 07:12: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')]} 07:12:27 INFO - https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:29 INFO - Downloaded 21277477 bytes. 07:12:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:12:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:12:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:12:31 INFO - Return code: 0 07:12:31 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')]} 07:12:31 INFO - https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:12:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:32 INFO - Downloaded 11130997 bytes. 07:12:32 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 07:12:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:12:32 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 07:12:32 INFO - Return code: 0 07:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:32 INFO - https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ljc232YETviCPTCy-mgPig/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 07:12:34 INFO - Downloaded 55659154 bytes. 07:12:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:34 INFO - mkdir: /builds/slave/test/properties 07:12:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:12:34 INFO - Writing to file /builds/slave/test/properties/build_url 07:12:34 INFO - Contents: 07:12:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:12:34 INFO - Running post-action listener: _resource_record_post_action 07:12:34 INFO - Running post-action listener: set_extra_try_arguments 07:12:34 INFO - ##### 07:12:34 INFO - ##### Running populate-webroot step. 07:12:34 INFO - ##### 07:12:34 INFO - Running pre-action listener: _resource_record_pre_action 07:12:34 INFO - Running main action method: populate_webroot 07:12:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:12:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:12:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:12:34 INFO - '../fennec_ids.txt'], 07:12:34 INFO - 'tests': ['tcheck2']}, 07:12:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:12:34 INFO - '--tppagecycles', 07:12:34 INFO - '7'], 07:12:34 INFO - 'tests': ['tsvgm']}}, 07:12:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:12:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:12:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:12:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:12:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'tests': ['damp', 'tps']}, 07:12:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['damp', 'tps']}, 07:12:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:12:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:12:34 INFO - 'other': {'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'other_l64': {'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'other_nol64': {'tests': ['a11yr', 07:12:34 INFO - 'ts_paint', 07:12:34 INFO - 'tpaint', 07:12:34 INFO - 'sessionrestore', 07:12:34 INFO - 'sessionrestore_no_auto_restore']}, 07:12:34 INFO - 'svgr': {'tests': ['tsvgx', 07:12:34 INFO - 'tsvgr_opacity', 07:12:34 INFO - 'tart', 07:12:34 INFO - 'tscrollx', 07:12:34 INFO - 'cart']}, 07:12:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['tsvgx', 07:12:34 INFO - 'tsvgr_opacity', 07:12:34 INFO - 'tart', 07:12:34 INFO - 'tscrollx', 07:12:34 INFO - 'cart']}, 07:12:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'tests': ['tp5o']}, 07:12:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'talos_options': ['--e10s'], 07:12:34 INFO - 'tests': ['tp5o']}, 07:12:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'talos_options': ['--xperf_path', 07:12:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:34 INFO - 'tests': ['tp5n']}, 07:12:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:12:34 INFO - 'talos_options': ['--e10s', 07:12:34 INFO - '--xperf_path', 07:12:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:12:34 INFO - 'tests': ['tp5n']}}, 07:12:34 INFO - 'talos.zip': {'path': '', 07:12:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:12:34 INFO - Running post-action listener: _resource_record_post_action 07:12:34 INFO - ##### 07:12:34 INFO - ##### Running create-virtualenv step. 07:12:34 INFO - ##### 07:12:34 INFO - Running pre-action listener: _resource_record_pre_action 07:12:34 INFO - Running main action method: create_virtualenv 07:12:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:12:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:12:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:12:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:12:34 INFO - Using real prefix '/usr' 07:12:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:12:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:12:37 INFO - Installing pip.................done. 07:12:37 INFO - Return code: 0 07:12:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:12:37 INFO - Using env: {'DISPLAY': ':0', 07:12:37 INFO - 'HOME': '/home/cltbld', 07:12:37 INFO - 'LANG': 'en_US.UTF-8', 07:12:37 INFO - 'LANGUAGE': 'en_US:en', 07:12:37 INFO - 'LOGNAME': 'cltbld', 07:12:37 INFO - 'MAIL': '/var/mail/cltbld', 07:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:37 INFO - 'MOZ_NO_REMOTE': '1', 07:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:37 INFO - 'NO_EM_RESTART': '1', 07:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:37 INFO - 'PWD': '/builds/slave/test', 07:12:37 INFO - 'SHELL': '/bin/bash', 07:12:37 INFO - 'SHLVL': '1', 07:12:37 INFO - 'TERM': 'linux', 07:12:37 INFO - 'TMOUT': '86400', 07:12:37 INFO - 'USER': 'cltbld', 07:12:37 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:37 INFO - '_': '/tools/buildbot/bin/python'} 07:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:38 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 07:12:38 INFO - Cleaning up... 07:12:38 INFO - Return code: 0 07:12:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:12:38 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')]} 07:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:38 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')]} 07:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:38 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 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:38 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 07:12:38 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 07:12:38 INFO - Using env: {'DISPLAY': ':0', 07:12:38 INFO - 'HOME': '/home/cltbld', 07:12:38 INFO - 'LANG': 'en_US.UTF-8', 07:12:38 INFO - 'LANGUAGE': 'en_US:en', 07:12:38 INFO - 'LOGNAME': 'cltbld', 07:12:38 INFO - 'MAIL': '/var/mail/cltbld', 07:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:38 INFO - 'MOZ_NO_REMOTE': '1', 07:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:38 INFO - 'NO_EM_RESTART': '1', 07:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:38 INFO - 'PWD': '/builds/slave/test', 07:12:38 INFO - 'SHELL': '/bin/bash', 07:12:38 INFO - 'SHLVL': '1', 07:12:38 INFO - 'TERM': 'linux', 07:12:38 INFO - 'TMOUT': '86400', 07:12:38 INFO - 'USER': 'cltbld', 07:12:38 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:38 INFO - '_': '/tools/buildbot/bin/python'} 07:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:38 INFO - Downloading/unpacking psutil>=0.7.1 07:12:38 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 07:12:38 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 07:12:38 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 07:12:38 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 07:12:38 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 07:12:38 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 07:12:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:12:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:40 INFO - Installing collected packages: psutil 07:12:40 INFO - Running setup.py install for psutil 07:12:40 INFO - building 'psutil._psutil_linux' extension 07:12:40 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 07:12:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:12:41 INFO - building 'psutil._psutil_posix' extension 07:12:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:12:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:12:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:41 INFO - Successfully installed psutil 07:12:41 INFO - Cleaning up... 07:12:41 INFO - Return code: 0 07:12:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:12:41 INFO - Using env: {'DISPLAY': ':0', 07:12:41 INFO - 'HOME': '/home/cltbld', 07:12:41 INFO - 'LANG': 'en_US.UTF-8', 07:12:41 INFO - 'LANGUAGE': 'en_US:en', 07:12:41 INFO - 'LOGNAME': 'cltbld', 07:12:41 INFO - 'MAIL': '/var/mail/cltbld', 07:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:41 INFO - 'MOZ_NO_REMOTE': '1', 07:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:41 INFO - 'NO_EM_RESTART': '1', 07:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:41 INFO - 'PWD': '/builds/slave/test', 07:12:41 INFO - 'SHELL': '/bin/bash', 07:12:41 INFO - 'SHLVL': '1', 07:12:41 INFO - 'TERM': 'linux', 07:12:41 INFO - 'TMOUT': '86400', 07:12:41 INFO - 'USER': 'cltbld', 07:12:41 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:41 INFO - '_': '/tools/buildbot/bin/python'} 07:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12:41 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 07:12:41 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 07:12:41 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 07:12:41 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 07:12:41 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 07:12:41 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 07:12:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:43 INFO - Installing collected packages: mozsystemmonitor 07:12:43 INFO - Running setup.py install for mozsystemmonitor 07:12:43 INFO - Successfully installed mozsystemmonitor 07:12:43 INFO - Cleaning up... 07:12:43 INFO - Return code: 0 07:12:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:43 INFO - Using env: {'DISPLAY': ':0', 07:12:43 INFO - 'HOME': '/home/cltbld', 07:12:43 INFO - 'LANG': 'en_US.UTF-8', 07:12:43 INFO - 'LANGUAGE': 'en_US:en', 07:12:43 INFO - 'LOGNAME': 'cltbld', 07:12:43 INFO - 'MAIL': '/var/mail/cltbld', 07:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:43 INFO - 'MOZ_NO_REMOTE': '1', 07:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:43 INFO - 'NO_EM_RESTART': '1', 07:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:43 INFO - 'PWD': '/builds/slave/test', 07:12:43 INFO - 'SHELL': '/bin/bash', 07:12:43 INFO - 'SHLVL': '1', 07:12:43 INFO - 'TERM': 'linux', 07:12:43 INFO - 'TMOUT': '86400', 07:12:43 INFO - 'USER': 'cltbld', 07:12:43 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:43 INFO - '_': '/tools/buildbot/bin/python'} 07:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:43 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 07:12:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:46 INFO - Downloading docopt-0.6.1.tar.gz 07:12:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:46 INFO - Running setup.py install for blobuploader 07:12:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:46 INFO - Running setup.py install for requests 07:12:46 INFO - Running setup.py install for docopt 07:12:46 INFO - Successfully installed blobuploader requests docopt 07:12:46 INFO - Cleaning up... 07:12:46 INFO - Return code: 0 07:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:46 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 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:46 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 07:12:46 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 07:12:46 INFO - Using env: {'DISPLAY': ':0', 07:12:46 INFO - 'HOME': '/home/cltbld', 07:12:46 INFO - 'LANG': 'en_US.UTF-8', 07:12:46 INFO - 'LANGUAGE': 'en_US:en', 07:12:46 INFO - 'LOGNAME': 'cltbld', 07:12:46 INFO - 'MAIL': '/var/mail/cltbld', 07:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:46 INFO - 'MOZ_NO_REMOTE': '1', 07:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:46 INFO - 'NO_EM_RESTART': '1', 07:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:46 INFO - 'PWD': '/builds/slave/test', 07:12:46 INFO - 'SHELL': '/bin/bash', 07:12:46 INFO - 'SHLVL': '1', 07:12:46 INFO - 'TERM': 'linux', 07:12:46 INFO - 'TMOUT': '86400', 07:12:46 INFO - 'USER': 'cltbld', 07:12:46 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:46 INFO - '_': '/tools/buildbot/bin/python'} 07:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:47 INFO - Running setup.py (path:/tmp/pip-iu79ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:47 INFO - Running setup.py (path:/tmp/pip-ZJA_3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:47 INFO - Running setup.py (path:/tmp/pip-gJvxpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:47 INFO - Running setup.py (path:/tmp/pip-6Ma31c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:47 INFO - Running setup.py (path:/tmp/pip-biA16B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:47 INFO - Running setup.py (path:/tmp/pip-WkSpn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:47 INFO - Running setup.py (path:/tmp/pip-Qg0m2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:47 INFO - Running setup.py (path:/tmp/pip-3157H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:47 INFO - Running setup.py (path:/tmp/pip-RBgusE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:47 INFO - Running setup.py (path:/tmp/pip-9MFQmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:47 INFO - Running setup.py (path:/tmp/pip-HixZmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:47 INFO - Running setup.py (path:/tmp/pip-NlId3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:47 INFO - Running setup.py (path:/tmp/pip-ry7AyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:48 INFO - Running setup.py (path:/tmp/pip-O3aHgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:48 INFO - Running setup.py (path:/tmp/pip-U_Euqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:48 INFO - Running setup.py (path:/tmp/pip-WVRN9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:48 INFO - Running setup.py (path:/tmp/pip-605eCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:48 INFO - Running setup.py install for manifestparser 07:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:48 INFO - Running setup.py install for mozcrash 07:12:48 INFO - Running setup.py install for mozdebug 07:12:48 INFO - Running setup.py install for mozdevice 07:12:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:48 INFO - Running setup.py install for mozfile 07:12:48 INFO - Running setup.py install for mozhttpd 07:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:48 INFO - Running setup.py install for mozinfo 07:12:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for mozInstall 07:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for mozleak 07:12:49 INFO - Running setup.py install for mozlog 07:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for moznetwork 07:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for mozprocess 07:12:49 INFO - Running setup.py install for mozprofile 07:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for mozrunner 07:12:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:49 INFO - Running setup.py install for mozscreenshot 07:12:49 INFO - Running setup.py install for moztest 07:12:49 INFO - Running setup.py install for mozversion 07:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:50 INFO - Cleaning up... 07:12:50 INFO - Return code: 0 07:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:50 INFO - Using env: {'DISPLAY': ':0', 07:12:50 INFO - 'HOME': '/home/cltbld', 07:12:50 INFO - 'LANG': 'en_US.UTF-8', 07:12:50 INFO - 'LANGUAGE': 'en_US:en', 07:12:50 INFO - 'LOGNAME': 'cltbld', 07:12:50 INFO - 'MAIL': '/var/mail/cltbld', 07:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:50 INFO - 'MOZ_NO_REMOTE': '1', 07:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:50 INFO - 'NO_EM_RESTART': '1', 07:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:50 INFO - 'PWD': '/builds/slave/test', 07:12:50 INFO - 'SHELL': '/bin/bash', 07:12:50 INFO - 'SHLVL': '1', 07:12:50 INFO - 'TERM': 'linux', 07:12:50 INFO - 'TMOUT': '86400', 07:12:50 INFO - 'USER': 'cltbld', 07:12:50 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:50 INFO - '_': '/tools/buildbot/bin/python'} 07:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:50 INFO - Running setup.py (path:/tmp/pip-qXEZRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:50 INFO - Running setup.py (path:/tmp/pip-tD9Rr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:50 INFO - Running setup.py (path:/tmp/pip-ex1Avr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:50 INFO - Running setup.py (path:/tmp/pip-K7e2aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:50 INFO - Running setup.py (path:/tmp/pip-HlXWnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:50 INFO - Running setup.py (path:/tmp/pip-8QFPe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:50 INFO - Running setup.py (path:/tmp/pip-9fNphA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:50 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)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:50 INFO - Running setup.py (path:/tmp/pip-xecRuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:50 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)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:50 INFO - Running setup.py (path:/tmp/pip-VuCsCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:50 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)) 07:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:50 INFO - Running setup.py (path:/tmp/pip-VxqgRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:51 INFO - Running setup.py (path:/tmp/pip-VnNzXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:51 INFO - Running setup.py (path:/tmp/pip-mx0ui8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:51 INFO - Running setup.py (path:/tmp/pip-lsDWSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:51 INFO - Running setup.py (path:/tmp/pip-9NXBYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:51 INFO - Running setup.py (path:/tmp/pip-Bgg2iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:51 INFO - Running setup.py (path:/tmp/pip-zOfppl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:51 INFO - Running setup.py (path:/tmp/pip-wI8vr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:53 INFO - Downloading blessings-1.5.1.tar.gz 07:12:53 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:53 INFO - Installing collected packages: blessings 07:12:53 INFO - Running setup.py install for blessings 07:12:53 INFO - Successfully installed blessings 07:12:53 INFO - Cleaning up... 07:12:53 INFO - Return code: 0 07:12:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:53 INFO - Reading from file tmpfile_stdout 07:12:53 INFO - Current package versions: 07:12:53 INFO - argparse == 1.2.1 07:12:53 INFO - blessings == 1.5.1 07:12:53 INFO - blobuploader == 1.2.4 07:12:53 INFO - docopt == 0.6.1 07:12:53 INFO - manifestparser == 1.1 07:12:53 INFO - mozInstall == 1.12 07:12:53 INFO - mozcrash == 0.16 07:12:53 INFO - mozdebug == 0.1 07:12:53 INFO - mozdevice == 0.47 07:12:53 INFO - mozfile == 1.2 07:12:53 INFO - mozhttpd == 0.7 07:12:53 INFO - mozinfo == 0.9 07:12:53 INFO - mozleak == 0.1 07:12:53 INFO - mozlog == 3.0 07:12:53 INFO - moznetwork == 0.27 07:12:53 INFO - mozprocess == 0.22 07:12:53 INFO - mozprofile == 0.27 07:12:53 INFO - mozrunner == 6.11 07:12:53 INFO - mozscreenshot == 0.1 07:12:53 INFO - mozsystemmonitor == 0.0 07:12:53 INFO - moztest == 0.7 07:12:53 INFO - mozversion == 1.4 07:12:53 INFO - psutil == 3.1.1 07:12:53 INFO - requests == 1.2.3 07:12:53 INFO - wsgiref == 0.1.2 07:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93e9529c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a996c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b4a900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, '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': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', '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 07:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:53 INFO - Using env: {'DISPLAY': ':0', 07:12:53 INFO - 'HOME': '/home/cltbld', 07:12:53 INFO - 'LANG': 'en_US.UTF-8', 07:12:53 INFO - 'LANGUAGE': 'en_US:en', 07:12:53 INFO - 'LOGNAME': 'cltbld', 07:12:53 INFO - 'MAIL': '/var/mail/cltbld', 07:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:53 INFO - 'MOZ_NO_REMOTE': '1', 07:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:53 INFO - 'NO_EM_RESTART': '1', 07:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:53 INFO - 'PWD': '/builds/slave/test', 07:12:53 INFO - 'SHELL': '/bin/bash', 07:12:53 INFO - 'SHLVL': '1', 07:12:53 INFO - 'TERM': 'linux', 07:12:53 INFO - 'TMOUT': '86400', 07:12:53 INFO - 'USER': 'cltbld', 07:12:53 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:53 INFO - '_': '/tools/buildbot/bin/python'} 07:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 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)) 07:12:53 INFO - Cleaning up... 07:12:53 INFO - Return code: 0 07:12:53 INFO - Running post-action listener: _resource_record_post_action 07:12:53 INFO - Running post-action listener: _start_resource_monitoring 07:12:53 INFO - Starting resource monitoring. 07:12:53 INFO - ##### 07:12:53 INFO - ##### Running install step. 07:12:53 INFO - ##### 07:12:53 INFO - Running pre-action listener: _resource_record_pre_action 07:12:53 INFO - Running main action method: install 07:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:54 INFO - Reading from file tmpfile_stdout 07:12:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:54 INFO - Reading from file tmpfile_stdout 07:12:54 INFO - Output received: 07:12:54 INFO - Usage: mozinstall [options] installer 07:12:54 INFO - Options: 07:12:54 INFO - -h, --help show this help message and exit 07:12:54 INFO - -d DEST, --destination=DEST 07:12:54 INFO - Directory to install application into. [default: 07:12:54 INFO - "/builds/slave/test"] 07:12:54 INFO - --app=APP Application being installed. [default: firefox] 07:12:54 INFO - mkdir: /builds/slave/test/build/application 07:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:13:08 INFO - Reading from file tmpfile_stdout 07:13:08 INFO - Output received: 07:13:08 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:08 INFO - Running post-action listener: _resource_record_post_action 07:13:08 INFO - ##### 07:13:08 INFO - ##### Running run-tests step. 07:13:08 INFO - ##### 07:13:08 INFO - Running pre-action listener: _resource_record_pre_action 07:13:08 INFO - Running main action method: run_tests 07:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:08 INFO - Python 2.7.3 07:13:08 INFO - Return code: 0 07:13:08 INFO - grabbing minidump binary from tooltool 07:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90b70>, '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 0x1be1dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be2250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:13:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:13:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:08 INFO - Return code: 0 07:13:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test/build 07:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 07:13:08 INFO - Using env: {'DISPLAY': ':0', 07:13:08 INFO - 'HOME': '/home/cltbld', 07:13:08 INFO - 'LANG': 'en_US.UTF-8', 07:13:08 INFO - 'LANGUAGE': 'en_US:en', 07:13:08 INFO - 'LOGNAME': 'cltbld', 07:13:08 INFO - 'MAIL': '/var/mail/cltbld', 07:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:08 INFO - 'MOZ_NO_REMOTE': '1', 07:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:08 INFO - 'NO_EM_RESTART': '1', 07:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:08 INFO - 'PWD': '/builds/slave/test', 07:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:08 INFO - 'SHELL': '/bin/bash', 07:13:08 INFO - 'SHLVL': '1', 07:13:08 INFO - 'TERM': 'linux', 07:13:08 INFO - 'TMOUT': '86400', 07:13:08 INFO - 'USER': 'cltbld', 07:13:08 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768', 07:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:08 INFO - '_': '/tools/buildbot/bin/python'} 07:13:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 07:13:08 INFO - mozversion INFO | application_buildid: 20151118055124 07:13:08 INFO - mozversion INFO | application_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:13:08 INFO - mozversion INFO | application_display_name: Nightly 07:13:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:08 INFO - mozversion INFO | application_name: Firefox 07:13:08 INFO - mozversion INFO | application_remotingname: firefox 07:13:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:13:08 INFO - mozversion INFO | application_vendor: Mozilla 07:13:08 INFO - mozversion INFO | application_version: 45.0a1 07:13:08 INFO - mozversion INFO | platform_buildid: 20151118055124 07:13:08 INFO - mozversion INFO | platform_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 07:13:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:13:08 INFO - mozversion INFO | platform_version: 45.0a1 07:13:08 INFO - 2015-11-18 07:13:08,891 DEBUG : using testdate: 1447859588 07:13:08 INFO - 2015-11-18 07:13:08,891 DEBUG : actual date: 1447859588 07:13:08 INFO - 2015-11-18 07:13:08,899 INFO : starting webserver on 'localhost:43903' 07:13:08 INFO - 2015-11-18 07:13:08,900 INFO : Starting test suite talos-linux64-ix-049 07:13:08 INFO - 2015-11-18 07:13:08,900 INFO : Starting test dromaeo_css 07:13:08 INFO - 2015-11-18 07:13:08,900 DEBUG : operating with platform_type : linux_ 07:13:08 INFO - 2015-11-18 07:13:08,900 INFO : Initialising browser for dromaeo_css test... 07:13:08 INFO - 2015-11-18 07:13:08,965 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXq45Pp/profile http://localhost:43903/getInfo.html 07:13:14 INFO - 2015-11-18 07:13:14,479 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:14 INFO - 2015-11-18 07:13:14,479 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:14 INFO - 2015-11-18 07:13:14,479 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:14 INFO - 2015-11-18 07:13:14,479 DEBUG : BROWSER_OUTPUT: __metrics 07:13:14 INFO - 2015-11-18 07:13:14,621 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:15 INFO - 2015-11-18 07:13:15,837 INFO : Browser initialized. 07:13:15 INFO - 2015-11-18 07:13:15,837 INFO : Running cycle 1/1 for dromaeo_css test... 07:13:15 INFO - 2015-11-18 07:13:15,837 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXq45Pp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:27 INFO - 2015-11-18 07:13:27,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 139714560 07:13:27 INFO - 2015-11-18 07:13:27,767 DEBUG : BROWSER_OUTPUT: 07:14:19 INFO - 2015-11-18 07:14:19,212 DEBUG : BROWSER_OUTPUT: 1447859659212 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] 07:16:31 INFO - 2015-11-18 07:16:31,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43903/tests/dromaeo/cssquery-ext.html) 07:16:32 INFO - 2015-11-18 07:16:32,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 254263296 07:16:32 INFO - 2015-11-18 07:16:32,266 DEBUG : BROWSER_OUTPUT: 07:19:34 INFO - 2015-11-18 07:19:34,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-ext.html (next: http://localhost:43903/tests/dromaeo/cssquery-jquery.html) 07:19:35 INFO - 2015-11-18 07:19:35,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 224641024 07:19:35 INFO - 2015-11-18 07:19:35,432 DEBUG : BROWSER_OUTPUT: 07:22:37 INFO - 2015-11-18 07:22:37,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43903/tests/dromaeo/cssquery-mootools.html) 07:22:38 INFO - 2015-11-18 07:22:38,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 214003712 07:22:38 INFO - 2015-11-18 07:22:38,096 DEBUG : BROWSER_OUTPUT: 07:25:40 INFO - 2015-11-18 07:25:40,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43903/tests/dromaeo/cssquery-prototype.html) 07:25:40 INFO - 2015-11-18 07:25:40,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 199999488 07:25:40 INFO - 2015-11-18 07:25:40,599 DEBUG : BROWSER_OUTPUT: 07:28:43 INFO - 2015-11-18 07:28:43,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43903/tests/dromaeo/cssquery-yui.html) 07:28:43 INFO - 2015-11-18 07:28:43,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 206315520 07:28:43 INFO - 2015-11-18 07:28:43,881 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/dromaeo/cssquery-yui.html (next: http://localhost:43903/tests/dromaeo/cssquery-dojo.html) 07:31:46 INFO - 2015-11-18 07:31:46,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 249274368 07:31:46 INFO - 2015-11-18 07:31:46,776 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,777 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:31:46 INFO - 2015-11-18 07:31:46,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:31:46 INFO - 2015-11-18 07:31:46,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:31:46 INFO - 2015-11-18 07:31:46,777 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:31:46 INFO - 2015-11-18 07:31:46,781 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2671.465706858628;2739.055026016026;2784.7215278472154;2792.8882844686214;2797.3566079801644;4547.067851090526;4671.883202919925;4700.506446823086;4815.181419158743;4841;4595.494495605489;4645.721256724599;4650.395448591678;4653.8371157009515;4687.296905464182;4327.6754243431715;4333.1117120990275;4350.477942646879;4373.671974601902;4382.649388048964;4170.311898536738;4348.108637729258;4383.956160438387;4396.384506169139;4440.489343725464;4111;4184.895377615553;4202.222588821078;4204.474440694913;4294.570542945712;4300.440942677463;4336.284513055342;4342.435483387171;4356.586124318184;4371.34429835524;4133.648639865615;4254.106637606106;4322.783860806947;4327.0913108247305;4360.934585981213;4516.299973504112;4562.041971186021;4650.674452788307;4682.578567928868;4710.811567537295;4985.102681517325;5055.69665820052;5058.848234552969;5060.569851562622;5095.464976177522;4810.951890481086;4935.259711043336;5060.367454068241;5078.7460626968505;5081.237814327844;4584.6561507887045;4660.021395506948;4725.125851717443;4728.196206644879;4781.450133234653;5108.2848401223855;5108.770105345268;5112.821051263188;5150.665206761549;5185.274061631375;4661.137689527448;4775.904481910342;4905.701732537655;4918.729469879119;4945.604351651859;4944.8763780905765;5102.8214012510125;5196.558292545176;5207.843764687065;5215.348081489814;4968.925466118011;4975.875603109951;4980.551750342414;4997.9750101249265;5020.874478138003;4681.9297710534365;4830.275458681155;4945.455999840015;4956.851294461172;4962.280469331927;4052.878413647595;4088.9386659200136;4100.2619528484565;4101.200265948171;4122.546519882811;3671.963280367162;3682.963170368262;3704.2221133562252;3704.5369328833895;3736.7384283100464;4146.543880173179;4241.151769646083;4349.782510874444;4355.0854320593035;4374.234508960983;4850.611951043908;4933.062718083553;5001.699898006132;5009.5491405773655;5056.873578160502;4302.677299202573;4310.547392523803;4317.266064768997;4342.6742994275555;4383.123375324948;4324.891877703019;4439.689221754446;4449;4457.353683715908;4519.706219095814;4628.768561571908;4680.555347242007;4698.9530104698515;4735.644826637947;4783.210770222944;5042.647014708935;5059.114654935445;5060.620453465931;5075.390953085654;5104.617153713561;4641.976790116163;4751.714897106184;4805.303231031551;4806.759662016955;4837.879053023562;4843.975780121077;4887.560119589254;4904.6566740327835;4912.901741965212;4951.282064100613;5033.421156566895;5076.898462030813;5094.7962081516325;5100.081985242544;5147;4617.492075871719;4741.075490279362;4899.16714158601;4911.435184953776;4942.82700105509;4689.648276379354;4728.929066064081;4797.496262892346;4800.279958006327;4813.03739252144;4807.519248075165;4845.1278769820365;4864.489228630943;4869.220924652039;4894.4616092230535;4575.405197324327;4975.129352363394;4976.552110310089;4982.775775090057;5021.824236151717;4641.582257596832;4670.813167473263;4689.601383882408;4816.446108697404;4821.879453013562 07:31:46 INFO - 2015-11-18 07:31:46,782 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.9133684278936;568.4344077642745;569.9487046165845;581.5289615411517;591.6479694581723;24719.999999999978;33928.98213053609;34642.480362794515;34719.30561388771;34746;39368;39904.60095399045;39912;39990.8000459998;40049.199016019666;6985.091938048046;7072.6817293221675;8020.478668886532;8204.958975205116;8205.138460461625;10162.796744065114;10415.479226038706;10430.63492777753;10433.321834080798;10442.843357349646;10261.281710280284;10312.278140530167;10323.638672646459;10372.481375931173;10373.325733827314;7166.892496612581;7323.48735588509;7333.449991250677;7344.228855970099;10207.13239374654;7027.191872934627;10334.896651033469;10644.680659580225;10661.626843060532;10664.573417063308;37325.44011839825;37415.4387684185;37549;37658.62341376606;37844.43233351474;2779.0551212587616;2829.363393236526;2845.6300680911554;2857.171420288114;3442.277121804424;28191.15426537207;28393.290167745767;28646.570301445496;28678.856605717046;28824;2940.5148150555133;2963.9110826675233;2974.6876577959433;3009.232645675361;3074.446599612069;217596;217807;217899;218438;218936;45864.77067614641;46518.53481465142;52758;53106.203406948924;59367.40632593619;53803;54183.729081354344;54216;54225.45774542283;54249.72875135599;12911.677208069874;13050.34748262602;13125.278109704059;13131.868681313064;13140.27728474924;9466.95266523663;9493.050694930589;9508.38195517303;9511.809763804686;9513.714588562354;18087.909560452114;18351.724724129148;18358.173882175335;18377.356792512197;18498.907505462386;7175.89236161458;7430;7448.478606497493;7455.701771929171;7525.172231054579;796.3509739562238;818.8648872936018;867.4318321499428;881.5195718333524;961.8797650293714;26133;26287.34281642936;26583.601245981325;26637.733622663527;26654;888.9555522223862;896.1620884472908;912.9497877616794;930.0559931669361;933.8319102561468;12403;12477.625671229878;12612.55856045034;12649;14156.85843141576;203778;206121;206955;207385;207944;42379.364309535384;42728;42840.57159428428;42894.57105428906;43018.35472467916;1101.0255923507752;1103.690966529373;1140.5551834784276;1152.9680935562624;1154.509333533245;21658.566828663024;24428.51142977166;24547;27625.309367265978;27859;40418.79790601028;40853.38719919263;40924;40931.18137637171;40954.385684215355;211895;212580;212649;213212;311206;24091.27726168218;28646.85676571604;29015.564766528096;29351.706482934896;29422;33872.66127338695;34388.82805586056;34510.82744586261;34521.65478345184;34771.82614086913;29425.11724648264;29560.852195738884;29810.850945745133;29835.850820745756;32828.67171328256;30222.54666179965;30778.384432311675;31663.683363166074;32475.675243247264;33094.50358244676;32336.514952276204;32755.181120472178;32981.67018329786;32983.34033319368;33050;28140.296492587848;29423.411531769674;29942.401151977276;30088.84955575208;30570;21961.780382195975;22788.202412915467;22798.518096323685;22869.771302286765;23108.306750797503 07:31:46 INFO - 2015-11-18 07:31:46,784 DEBUG : BROWSER_OUTPUT: |2;jquery.html;302.5522227103886;309.3951325159315;310.21515565618967;311.4798286860942;318.32673894712684;12417.937910310437;12811.679708007281;14955.626109347259;15351.155686437241;15416;13040.347982600855;14501.274936253198;15267.847321526782;15809.288582013809;15844.76232856508;4312;4436.534163912791;4446.599806017458;4841.564259216679;4974.751262436864;3161.5415764714216;3242.4649932761067;4410.536893626171;4427.911441771163;4432.20220360335;4400.845970391037;4486.1700585391645;4521.819127234923;4524.728516289017;4528.343390208434;4206.390073439334;4492.595666390024;4493.505714371417;4495.775211239441;4499.392582001437;3961.6038396160443;3973.2252210818615;3976.08550033491;3979.641832235113;3982.183652351261;10897.509612067475;11009.394483303415;11044.282121662067;11132.666020019413;11285.887141128647;1587.618971446856;1650.991745041279;1714.4085290574733;1764.6117854072083;1765.1527266911826;8434.24091831732;8470.449420787629;8607.39748217625;8623.956880215621;8666.39335246533;1617.385393550455;1708.8803783735143;1714.7685062516525;1721.614100648977;1775.6537475192342;45393.54606453926;46269;46448.3032754509;46966.29550556745;47593.5240647596;6064.120702498113;6083.422074902877;6148.1699970504305;6167.259928808572;6179.938200618026;7037.612931288726;7039.612821294775;7049.753258636026;7063.081799366049;7064.7527336544;4530.954690453119;4535.9773201133785;4557.430321209848;4576.313552967082;4578.5421457853945;4528.02647430804;4595;4607.170709272296;4633.374494443207;4638.304254361805;2771.722827717212;2801.579763035561;2804.9859750701116;2824.997126020274;2828.250513613894;1026.8459731040255;1033.5194134727237;1033.7622346860264;1046.6598355534481;1099.8130317845985;324.1765914576948;340.664743185465;390.94917660703925;397.6619873107893;406.46752753892497;9958.402495850272;10376;10415.427151506588;10694.144468442506;10751.623693170857;347.4909257937134;379.249086808116;386.6114554872335;427.446456838395;435.44915681662724;5185.429602743695;5377.838664840061;5399.1091469907815;5453.291072160673;5717.485426311652;462082;472907;477838;482391;483040;65184.674076629315;65761.67119164373;65972;66078.66960665262;67086.32913670801;468.2017160740929;472.3764630687528;475.63613835415936;478.0176736805828;478.2014036558955;9411.764705882408;9482.762930926781;9549.188318992963;9566.330356874952;9574.808503830023;30458.543121853632;31585.21036974094;32021.199470013435;32146.357072857943;32398.514022290157;42108;42142.57857421387;42730.78634606807;42872.57127428811;43531.347029795215;5853.94146058551;5876.676782776988;5964.105384192406;5997.280326360865;6048.304444988883;10590.735231619272;10766.300190487593;10873.836892446461;10877.347359158475;10901.34591924487;9116.1339672731;9282.257419406566;9356.532173391439;9688.32181747271;9704.078112579293;9214.44713317203;9436.622535098519;9526.285528585522;9655.372400793925;9719.56261968199;9567.282453815853;9592.856107158537;9764.85352719724;9770.609175633179;9981.800363992534;5322.920156197738;5339.546138578109;5346.224797404432;5422.240886276003;5422.457754224546;8707.956460217658;9018.774530636787;9190.31072669539;9436.480993545421;9450.149486546245 07:31:46 INFO - 2015-11-18 07:31:46,785 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1421.147311613033;1615.5314958661988;1671.8662506999433;1683.5875210573408;1697.9660406791857;5623.9999999999945;5892.764289428423;6456.967715161423;6634.4029037386745;6669.799906002816;6589.637569933664;6673.366030227121;6706.865862682744;6709.261981182066;6724.428423583989;1917.6739954207783;1934.5067007912962;1935.3516571948414;1939.679952807785;1940.2142132436315;1949.0547084663997;1960.5686748915216;1966.7934866838991;1976.8715033522847;1987.3044434447972;1945.1344151852431;1951.863369564131;1953.794851540589;1958.2852258925461;1959.8726082804644;1921.269917431374;1947.4352437793023;1953.2772874036555;1953.7167110769;1953.872998255116;1832.9083545822655;1857.8699491035634;1860.9255629774793;1864.2636158717366;1864.645717313706;5487.396386397493;6637;6681.198256209237;6692.498062645321;6699.966500167517;3439.7592168548213;3848.749831260987;3950.0914789598555;3960.2277555876617;3966.7619942803235;2620.2401303621928;2635.9868200659066;2686.9059582914506;2689.17980016095;2730.7405796449307;844.7339088187201;849.4096602861014;1665.267282395742;1682.8317168283197;1712.332190445727;8966.551672416419;9099.1810737034;9144.268458523302;9159.084091590788;9160.358774885828;3543.7165026797793;3570.4644303354185;3605.9819700901853;3615.042013866275;3621.4748861415474;7492.438067144877;7496.7376141834775;7497.66260518278;7504.061992250969;7506.099268087755;4048.554658987509;4069.8575549855614;4073.816678249486;4076.9184616308103;4079.1841631673783;3768.491253680773;3778.112143646241;3778.4332350147697;3778.981105094457;3782.7730336179916;2940.7647388208893;2957.600723902289;2961;2964.466396048732;2979.3147576057627;858.3819649852096;859.5186695450443;860.2644738748405;860.9397342185987;863.8963324400986;896.8161526886972;946.0208684012152;1137.1869113583828;1160.0255785140523;1166.6383421139474;6492.09110724499;6516.967415162989;6530;6545.672716364163;6553.213614366211;1009.6213919780082;1018.1752780248023;1021.5096753558186;1030.304544432505;1052.074174726236;4553.180427523078;4835.347228124158;4865.197242454955;4867.318575399447;4874.878128046827;6697.531172817856;7691.461597688108;7909.24862138096;7916.722914697958;8003.559804210824;7820.374370050382;7883.172266911892;7891.053073631201;7898.644560994769;7910.327622152066;6188.752449902044;6445.258795238514;6450.3549645036055;6453.354664533603;6473.126127972758;6166.784162554289;6181.443670069715;6190.350013248544;6197.752089916353;6201.472874805511;7085.220625731063;7132.108486439195;7264.527805692613;7281.2718728126765;7289.4168466523615;7235.674394652148;7341.669624866787;7428.777136685908;7524.548527088174;7530;5637.126245431965;5646.407127251579;5669.6314739541795;5701.258836351413;5706.144078388275;5956.702164891824;5956.731947062479;5987.042073268256;5989.341172470938;6043.75824967014;5969.492593129459;6005.519558435402;6123.295820980644;6242.313345531897;6243.594166379171;5997.940020599738;6033.487153591994;6055.757769689163;6059.151718759465;6173.629582225081;5987.700614969322;5998.130271110577;6001.06983417571;6187.783427580013;6220.626762394271;5720.256366672306;5747.224124743107;5747.48272655463;5754.913676294943;5760.740766665594;5765.5675824314185;5784.190213370048;5786.652800831964;5823.563232757476;5841.386654401226 07:31:46 INFO - 2015-11-18 07:31:46,788 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.22098565986556;285.687172546062;290.55980190012133;290.6439611475942;292.97656187505004;5142.871428214296;5294.947050529494;5406.891862162759;5459.7816087356505;5475.151351540512;5218.373795144578;5328.46715328467;5363.973180134104;5367.221752845835;5371.677699338043;4109.280875846723;4124.443200167969;4125.855595054174;4131.669466442692;4131.938020929689;3901.843926242947;3996.400539919021;3996.9800150999204;4103.199876024161;4104.42538044674;4067.1662309226535;4074.490688663917;4092.6112019358116;4107.301758701028;4112.485939257593;4091.2226676931587;4104.384342348641;4104.589541045902;4107.137501124767;4108.568600296956;3582.946255806165;3586.28274345132;3586.4261718125235;3591.317649646559;3594.28114377123;5074.923876141824;5180.989707007135;5195.064888320101;5196.844094677166;5202.14164662834;4726.905461890743;4727.645426592985;4736.455307639597;4739.502352253033;4740.976295118502;5641.435856414367;5649.745761440704;5651.5761317900915;5654.519365853907;5657.462541058634;3718.9070273243115;3796.886093417202;3846.673032792216;3904.2191561687778;3913.2173565287057;5937.881242375129;5948.464638182628;5956.940430595682;5965.582409231356;5971.970140149271;4031.354983202732;4034.45534852797;4035.435039094529;4035.4955630546183;4040.2929487340184;4089.386592011222;4094.467719196485;4094.6928980326593;4095.877123686294;4103.461202049231;4616.722996620214;4703.529647035269;4720.079584480994;4720.409948756405;4724.244120940633;5634.915476267859;5666.603337766399;5669.43305669438;5671.461211184931;5680.176374425685;1425.1164278147407;1442.3293168676616;1443.2350854047372;1444.1768192130385;1445.262915912892;939.9718008459757;957.4638202606562;968.3657204531044;978.8531720242021;981.6907674082784;4942.28336891156;4943.4809345018975;4949.430815456197;4954.3063971044085;4960.677555958851;5833.67914764692;5837.416258374214;5844.094165404369;5847.356790753014;5848.152017957457;4936.432310284364;4946.060248552835;4952.257161425815;4952.4057113146655;4953.702777833341;3053.7862349635757;3114.423831591163;3142.7485801135854;3147.3390587976783;3152.542881282201;5585.106382978704;5615.241942337814;5621.522170615462;5622.606417550732;5624.156376543551;6063.787767428207;6066.211392518944;6066.211392518944;6074.179985701874;6076.3316035236085;5602.38373778884;5607.4112218217315;5608.691521966331;5651.2935883014625;5653.067243904874;5711.400302968129;5907.822765316875;5914.467697907209;5925.022371308686;5928.318243402064;5572.3034620672415;5715;5787.392323806108;5798.15926690619;5798.304203495608;5477.643953143192;5608.130739735348;5612.326520817364;5633.042382795016;5634.943650563442;3908.8241029154324;3953.4069889516804;3957.485526881487;3960.5247370315747;3961.742486738353;5845.152452894392;5865.5600829937075;5887;5894.734736936934;5897.67562784051;5478;5615.101583746581;5641.802536911188;5647.124695672177;5652.830415087554;5608.074667679787;5613.915791263053;5618.438156184349;5620.241267429008;5644.604877658689;5523.834284971457;5535.723213839373;5536.114221724505;5536.335639723098;5536.390996990247;5563.77744890216;5681.829545113653;5685.175649530712;5685.971570142288;5702.572307076903;5497.725113744376;5499.120140777456;5512.91730624033;5518.061929471919;5520.613557050968 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: |5;yui.html;759.8366351234486;767.919368466311;769.6267310354478;784.9293563579276;801.6512816924635;12990.935045324772;13075.280859552744;13082.411291491882;13091.93454032731;13127.277999710024;12895.09734318598;12935.094543381967;13023.934880325609;13032.478700851954;13036.543720969768;602.0517684646677;612;741.3957624535985;748.2891253309377;749.763824395315;753.3220101908299;756.156885073145;760.5170716594974;767.3477544087536;768.0476209500207;810.7081450677751;817.342039658078;817.8650522663753;818.0919179710517;818.4148333941231;627.7802769030849;633.7369991453542;634.2895956528718;634.7683095670093;812.0417906869891;464.324407986379;571.7512881896388;578.6181120460518;580.5732786401991;581.4824805922732;11534.134939879543;11628.011619012394;11676.299422034705;11873.228240164362;11964.70088247792;9249;9294.581743821476;9335.299852511089;9614.579804300587;9636.90363096367;8965.731028069169;9110.116951523141;9177;9424.528773561295;9513.191378732816;2849.586809912551;2869.368738877444;2904.2158617173454;2906.070057581575;2967.0802051364144;39507.20985580272;39535.40696889549;39651.60348396508;39850.60149398469;40015.19969600592;6686.598804071771;6778.322957159544;6901.965490172617;6918.930810691829;6925.203601585882;10993.725156871142;10998.395088270221;11004.229703920648;11011.559537618567;11020.44897755109;5554.888902221933;5561.277033985556;5561.388247292794;5647.209390685307;5734.340550836624;3432.845521951518;3587.820608969541;3630.673239408413;3661.5056967309606;3668.211334563082;2418.975810241875;2454.312792418126;2454.5827209374447;2455.72986971433;2457.103157347555;375.2569911575097;377.57899941565506;378.65920671395963;379.5047463060677;382.29466634060117;463.74494028284306;515.4072816261255;576.5675743192605;588.1442501160801;594.2838879150613;7478.326950574475;7500.774976750707;7598.542663088281;8073.2734053934255;8201.95899020501;400.79359130047465;479.3959610890234;545.4518209199729;567.4694160959516;594.7739858853608;3618.819059047037;3778.017715394017;3796.6393192646656;3840.8271627776817;3846.1922996171115;48936.26595601069;53696.731516342166;53729.462705373226;54801.45198548043;55062.89874202493;45934.31098533524;46272.76863615728;47964.520354796005;48130;48657.513424866;42994.7850260753;43417.56582434135;43473.565264347584;43601.563984360386;43702;8155.429119961783;8313;8361.83276334482;8415.074341822272;8521.744347669579;32655.836720816245;32865.67134328626;32888.50667239945;32980.50529242111;33438.164045899044;36873;38133;41780.373294401215;42069.36895946624;42078.36882446827;7033.191183013814;7181.886807544839;7256.0567126273245;7286.781396558112;7333.926660733325;11449.542018319175;11636.88363116358;11645.6506304811;11695.707607309885;11955.342456164646;10556.366618002945;10783.275081931293;10816.4050977197;10901.618443354762;10978.286411383235;10587.947060264649;10782.784344313226;11234.719132021439;11251.324920504796;11262;10702.571897124028;11104.5558177672;11466.656000320003;11505.48225329879;11509.194356394972;9203.35576509638;9238.399504032217;9368.203702685349;9402.059794020543;9590.808183836423;8825.426347287406;9096.909030909606;9210.493422861808;9218.44689318643;9725.85411218818 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:31:46 INFO - 2015-11-18 07:31:46,790 DEBUG : BROWSER_OUTPUT: __startTimestamp1447860706776__endTimestamp 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4618.67 Median:4725.13 stddev:477.81 (10.1%) stddev-sans-first:454.20 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: Values: 2671.5 2739.1 2784.7 2792.9 2797.4 4547.1 4671.9 4700.5 4815.2 4841.0 4595.5 4645.7 4650.4 4653.8 4687.3 4327.7 4333.1 4350.5 4373.7 4382.6 4170.3 4348.1 4384.0 4396.4 4440.5 4111.0 4184.9 4202.2 4204.5 4294.6 4300.4 4336.3 4342.4 4356.6 4371.3 4133.6 4254.1 4322.8 4327.1 4360.9 4516.3 4562.0 4650.7 4682.6 4710.8 4985.1 5055.7 5058.8 5060.6 5095.5 4811.0 4935.3 5060.4 5078.7 5081.2 4584.7 4660.0 4725.1 4728.2 4781.5 5108.3 5108.8 5112.8 5150.7 5185.3 4661.1 4775.9 4905.7 4918.7 4945.6 4944.9 5102.8 5196.6 5207.8 5215.3 4968.9 4975.9 4980.6 4998.0 5020.9 4681.9 4830.3 4945.5 4956.9 4962.3 4052.9 4088.9 4100.3 4101.2 4122.5 3672.0 3683.0 3704.2 3704.5 3736.7 4146.5 4241.2 4349.8 4355.1 4374.2 4850.6 4933.1 5001.7 5009.5 5056.9 4302.7 4310.5 4317.3 4342.7 4383.1 4324.9 4439.7 4449.0 4457.4 4519.7 4628.8 4680.6 4699.0 4735.6 4783.2 5042.6 5059.1 5060.6 5075.4 5104.6 4642.0 4751.7 4805.3 4806.8 4837.9 4844.0 4887.6 4904.7 4912.9 4951.3 5033.4 5076.9 5094.8 5100.1 5147.0 4617.5 4741.1 4899.2 4911.4 4942.8 4689.6 4728.9 4797.5 4800.3 4813.0 4807.5 4845.1 4864.5 4869.2 4894.5 4575.4 4975.1 4976.6 4982.8 5021.8 4641.6 4670.8 4689.6 4816.4 4821.9 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,791 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37852.00 Median:16615.89 stddev:57199.09 (344.2%) stddev-sans-first:57291.00 07:31:46 INFO - 2015-11-18 07:31:46,793 DEBUG : BROWSER_OUTPUT: Values: 558.9 568.4 569.9 581.5 591.6 24720.0 33929.0 34642.5 34719.3 34746.0 39368.0 39904.6 39912.0 39990.8 40049.2 6985.1 7072.7 8020.5 8205.0 8205.1 10162.8 10415.5 10430.6 10433.3 10442.8 10261.3 10312.3 10323.6 10372.5 10373.3 7166.9 7323.5 7333.4 7344.2 10207.1 7027.2 10334.9 10644.7 10661.6 10664.6 37325.4 37415.4 37549.0 37658.6 37844.4 2779.1 2829.4 2845.6 2857.2 3442.3 28191.2 28393.3 28646.6 28678.9 28824.0 2940.5 2963.9 2974.7 3009.2 3074.4 217596.0 217807.0 217899.0 218438.0 218936.0 45864.8 46518.5 52758.0 53106.2 59367.4 53803.0 54183.7 54216.0 54225.5 54249.7 12911.7 13050.3 13125.3 13131.9 13140.3 9467.0 9493.1 9508.4 9511.8 9513.7 18087.9 18351.7 18358.2 18377.4 18498.9 7175.9 7430.0 7448.5 7455.7 7525.2 796.4 818.9 867.4 881.5 961.9 26133.0 26287.3 26583.6 26637.7 26654.0 889.0 896.2 912.9 930.1 933.8 12403.0 12477.6 12612.6 12649.0 14156.9 203778.0 206121.0 206955.0 207385.0 207944.0 42379.4 42728.0 42840.6 42894.6 43018.4 1101.0 1103.7 1140.6 1153.0 1154.5 21658.6 24428.5 24547.0 27625.3 27859.0 40418.8 40853.4 40924.0 40931.2 40954.4 211895.0 212580.0 212649.0 213212.0 311206.0 24091.3 28646.9 29015.6 29351.7 29422.0 33872.7 34388.8 34510.8 34521.7 34771.8 29425.1 29560.9 29810.9 29835.9 32828.7 30222.5 30778.4 31663.7 32475.7 33094.5 32336.5 32755.2 32981.7 32983.3 33050.0 28140.3 29423.4 29942.4 30088.8 30570.0 21961.8 22788.2 22798.5 22869.8 23108.3 07:31:46 INFO - 2015-11-18 07:31:46,793 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,793 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23590.19 Median:4526.38 stddev:77900.22 (1721.0%) stddev-sans-first:78099.12 07:31:46 INFO - 2015-11-18 07:31:46,793 DEBUG : BROWSER_OUTPUT: Values: 302.6 309.4 310.2 311.5 318.3 12417.9 12811.7 14955.6 15351.2 15416.0 13040.3 14501.3 15267.8 15809.3 15844.8 4312.0 4436.5 4446.6 4841.6 4974.8 3161.5 3242.5 4410.5 4427.9 4432.2 4400.8 4486.2 4521.8 4524.7 4528.3 4206.4 4492.6 4493.5 4495.8 4499.4 3961.6 3973.2 3976.1 3979.6 3982.2 10897.5 11009.4 11044.3 11132.7 11285.9 1587.6 1651.0 1714.4 1764.6 1765.2 8434.2 8470.4 8607.4 8624.0 8666.4 1617.4 1708.9 1714.8 1721.6 1775.7 45393.5 46269.0 46448.3 46966.3 47593.5 6064.1 6083.4 6148.2 6167.3 6179.9 7037.6 7039.6 7049.8 7063.1 7064.8 4531.0 4536.0 4557.4 4576.3 4578.5 4528.0 4595.0 4607.2 4633.4 4638.3 2771.7 2801.6 2805.0 2825.0 2828.3 1026.8 1033.5 1033.8 1046.7 1099.8 324.2 340.7 390.9 397.7 406.5 9958.4 10376.0 10415.4 10694.1 10751.6 347.5 379.2 386.6 427.4 435.4 5185.4 5377.8 5399.1 5453.3 5717.5 462082.0 472907.0 477838.0 482391.0 483040.0 65184.7 65761.7 65972.0 66078.7 67086.3 468.2 472.4 475.6 478.0 478.2 9411.8 9482.8 9549.2 9566.3 9574.8 30458.5 31585.2 32021.2 32146.4 32398.5 42108.0 42142.6 42730.8 42872.6 43531.3 5853.9 5876.7 5964.1 5997.3 6048.3 10590.7 10766.3 10873.8 10877.3 10901.3 9116.1 9282.3 9356.5 9688.3 9704.1 9214.4 9436.6 9526.3 9655.4 9719.6 9567.3 9592.9 9764.9 9770.6 9981.8 5322.9 5339.5 5346.2 5422.2 5422.5 8708.0 9018.8 9190.3 9436.5 9450.1 07:31:46 INFO - 2015-11-18 07:31:46,794 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,794 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4666.37 Median:5805.11 stddev:2363.62 (40.7%) stddev-sans-first:2357.66 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: Values: 1421.1 1615.5 1671.9 1683.6 1698.0 5624.0 5892.8 6457.0 6634.4 6669.8 6589.6 6673.4 6706.9 6709.3 6724.4 1917.7 1934.5 1935.4 1939.7 1940.2 1949.1 1960.6 1966.8 1976.9 1987.3 1945.1 1951.9 1953.8 1958.3 1959.9 1921.3 1947.4 1953.3 1953.7 1953.9 1832.9 1857.9 1860.9 1864.3 1864.6 5487.4 6637.0 6681.2 6692.5 6700.0 3439.8 3848.7 3950.1 3960.2 3966.8 2620.2 2636.0 2686.9 2689.2 2730.7 844.7 849.4 1665.3 1682.8 1712.3 8966.6 9099.2 9144.3 9159.1 9160.4 3543.7 3570.5 3606.0 3615.0 3621.5 7492.4 7496.7 7497.7 7504.1 7506.1 4048.6 4069.9 4073.8 4076.9 4079.2 3768.5 3778.1 3778.4 3779.0 3782.8 2940.8 2957.6 2961.0 2964.5 2979.3 858.4 859.5 860.3 860.9 863.9 896.8 946.0 1137.2 1160.0 1166.6 6492.1 6517.0 6530.0 6545.7 6553.2 1009.6 1018.2 1021.5 1030.3 1052.1 4553.2 4835.3 4865.2 4867.3 4874.9 6697.5 7691.5 7909.2 7916.7 8003.6 7820.4 7883.2 7891.1 7898.6 7910.3 6188.8 6445.3 6450.4 6453.4 6473.1 6166.8 6181.4 6190.4 6197.8 6201.5 7085.2 7132.1 7264.5 7281.3 7289.4 7235.7 7341.7 7428.8 7524.5 7530.0 5637.1 5646.4 5669.6 5701.3 5706.1 5956.7 5956.7 5987.0 5989.3 6043.8 5969.5 6005.5 6123.3 6242.3 6243.6 5997.9 6033.5 6055.8 6059.2 6173.6 5987.7 5998.1 6001.1 6187.8 6220.6 5720.3 5747.2 5747.5 5754.9 5760.7 5765.6 5784.2 5786.7 5823.6 5841.4 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4674.53 Median:5369.45 stddev:1393.24 (25.9%) stddev-sans-first:1357.55 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: Values: 280.2 285.7 290.6 290.6 293.0 5142.9 5294.9 5406.9 5459.8 5475.2 5218.4 5328.5 5364.0 5367.2 5371.7 4109.3 4124.4 4125.9 4131.7 4131.9 3901.8 3996.4 3997.0 4103.2 4104.4 4067.2 4074.5 4092.6 4107.3 4112.5 4091.2 4104.4 4104.6 4107.1 4108.6 3582.9 3586.3 3586.4 3591.3 3594.3 5074.9 5181.0 5195.1 5196.8 5202.1 4726.9 4727.6 4736.5 4739.5 4741.0 5641.4 5649.7 5651.6 5654.5 5657.5 3718.9 3796.9 3846.7 3904.2 3913.2 5937.9 5948.5 5956.9 5965.6 5972.0 4031.4 4034.5 4035.4 4035.5 4040.3 4089.4 4094.5 4094.7 4095.9 4103.5 4616.7 4703.5 4720.1 4720.4 4724.2 5634.9 5666.6 5669.4 5671.5 5680.2 1425.1 1442.3 1443.2 1444.2 1445.3 940.0 957.5 968.4 978.9 981.7 4942.3 4943.5 4949.4 4954.3 4960.7 5833.7 5837.4 5844.1 5847.4 5848.2 4936.4 4946.1 4952.3 4952.4 4953.7 3053.8 3114.4 3142.7 3147.3 3152.5 5585.1 5615.2 5621.5 5622.6 5624.2 6063.8 6066.2 6066.2 6074.2 6076.3 5602.4 5607.4 5608.7 5651.3 5653.1 5711.4 5907.8 5914.5 5925.0 5928.3 5572.3 5715.0 5787.4 5798.2 5798.3 5477.6 5608.1 5612.3 5633.0 5634.9 3908.8 3953.4 3957.5 3960.5 3961.7 5845.2 5865.6 5887.0 5894.7 5897.7 5478.0 5615.1 5641.8 5647.1 5652.8 5608.1 5613.9 5618.4 5620.2 5644.6 5523.8 5535.7 5536.1 5536.3 5536.4 5563.8 5681.8 5685.2 5686.0 5702.6 5497.7 5499.1 5512.9 5518.1 5520.6 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12277.03 Median:24221.96 stddev:14555.67 (60.1%) stddev-sans-first:14570.81 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: Values: 759.8 767.9 769.6 784.9 801.7 12990.9 13075.3 13082.4 13091.9 13127.3 12895.1 12935.1 13023.9 13032.5 13036.5 602.1 612.0 741.4 748.3 749.8 753.3 756.2 760.5 767.3 768.0 810.7 817.3 817.9 818.1 818.4 627.8 633.7 634.3 634.8 812.0 464.3 571.8 578.6 580.6 581.5 11534.1 11628.0 11676.3 11873.2 11964.7 9249.0 9294.6 9335.3 9614.6 9636.9 8965.7 9110.1 9177.0 9424.5 9513.2 2849.6 2869.4 2904.2 2906.1 2967.1 39507.2 39535.4 39651.6 39850.6 40015.2 6686.6 6778.3 6902.0 6918.9 6925.2 10993.7 10998.4 11004.2 11011.6 11020.4 5554.9 5561.3 5561.4 5647.2 5734.3 3432.8 3587.8 3630.7 3661.5 3668.2 2419.0 2454.3 2454.6 2455.7 2457.1 375.3 377.6 378.7 379.5 382.3 463.7 515.4 576.6 588.1 594.3 7478.3 7500.8 7598.5 8073.3 8202.0 400.8 479.4 545.5 567.5 594.8 3618.8 3778.0 3796.6 3840.8 3846.2 48936.3 53696.7 53729.5 54801.5 55062.9 45934.3 46272.8 47964.5 48130.0 48657.5 42994.8 43417.6 43473.6 43601.6 43702.0 8155.4 8313.0 8361.8 8415.1 8521.7 32655.8 32865.7 32888.5 32980.5 33438.2 36873.0 38133.0 41780.4 42069.4 42078.4 7033.2 7181.9 7256.1 7286.8 7333.9 11449.5 11636.9 11645.7 11695.7 11955.3 10556.4 10783.3 10816.4 10901.6 10978.3 10587.9 10782.8 11234.7 11251.3 11262.0 10702.6 11104.6 11466.7 11505.5 11509.2 9203.4 9238.4 9368.2 9402.1 9590.8 8825.4 9096.9 9210.5 9218.4 9725.9 07:31:46 INFO - 2015-11-18 07:31:46,795 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:31:46 INFO - 2015-11-18 07:31:46,796 DEBUG : BROWSER_OUTPUT: 07:31:47 INFO - 2015-11-18 07:31:47,559 INFO : Browser exited with error code: 0 07:31:47 INFO - 2015-11-18 07:31:47,577 INFO : Completed test dromaeo_css (00:18:38) 07:31:47 INFO - 2015-11-18 07:31:47,577 INFO : Starting test kraken 07:31:47 INFO - 2015-11-18 07:31:47,577 DEBUG : operating with platform_type : linux_ 07:31:47 INFO - 2015-11-18 07:31:47,578 INFO : Initialising browser for kraken test... 07:31:47 INFO - 2015-11-18 07:31:47,584 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfucbgq/profile http://localhost:43903/getInfo.html 07:31:51 INFO - 2015-11-18 07:31:51,820 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:31:51 INFO - 2015-11-18 07:31:51,820 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:31:51 INFO - 2015-11-18 07:31:51,820 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:31:51 INFO - 2015-11-18 07:31:51,820 DEBUG : BROWSER_OUTPUT: __metrics 07:31:51 INFO - 2015-11-18 07:31:51,965 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:53 INFO - 2015-11-18 07:31:53,204 INFO : Browser initialized. 07:31:53 INFO - 2015-11-18 07:31:53,204 INFO : Running cycle 1/1 for kraken test... 07:31:53 INFO - 2015-11-18 07:31:53,205 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfucbgq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:32:05 INFO - 2015-11-18 07:32:05,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 07:32:05 INFO - 2015-11-18 07:32:05,165 DEBUG : BROWSER_OUTPUT: 07:32:07 INFO - 2015-11-18 07:32:07,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43903/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:08 INFO - 2015-11-18 07:32:08,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 178065408 07:32:08 INFO - 2015-11-18 07:32:08,355 DEBUG : BROWSER_OUTPUT: 07:32:11 INFO - 2015-11-18 07:32:11,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43903/tests/kraken/driver.html?testName=audio-dft) 07:32:11 INFO - 2015-11-18 07:32:11,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 168845312 07:32:11 INFO - 2015-11-18 07:32:11,659 DEBUG : BROWSER_OUTPUT: 07:32:14 INFO - 2015-11-18 07:32:14,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43903/tests/kraken/driver.html?testName=audio-fft) 07:32:15 INFO - 2015-11-18 07:32:15,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 152334336 07:32:15 INFO - 2015-11-18 07:32:15,271 DEBUG : BROWSER_OUTPUT: 07:32:17 INFO - 2015-11-18 07:32:17,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43903/tests/kraken/driver.html?testName=audio-oscillator) 07:32:17 INFO - 2015-11-18 07:32:17,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 154812416 07:32:17 INFO - 2015-11-18 07:32:17,861 DEBUG : BROWSER_OUTPUT: 07:32:20 INFO - 2015-11-18 07:32:20,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:20 INFO - 2015-11-18 07:32:20,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 157327360 07:32:20 INFO - 2015-11-18 07:32:20,686 DEBUG : BROWSER_OUTPUT: 07:32:23 INFO - 2015-11-18 07:32:23,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43903/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:24 INFO - 2015-11-18 07:32:24,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 156909568 07:32:24 INFO - 2015-11-18 07:32:24,272 DEBUG : BROWSER_OUTPUT: 07:32:27 INFO - 2015-11-18 07:32:27,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43903/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:28 INFO - 2015-11-18 07:32:28,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 156786688 07:32:28 INFO - 2015-11-18 07:32:28,308 DEBUG : BROWSER_OUTPUT: 07:32:31 INFO - 2015-11-18 07:32:31,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43903/tests/kraken/driver.html?testName=json-parse-financial) 07:32:31 INFO - 2015-11-18 07:32:31,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 158105600 07:32:32 INFO - 2015-11-18 07:32:31,708 DEBUG : BROWSER_OUTPUT: 07:32:33 INFO - 2015-11-18 07:32:33,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:34 INFO - 2015-11-18 07:32:34,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 166985728 07:32:34 INFO - 2015-11-18 07:32:34,045 DEBUG : BROWSER_OUTPUT: 07:32:35 INFO - 2015-11-18 07:32:35,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:36 INFO - 2015-11-18 07:32:36,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 167600128 07:32:36 INFO - 2015-11-18 07:32:36,521 DEBUG : BROWSER_OUTPUT: 07:32:38 INFO - 2015-11-18 07:32:38,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:39 INFO - 2015-11-18 07:32:39,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 175300608 07:32:39 INFO - 2015-11-18 07:32:39,239 DEBUG : BROWSER_OUTPUT: 07:32:41 INFO - 2015-11-18 07:32:41,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:42 INFO - 2015-11-18 07:32:42,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 182374400 07:32:42 INFO - 2015-11-18 07:32:42,375 DEBUG : BROWSER_OUTPUT: 07:32:45 INFO - 2015-11-18 07:32:45,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:45 INFO - 2015-11-18 07:32:45,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 179621888 07:32:45 INFO - 2015-11-18 07:32:45,606 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43903/tests/kraken/driver.html?testName=ai-astar) 07:32:47 INFO - 2015-11-18 07:32:47,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 239566848 07:32:47 INFO - 2015-11-18 07:32:47,625 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,628 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:32:47 INFO - 2015-11-18 07:32:47,628 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:32:47 INFO - 2015-11-18 07:32:47,628 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:32:47 INFO - 2015-11-18 07:32:47,628 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;110;113;112;113;121;113;112;112;113 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;132;155;168;131;156;154;135;167;132 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;162;160;161;159;162;162;160;162 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;78;92;73;73;73;99;91;74 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;129;91;93;93;139;93;93;130 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;111;111;110;109 07:32:47 INFO - 2015-11-18 07:32:47,629 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;149;149;149;148;148;148 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;96;95;95;95;95 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;79;73;74;72;72;73;72;81;71;70 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;70;70;70;70;71;70;70;70 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;94;84;85;83;83;85;84 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;128;129;117;131;131;121;129;133;129 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;141;154;150;152;139;152;151;152;143 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;69;71;71;72;69;70;69;68;68 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:32:47 INFO - 2015-11-18 07:32:47,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 07:32:47 INFO - 2015-11-18 07:32:47,631 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:32:47 INFO - 2015-11-18 07:32:47,631 DEBUG : BROWSER_OUTPUT: __startTimestamp1447860767626__endTimestamp 07:32:47 INFO - 2015-11-18 07:32:47,631 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:2.95 (2.6%) stddev-sans-first:3.07 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: Values: 115.0 110.0 113.0 112.0 113.0 121.0 113.0 112.0 112.0 113.0 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.50 stddev:14.47 (9.4%) stddev-sans-first:15.33 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: Values: 150.0 132.0 155.0 168.0 131.0 156.0 154.0 135.0 167.0 132.0 07:32:47 INFO - 2015-11-18 07:32:47,634 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.74 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 162.0 160.0 161.0 159.0 162.0 162.0 160.0 162.0 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:76.00 stddev:9.92 (13.0%) stddev-sans-first:10.27 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 78.0 92.0 73.0 73.0 73.0 99.0 91.0 74.0 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:93.00 stddev:19.55 (21.0%) stddev-sans-first:20.20 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 129.0 91.0 93.0 93.0 139.0 93.0 93.0 130.0 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 109.0 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 149.0 149.0 149.0 148.0 148.0 148.0 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,635 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:73.00 stddev:3.53 (4.8%) stddev-sans-first:3.18 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: Values: 79.0 73.0 74.0 72.0 72.0 73.0 72.0 81.0 71.0 70.0 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 70.0 70.0 70.0 71.0 70.0 70.0 70.0 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:3.25 (3.8%) stddev-sans-first:3.35 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 94.0 84.0 85.0 83.0 83.0 85.0 84.0 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:4.88 (3.8%) stddev-sans-first:5.17 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: Values: 128.0 128.0 129.0 117.0 131.0 131.0 121.0 129.0 133.0 129.0 07:32:47 INFO - 2015-11-18 07:32:47,636 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:152.00 stddev:5.83 (3.8%) stddev-sans-first:5.61 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: Values: 156.0 141.0 154.0 150.0 152.0 139.0 152.0 151.0 152.0 143.0 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.70 (2.4%) stddev-sans-first:1.41 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: Values: 73.0 69.0 71.0 71.0 72.0 69.0 70.0 69.0 68.0 68.0 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:32:47 INFO - 2015-11-18 07:32:47,637 DEBUG : BROWSER_OUTPUT: 07:32:48 INFO - 2015-11-18 07:32:48,543 INFO : Browser exited with error code: 0 07:32:48 INFO - 2015-11-18 07:32:48,591 INFO : Completed test kraken (00:01:01) 07:32:48 INFO - 2015-11-18 07:32:48,591 INFO : Starting test v8_7 07:32:48 INFO - 2015-11-18 07:32:48,592 DEBUG : operating with platform_type : linux_ 07:32:48 INFO - 2015-11-18 07:32:48,592 INFO : Initialising browser for v8_7 test... 07:32:48 INFO - 2015-11-18 07:32:48,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdv1sl/profile http://localhost:43903/getInfo.html 07:32:52 INFO - 2015-11-18 07:32:52,784 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:32:52 INFO - 2015-11-18 07:32:52,785 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:32:52 INFO - 2015-11-18 07:32:52,785 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:32:52 INFO - 2015-11-18 07:32:52,785 DEBUG : BROWSER_OUTPUT: __metrics 07:32:52 INFO - 2015-11-18 07:32:52,901 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:54 INFO - 2015-11-18 07:32:54,117 INFO : Browser initialized. 07:32:54 INFO - 2015-11-18 07:32:54,118 INFO : Running cycle 1/1 for v8_7 test... 07:32:54 INFO - 2015-11-18 07:32:54,118 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdv1sl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:33:06 INFO - 2015-11-18 07:33:06,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 07:33:06 INFO - 2015-11-18 07:33:06,007 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43903/tests/v8_7/run.html (next: http://localhost:43903/tests/v8_7/run.html) 07:33:27 INFO - 2015-11-18 07:33:27,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 437694464 07:33:27 INFO - 2015-11-18 07:33:27,714 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,714 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:33:27 INFO - 2015-11-18 07:33:27,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |0;Richards;163.05233980107616 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.26591760299627 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 07:33:27 INFO - 2015-11-18 07:33:27,715 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2018.1451612903227 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: |8;Splay;626.4760720944686 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:33:27 INFO - 2015-11-18 07:33:27,716 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: __startTimestamp1447860807712__endTimestamp 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,717 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.05 Median:163.05 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,718 DEBUG : BROWSER_OUTPUT: Values: 163.1 07:33:27 INFO - 2015-11-18 07:33:27,718 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,719 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.27 Median:187.27 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,719 DEBUG : BROWSER_OUTPUT: Values: 187.3 07:33:27 INFO - 2015-11-18 07:33:27,719 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,719 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: Values: 279.1 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: Values: 5045.2 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,720 DEBUG : BROWSER_OUTPUT: Values: 2018.1 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: Values: 794.3 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: Values: 12132.5 07:33:27 INFO - 2015-11-18 07:33:27,721 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: Values: 27216.2 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.48 Median:626.48 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: Values: 626.5 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:33:27 INFO - 2015-11-18 07:33:27,722 DEBUG : BROWSER_OUTPUT: 07:33:28 INFO - 2015-11-18 07:33:28,651 INFO : Browser exited with error code: 0 07:33:28 INFO - 2015-11-18 07:33:28,663 INFO : Completed test v8_7 (00:00:40) 07:33:28 INFO - 2015-11-18 07:33:28,710 INFO : Completed test suite (00:20:19) 07:33:28 INFO - 2015-11-18 07:33:28,710 DEBUG : Working with test: dromaeo_css 07:33:28 INFO - 2015-11-18 07:33:28,710 DEBUG : Generating results file: dromaeo_css 07:33:28 INFO - 2015-11-18 07:33:28,711 DEBUG : Working with test: kraken 07:33:28 INFO - 2015-11-18 07:33:28,711 DEBUG : Generating results file: kraken 07:33:28 INFO - 2015-11-18 07:33:28,712 INFO : javascript benchmark 07:33:28 INFO - 2015-11-18 07:33:28,712 DEBUG : Working with test: v8_7 07:33:28 INFO - 2015-11-18 07:33:28,712 DEBUG : Generating results file: v8_7 07:33:28 INFO - 2015-11-18 07:33:28,712 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:28 INFO - 2015-11-18 07:33:28,774 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 07:33:28 INFO - 2015-11-18 07:33:28,775 DEBUG : process_Request line: dromaeo_css 5872.02 graph.html#tests=[[72,94,35]] 07:33:28 INFO - 2015-11-18 07:33:28,775 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:28 INFO - 2015-11-18 07:33:28,803 DEBUG : process_Request line: kraken 1537.10 graph.html#tests=[[232,94,35]] 07:33:28 INFO - 2015-11-18 07:33:28,804 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:33:28 INFO - 2015-11-18 07:33:28,831 DEBUG : process_Request line: v8_7 19752.46 graph.html#tests=[[230,94,35]] 07:33:28 INFO - 2015-11-18 07:33:28,833 INFO : javascript benchmark 07:33:28 INFO - 2015-11-18 07:33:28,836 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2671.465706858628, 2739.055026016026, 2784.7215278472154, 2792.8882844686214, 2797.3566079801644, 4547.067851090526, 4671.883202919925, 4700.506446823086, 4815.181419158743, 4841.0, 4595.494495605489, 4645.721256724599, 4650.395448591678, 4653.8371157009515, 4687.296905464182, 4327.6754243431715, 4333.1117120990275, 4350.477942646879, 4373.671974601902, 4382.649388048964, 4170.311898536738, 4348.108637729258, 4383.956160438387, 4396.384506169139, 4440.489343725464, 4111.0, 4184.895377615553, 4202.222588821078, 4204.474440694913, 4294.570542945712, 4300.440942677463, 4336.284513055342, 4342.435483387171, 4356.586124318184, 4371.34429835524, 4133.648639865615, 4254.106637606106, 4322.783860806947, 4327.0913108247305, 4360.934585981213, 4516.299973504112, 4562.041971186021, 4650.674452788307, 4682.578567928868, 4710.811567537295, 4985.102681517325, 5055.69665820052, 5058.848234552969, 5060.569851562622, 5095.464976177522, 4810.951890481086, 4935.259711043336, 5060.367454068241, 5078.7460626968505, 5081.237814327844, 4584.6561507887045, 4660.021395506948, 4725.125851717443, 4728.196206644879, 4781.450133234653, 5108.2848401223855, 5108.770105345268, 5112.821051263188, 5150.665206761549, 5185.274061631375, 4661.137689527448, 4775.904481910342, 4905.701732537655, 4918.729469879119, 4945.604351651859, 4944.8763780905765, 5102.8214012510125, 5196.558292545176, 5207.843764687065, 5215.348081489814, 4968.925466118011, 4975.875603109951, 4980.551750342414, 4997.9750101249265, 5020.874478138003, 4681.9297710534365, 4830.275458681155, 4945.455999840015, 4956.851294461172, 4962.280469331927, 4052.878413647595, 4088.9386659200136, 4100.2619528484565, 4101.200265948171, 4122.546519882811, 3671.963280367162, 3682.963170368262, 3704.2221133562252, 3704.5369328833895, 3736.7384283100464, 4146.543880173179, 4241.151769646083, 4349.782510874444, 4355.0854320593035, 4374.234508960983, 4850.611951043908, 4933.062718083553, 5001.699898006132, 5009.5491405773655, 5056.873578160502, 4302.677299202573, 4310.547392523803, 4317.266064768997, 4342.6742994275555, 4383.123375324948, 4324.891877703019, 4439.689221754446, 4449.0, 4457.353683715908, 4519.706219095814, 4628.768561571908, 4680.555347242007, 4698.9530104698515, 4735.644826637947, 4783.210770222944, 5042.647014708935, 5059.114654935445, 5060.620453465931, 5075.390953085654, 5104.617153713561, 4641.976790116163, 4751.714897106184, 4805.303231031551, 4806.759662016955, 4837.879053023562, 4843.975780121077, 4887.560119589254, 4904.6566740327835, 4912.901741965212, 4951.282064100613, 5033.421156566895, 5076.898462030813, 5094.7962081516325, 5100.081985242544, 5147.0, 4617.492075871719, 4741.075490279362, 4899.16714158601, 4911.435184953776, 4942.82700105509, 4689.648276379354, 4728.929066064081, 4797.496262892346, 4800.279958006327, 4813.03739252144, 4807.519248075165, 4845.1278769820365, 4864.489228630943, 4869.220924652039, 4894.4616092230535, 4575.405197324327, 4975.129352363394, 4976.552110310089, 4982.775775090057, 5021.824236151717, 4641.582257596832, 4670.813167473263, 4689.601383882408, 4816.446108697404, 4821.879453013562], "unit": "ms", "name": "dojo.html", "value": 4590.068946150037}, {"lowerIsBetter": false, "replicates": [558.9133684278936, 568.4344077642745, 569.9487046165845, 581.5289615411517, 591.6479694581723, 24719.999999999978, 33928.98213053609, 34642.480362794515, 34719.30561388771, 34746.0, 39368.0, 39904.60095399045, 39912.0, 39990.8000459998, 40049.199016019666, 6985.091938048046, 7072.6817293221675, 8020.478668886532, 8204.958975205116, 8205.138460461625, 10162.796744065114, 10415.479226038706, 10430.63492777753, 10433.321834080798, 10442.843357349646, 10261.281710280284, 10312.278140530167, 10323.638672646459, 10372.481375931173, 10373.325733827314, 7166.892496612581, 7323.48735588509, 7333.449991250677, 7344.228855970099, 10207.13239374654, 7027.191872934627, 10334.896651033469, 10644.680659580225, 10661.626843060532, 10664.573417063308, 37325.44011839825, 37415.4387684185, 37549.0, 37658.62341376606, 37844.43233351474, 2779.0551212587616, 2829.363393236526, 2845.6300680911554, 2857.171420288114, 3442.277121804424, 28191.15426537207, 28393.290167745767, 28646.570301445496, 28678.856605717046, 28824.0, 2940.5148150555133, 2963.9110826675233, 2974.6876577959433, 3009.232645675361, 3074.446599612069, 217596.0, 217807.0, 217899.0, 218438.0, 218936.0, 45864.77067614641, 46518.53481465142, 52758.0, 53106.203406948924, 59367.40632593619, 53803.0, 54183.729081354344, 54216.0, 54225.45774542283, 54249.72875135599, 12911.677208069874, 13050.34748262602, 13125.278109704059, 13131.868681313064, 13140.27728474924, 9466.95266523663, 9493.050694930589, 9508.38195517303, 9511.809763804686, 9513.714588562354, 18087.909560452114, 18351.724724129148, 18358.173882175335, 18377.356792512197, 18498.907505462386, 7175.89236161458, 7430.0, 7448.478606497493, 7455.701771929171, 7525.172231054579, 796.3509739562238, 818.8648872936018, 867.4318321499428, 881.5195718333524, 961.8797650293714, 26133.0, 26287.34281642936, 26583.601245981325, 26637.733622663527, 26654.0, 888.9555522223862, 896.1620884472908, 912.9497877616794, 930.0559931669361, 933.8319102561468, 12403.0, 12477.625671229878, 12612.55856045034, 12649.0, 14156.85843141576, 203778.0, 206121.0, 206955.0, 207385.0, 207944.0, 42379.364309535384, 42728.0, 42840.57159428428, 42894.57105428906, 43018.35472467916, 1101.0255923507752, 1103.690966529373, 1140.5551834784276, 1152.9680935562624, 1154.509333533245, 21658.566828663024, 24428.51142977166, 24547.0, 27625.309367265978, 27859.0, 40418.79790601028, 40853.38719919263, 40924.0, 40931.18137637171, 40954.385684215355, 211895.0, 212580.0, 212649.0, 213212.0, 311206.0, 24091.27726168218, 28646.85676571604, 29015.564766528096, 29351.706482934896, 29422.0, 33872.66127338695, 34388.82805586056, 34510.82744586261, 34521.65478345184, 34771.82614086913, 29425.11724648264, 29560.852195738884, 29810.850945745133, 29835.850820745756, 32828.67171328256, 30222.54666179965, 30778.384432311675, 31663.683363166074, 32475.675243247264, 33094.50358244676, 32336.514952276204, 32755.181120472178, 32981.67018329786, 32983.34033319368, 33050.0, 28140.296492587848, 29423.411531769674, 29942.401151977276, 30088.84955575208, 30570.0, 21961.780382195975, 22788.202412915467, 22798.518096323685, 22869.771302286765, 23108.306750797503], "unit": "ms", "name": "ext.html", "value": 16454.88157515044}, {"lowerIsBetter": false, "replicates": [302.5522227103886, 309.3951325159315, 310.21515565618967, 311.4798286860942, 318.32673894712684, 12417.937910310437, 12811.679708007281, 14955.626109347259, 15351.155686437241, 15416.0, 13040.347982600855, 14501.274936253198, 15267.847321526782, 15809.288582013809, 15844.76232856508, 4312.0, 4436.534163912791, 4446.599806017458, 4841.564259216679, 4974.751262436864, 3161.5415764714216, 3242.4649932761067, 4410.536893626171, 4427.911441771163, 4432.20220360335, 4400.845970391037, 4486.1700585391645, 4521.819127234923, 4524.728516289017, 4528.343390208434, 4206.390073439334, 4492.595666390024, 4493.505714371417, 4495.775211239441, 4499.392582001437, 3961.6038396160443, 3973.2252210818615, 3976.08550033491, 3979.641832235113, 3982.183652351261, 10897.509612067475, 11009.394483303415, 11044.282121662067, 11132.666020019413, 11285.887141128647, 1587.618971446856, 1650.991745041279, 1714.4085290574733, 1764.6117854072083, 1765.1527266911826, 8434.24091831732, 8470.449420787629, 8607.39748217625, 8623.956880215621, 8666.39335246533, 1617.385393550455, 1708.8803783735143, 1714.7685062516525, 1721.614100648977, 1775.6537475192342, 45393.54606453926, 46269.0, 46448.3032754509, 46966.29550556745, 47593.5240647596, 6064.120702498113, 6083.422074902877, 6148.1699970504305, 6167.259928808572, 6179.938200618026, 7037.612931288726, 7039.612821294775, 7049.753258636026, 7063.081799366049, 7064.7527336544, 4530.954690453119, 4535.9773201133785, 4557.430321209848, 4576.313552967082, 4578.5421457853945, 4528.02647430804, 4595.0, 4607.170709272296, 4633.374494443207, 4638.304254361805, 2771.722827717212, 2801.579763035561, 2804.9859750701116, 2824.997126020274, 2828.250513613894, 1026.8459731040255, 1033.5194134727237, 1033.7622346860264, 1046.6598355534481, 1099.8130317845985, 324.1765914576948, 340.664743185465, 390.94917660703925, 397.6619873107893, 406.46752753892497, 9958.402495850272, 10376.0, 10415.427151506588, 10694.144468442506, 10751.623693170857, 347.4909257937134, 379.249086808116, 386.6114554872335, 427.446456838395, 435.44915681662724, 5185.429602743695, 5377.838664840061, 5399.1091469907815, 5453.291072160673, 5717.485426311652, 462082.0, 472907.0, 477838.0, 482391.0, 483040.0, 65184.674076629315, 65761.67119164373, 65972.0, 66078.66960665262, 67086.32913670801, 468.2017160740929, 472.3764630687528, 475.63613835415936, 478.0176736805828, 478.2014036558955, 9411.764705882408, 9482.762930926781, 9549.188318992963, 9566.330356874952, 9574.808503830023, 30458.543121853632, 31585.21036974094, 32021.199470013435, 32146.357072857943, 32398.514022290157, 42108.0, 42142.57857421387, 42730.78634606807, 42872.57127428811, 43531.347029795215, 5853.94146058551, 5876.676782776988, 5964.105384192406, 5997.280326360865, 6048.304444988883, 10590.735231619272, 10766.300190487593, 10873.836892446461, 10877.347359158475, 10901.34591924487, 9116.1339672731, 9282.257419406566, 9356.532173391439, 9688.32181747271, 9704.078112579293, 9214.44713317203, 9436.622535098519, 9526.285528585522, 9655.372400793925, 9719.56261968199, 9567.282453815853, 9592.856107158537, 9764.85352719724, 9770.609175633179, 9981.800363992534, 5322.920156197738, 5339.546138578109, 5346.224797404432, 5422.240886276003, 5422.457754224546, 8707.956460217658, 9018.774530636787, 9190.31072669539, 9436.480993545421, 9450.149486546245], "unit": "ms", "name": "jquery.html", "value": 6054.604703552804}, {"lowerIsBetter": false, "replicates": [1421.147311613033, 1615.5314958661988, 1671.8662506999433, 1683.5875210573408, 1697.9660406791857, 5623.9999999999945, 5892.764289428423, 6456.967715161423, 6634.4029037386745, 6669.799906002816, 6589.637569933664, 6673.366030227121, 6706.865862682744, 6709.261981182066, 6724.428423583989, 1917.6739954207783, 1934.5067007912962, 1935.3516571948414, 1939.679952807785, 1940.2142132436315, 1949.0547084663997, 1960.5686748915216, 1966.7934866838991, 1976.8715033522847, 1987.3044434447972, 1945.1344151852431, 1951.863369564131, 1953.794851540589, 1958.2852258925461, 1959.8726082804644, 1921.269917431374, 1947.4352437793023, 1953.2772874036555, 1953.7167110769, 1953.872998255116, 1832.9083545822655, 1857.8699491035634, 1860.9255629774793, 1864.2636158717366, 1864.645717313706, 5487.396386397493, 6637.0, 6681.198256209237, 6692.498062645321, 6699.966500167517, 3439.7592168548213, 3848.749831260987, 3950.0914789598555, 3960.2277555876617, 3966.7619942803235, 2620.2401303621928, 2635.9868200659066, 2686.9059582914506, 2689.17980016095, 2730.7405796449307, 844.7339088187201, 849.4096602861014, 1665.267282395742, 1682.8317168283197, 1712.332190445727, 8966.551672416419, 9099.1810737034, 9144.268458523302, 9159.084091590788, 9160.358774885828, 3543.7165026797793, 3570.4644303354185, 3605.9819700901853, 3615.042013866275, 3621.4748861415474, 7492.438067144877, 7496.7376141834775, 7497.66260518278, 7504.061992250969, 7506.099268087755, 4048.554658987509, 4069.8575549855614, 4073.816678249486, 4076.9184616308103, 4079.1841631673783, 3768.491253680773, 3778.112143646241, 3778.4332350147697, 3778.981105094457, 3782.7730336179916, 2940.7647388208893, 2957.600723902289, 2961.0, 2964.466396048732, 2979.3147576057627, 858.3819649852096, 859.5186695450443, 860.2644738748405, 860.9397342185987, 863.8963324400986, 896.8161526886972, 946.0208684012152, 1137.1869113583828, 1160.0255785140523, 1166.6383421139474, 6492.09110724499, 6516.967415162989, 6530.0, 6545.672716364163, 6553.213614366211, 1009.6213919780082, 1018.1752780248023, 1021.5096753558186, 1030.304544432505, 1052.074174726236, 4553.180427523078, 4835.347228124158, 4865.197242454955, 4867.318575399447, 4874.878128046827, 6697.531172817856, 7691.461597688108, 7909.24862138096, 7916.722914697958, 8003.559804210824, 7820.374370050382, 7883.172266911892, 7891.053073631201, 7898.644560994769, 7910.327622152066, 6188.752449902044, 6445.258795238514, 6450.3549645036055, 6453.354664533603, 6473.126127972758, 6166.784162554289, 6181.443670069715, 6190.350013248544, 6197.752089916353, 6201.472874805511, 7085.220625731063, 7132.108486439195, 7264.527805692613, 7281.2718728126765, 7289.4168466523615, 7235.674394652148, 7341.669624866787, 7428.777136685908, 7524.548527088174, 7530.0, 5637.126245431965, 5646.407127251579, 5669.6314739541795, 5701.258836351413, 5706.144078388275, 5956.702164891824, 5956.731947062479, 5987.042073268256, 5989.341172470938, 6043.75824967014, 5969.492593129459, 6005.519558435402, 6123.295820980644, 6242.313345531897, 6243.594166379171, 5997.940020599738, 6033.487153591994, 6055.757769689163, 6059.151718759465, 6173.629582225081, 5987.700614969322, 5998.130271110577, 6001.06983417571, 6187.783427580013, 6220.626762394271, 5720.256366672306, 5747.224124743107, 5747.48272655463, 5754.913676294943, 5760.740766665594, 5765.5675824314185, 5784.190213370048, 5786.652800831964, 5823.563232757476, 5841.386654401226], "unit": "ms", "name": "mootools.html", "value": 3890.0284826044535}, {"lowerIsBetter": false, "replicates": [280.22098565986556, 285.687172546062, 290.55980190012133, 290.6439611475942, 292.97656187505004, 5142.871428214296, 5294.947050529494, 5406.891862162759, 5459.7816087356505, 5475.151351540512, 5218.373795144578, 5328.46715328467, 5363.973180134104, 5367.221752845835, 5371.677699338043, 4109.280875846723, 4124.443200167969, 4125.855595054174, 4131.669466442692, 4131.938020929689, 3901.843926242947, 3996.400539919021, 3996.9800150999204, 4103.199876024161, 4104.42538044674, 4067.1662309226535, 4074.490688663917, 4092.6112019358116, 4107.301758701028, 4112.485939257593, 4091.2226676931587, 4104.384342348641, 4104.589541045902, 4107.137501124767, 4108.568600296956, 3582.946255806165, 3586.28274345132, 3586.4261718125235, 3591.317649646559, 3594.28114377123, 5074.923876141824, 5180.989707007135, 5195.064888320101, 5196.844094677166, 5202.14164662834, 4726.905461890743, 4727.645426592985, 4736.455307639597, 4739.502352253033, 4740.976295118502, 5641.435856414367, 5649.745761440704, 5651.5761317900915, 5654.519365853907, 5657.462541058634, 3718.9070273243115, 3796.886093417202, 3846.673032792216, 3904.2191561687778, 3913.2173565287057, 5937.881242375129, 5948.464638182628, 5956.940430595682, 5965.582409231356, 5971.970140149271, 4031.354983202732, 4034.45534852797, 4035.435039094529, 4035.4955630546183, 4040.2929487340184, 4089.386592011222, 4094.467719196485, 4094.6928980326593, 4095.877123686294, 4103.461202049231, 4616.722996620214, 4703.529647035269, 4720.079584480994, 4720.409948756405, 4724.244120940633, 5634.915476267859, 5666.603337766399, 5669.43305669438, 5671.461211184931, 5680.176374425685, 1425.1164278147407, 1442.3293168676616, 1443.2350854047372, 1444.1768192130385, 1445.262915912892, 939.9718008459757, 957.4638202606562, 968.3657204531044, 978.8531720242021, 981.6907674082784, 4942.28336891156, 4943.4809345018975, 4949.430815456197, 4954.3063971044085, 4960.677555958851, 5833.67914764692, 5837.416258374214, 5844.094165404369, 5847.356790753014, 5848.152017957457, 4936.432310284364, 4946.060248552835, 4952.257161425815, 4952.4057113146655, 4953.702777833341, 3053.7862349635757, 3114.423831591163, 3142.7485801135854, 3147.3390587976783, 3152.542881282201, 5585.106382978704, 5615.241942337814, 5621.522170615462, 5622.606417550732, 5624.156376543551, 6063.787767428207, 6066.211392518944, 6066.211392518944, 6074.179985701874, 6076.3316035236085, 5602.38373778884, 5607.4112218217315, 5608.691521966331, 5651.2935883014625, 5653.067243904874, 5711.400302968129, 5907.822765316875, 5914.467697907209, 5925.022371308686, 5928.318243402064, 5572.3034620672415, 5715.0, 5787.392323806108, 5798.15926690619, 5798.304203495608, 5477.643953143192, 5608.130739735348, 5612.326520817364, 5633.042382795016, 5634.943650563442, 3908.8241029154324, 3953.4069889516804, 3957.485526881487, 3960.5247370315747, 3961.742486738353, 5845.152452894392, 5865.5600829937075, 5887.0, 5894.734736936934, 5897.67562784051, 5478.0, 5615.101583746581, 5641.802536911188, 5647.124695672177, 5652.830415087554, 5608.074667679787, 5613.915791263053, 5618.438156184349, 5620.241267429008, 5644.604877658689, 5523.834284971457, 5535.723213839373, 5536.114221724505, 5536.335639723098, 5536.390996990247, 5563.77744890216, 5681.829545113653, 5685.175649530712, 5685.971570142288, 5702.572307076903, 5497.725113744376, 5499.120140777456, 5512.91730624033, 5518.061929471919, 5520.613557050968], "unit": "ms", "name": "prototype.html", "value": 4219.990296990133}, {"lowerIsBetter": false, "replicates": [759.8366351234486, 767.919368466311, 769.6267310354478, 784.9293563579276, 801.6512816924635, 12990.935045324772, 13075.280859552744, 13082.411291491882, 13091.93454032731, 13127.277999710024, 12895.09734318598, 12935.094543381967, 13023.934880325609, 13032.478700851954, 13036.543720969768, 602.0517684646677, 612.0, 741.3957624535985, 748.2891253309377, 749.763824395315, 753.3220101908299, 756.156885073145, 760.5170716594974, 767.3477544087536, 768.0476209500207, 810.7081450677751, 817.342039658078, 817.8650522663753, 818.0919179710517, 818.4148333941231, 627.7802769030849, 633.7369991453542, 634.2895956528718, 634.7683095670093, 812.0417906869891, 464.324407986379, 571.7512881896388, 578.6181120460518, 580.5732786401991, 581.4824805922732, 11534.134939879543, 11628.011619012394, 11676.299422034705, 11873.228240164362, 11964.70088247792, 9249.0, 9294.581743821476, 9335.299852511089, 9614.579804300587, 9636.90363096367, 8965.731028069169, 9110.116951523141, 9177.0, 9424.528773561295, 9513.191378732816, 2849.586809912551, 2869.368738877444, 2904.2158617173454, 2906.070057581575, 2967.0802051364144, 39507.20985580272, 39535.40696889549, 39651.60348396508, 39850.60149398469, 40015.19969600592, 6686.598804071771, 6778.322957159544, 6901.965490172617, 6918.930810691829, 6925.203601585882, 10993.725156871142, 10998.395088270221, 11004.229703920648, 11011.559537618567, 11020.44897755109, 5554.888902221933, 5561.277033985556, 5561.388247292794, 5647.209390685307, 5734.340550836624, 3432.845521951518, 3587.820608969541, 3630.673239408413, 3661.5056967309606, 3668.211334563082, 2418.975810241875, 2454.312792418126, 2454.5827209374447, 2455.72986971433, 2457.103157347555, 375.2569911575097, 377.57899941565506, 378.65920671395963, 379.5047463060677, 382.29466634060117, 463.74494028284306, 515.4072816261255, 576.5675743192605, 588.1442501160801, 594.2838879150613, 7478.326950574475, 7500.774976750707, 7598.542663088281, 8073.2734053934255, 8201.95899020501, 400.79359130047465, 479.3959610890234, 545.4518209199729, 567.4694160959516, 594.7739858853608, 3618.819059047037, 3778.017715394017, 3796.6393192646656, 3840.8271627776817, 3846.1922996171115, 48936.26595601069, 53696.731516342166, 53729.462705373226, 54801.45198548043, 55062.89874202493, 45934.31098533524, 46272.76863615728, 47964.520354796005, 48130.0, 48657.513424866, 42994.7850260753, 43417.56582434135, 43473.565264347584, 43601.563984360386, 43702.0, 8155.429119961783, 8313.0, 8361.83276334482, 8415.074341822272, 8521.744347669579, 32655.836720816245, 32865.67134328626, 32888.50667239945, 32980.50529242111, 33438.164045899044, 36873.0, 38133.0, 41780.373294401215, 42069.36895946624, 42078.36882446827, 7033.191183013814, 7181.886807544839, 7256.0567126273245, 7286.781396558112, 7333.926660733325, 11449.542018319175, 11636.88363116358, 11645.6506304811, 11695.707607309885, 11955.342456164646, 10556.366618002945, 10783.275081931293, 10816.4050977197, 10901.618443354762, 10978.286411383235, 10587.947060264649, 10782.784344313226, 11234.719132021439, 11251.324920504796, 11262.0, 10702.571897124028, 11104.5558177672, 11466.656000320003, 11505.48225329879, 11509.194356394972, 9203.35576509638, 9238.399504032217, 9368.203702685349, 9402.059794020543, 9590.808183836423, 8825.426347287406, 9096.909030909606, 9210.493422861808, 9218.44689318643, 9725.85411218818], "unit": "ms", "name": "yui.html", "value": 5460.330676416183}], "name": "dromaeo_css", "value": 5872.021902205605}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 113.0, 112.0, 113.0, 121.0, 113.0, 112.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [150.0, 132.0, 155.0, 168.0, 131.0, 156.0, 154.0, 135.0, 167.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 162.0, 160.0, 161.0, 159.0, 162.0, 162.0, 160.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 78.0, 92.0, 73.0, 73.0, 73.0, 99.0, 91.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 129.0, 91.0, 93.0, 93.0, 139.0, 93.0, 93.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 74.0, 72.0, 72.0, 73.0, 72.0, 81.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 94.0, 84.0, 85.0, 83.0, 83.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 129.0, 117.0, 131.0, 131.0, 121.0, 129.0, 133.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [156.0, 141.0, 154.0, 150.0, 152.0, 139.0, 152.0, 151.0, 152.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 71.0, 71.0, 72.0, 69.0, 70.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1537.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.05233980107616], "unit": "score", "name": "Richards", "value": 216.50716599999996}, {"lowerIsBetter": false, "replicates": [187.26591760299627], "unit": "score", "name": "DeltaBlue", "value": 353.07012000000003}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [626.4760720944686], "unit": "score", "name": "Splay", "value": 130.07839186507942}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19752.455486719064}]} 07:33:28 INFO - RETURN: dromaeo_css: 5872.02 07:33:28 INFO - RETURN: kraken: 1537.10 07:33:28 INFO - RETURN: v8_7: 19752.46 07:33:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19752.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1537.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5872.02"}}} 07:33:28 INFO - Return code: 0 07:33:28 INFO - # TBPL SUCCESS # 07:33:28 INFO - Running post-action listener: _resource_record_post_action 07:33:28 INFO - Running post-run listener: _resource_record_post_run 07:33:30 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10383360; Write bytes: 394936320; Read time: 2648; Write time: 284748 07:33:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 42291200; Read time: 28; Write time: 12992 07:33:30 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8224768; Write bytes: 275017728; Read time: 2244; Write time: 171204 07:33:30 INFO - Running post-run listener: _upload_blobber_files 07:33:30 INFO - Blob upload gear active. 07:33:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:33:30 INFO - Copying logs to upload dir... 07:33:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.292090 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-18 07:33:29.762486) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:29.766147) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010016 build_url: 'https://queue.taskcluster.net/v1/task/Ljc232YETviCPTCy-mgPig/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-18 07:33:29.817403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:29.817804) ========= 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=0c96bf5caf0e090009e1a122000001b2-1447841014.249771-771625768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 07:33:29.867532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:33:29.867868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 07:33:29.868160) ========= ========= Total master_lag: 0.66 =========