builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1449662677.79 results: success (0) buildid: 20151209030353 builduid: 3eb57ef47a004eb38708c1d60f0a6a73 revision: 319be5e7ce3061c7c16f24d750b6dacdbcac4c35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.788064) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.788534) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.788835) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006486 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.822661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.822953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.880183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.880452) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.945383) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.945654) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.946216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:37.946507) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 04:04:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-09 04:04:39 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.197228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.197563) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.247880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.248280) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 319be5e7ce3061c7c16f24d750b6dacdbcac4c35 --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 319be5e7ce3061c7c16f24d750b6dacdbcac4c35 --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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 04:04:39,864 truncating revision to first 12 chars 2015-12-09 04:04:39,864 Setting DEBUG logging. 2015-12-09 04:04:39,864 attempt 1/10 2015-12-09 04:04:39,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/319be5e7ce30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 04:04:40,120 unpacking tar archive at: mozilla-central-319be5e7ce30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.784753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.785049) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.793504) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.793794) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:04:38.794228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-09 04:04:38.794532) ========= /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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:40 INFO - MultiFileLogger online at 20151209 04:04:40 in /builds/slave/test 04:04:40 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 04:04:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:40 INFO - {'append_to_log': False, 04:04:40 INFO - 'base_work_dir': '/builds/slave/test', 04:04:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:04:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:40 INFO - 'branch': 'Firefox-Non-PGO', 04:04:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:40 INFO - 'config_files': ('talos/linux_config.py',), 04:04:40 INFO - 'default_actions': ('clobber', 04:04:40 INFO - 'read-buildbot-config', 04:04:40 INFO - 'download-and-extract', 04:04:40 INFO - 'populate-webroot', 04:04:40 INFO - 'create-virtualenv', 04:04:40 INFO - 'install', 04:04:40 INFO - 'run-tests'), 04:04:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:40 INFO - 'download_minidump_stackwalk': True, 04:04:40 INFO - 'download_symbols': 'ondemand', 04:04:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:40 INFO - 'installer_path': 'installer.exe', 04:04:40 INFO - 'log_level': 'info', 04:04:40 INFO - 'log_name': 'talos', 04:04:40 INFO - 'log_to_console': True, 04:04:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:40 INFO - 'opt_config_files': (), 04:04:40 INFO - 'pip_index': False, 04:04:40 INFO - 'sps_profile': False, 04:04:40 INFO - 'sps_profile_interval': 0, 04:04:40 INFO - 'suite': 'dromaeojs', 04:04:40 INFO - 'system_bits': '64', 04:04:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:40 INFO - 'title': 'talos-linux64-ix-042', 04:04:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:40 INFO - 'use_talos_json': True, 04:04:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:40 INFO - 'work_dir': 'build'} 04:04:40 INFO - ##### 04:04:40 INFO - ##### Running clobber step. 04:04:40 INFO - ##### 04:04:40 INFO - Running pre-action listener: _resource_record_pre_action 04:04:40 INFO - Running main action method: clobber 04:04:40 INFO - rmtree: /builds/slave/test/build 04:04:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:41 INFO - Running post-action listener: _resource_record_post_action 04:04:41 INFO - ##### 04:04:41 INFO - ##### Running read-buildbot-config step. 04:04:41 INFO - ##### 04:04:41 INFO - Running pre-action listener: _resource_record_pre_action 04:04:41 INFO - Running main action method: read_buildbot_config 04:04:41 INFO - Using buildbot properties: 04:04:41 INFO - { 04:04:41 INFO - "properties": { 04:04:41 INFO - "buildnumber": 398, 04:04:41 INFO - "product": "firefox", 04:04:41 INFO - "script_repo_revision": "production", 04:04:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:04:41 INFO - "repository": "", 04:04:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:04:41 INFO - "buildid": "20151209030353", 04:04:41 INFO - "slavename": "talos-linux64-ix-042", 04:04:41 INFO - "pgo_build": "False", 04:04:41 INFO - "basedir": "/builds/slave/test", 04:04:41 INFO - "project": "", 04:04:41 INFO - "platform": "ubuntu64_hw", 04:04:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:04:41 INFO - "slavebuilddir": "test", 04:04:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:04:41 INFO - "branch": "mozilla-central", 04:04:41 INFO - "repo_path": "mozilla-central", 04:04:41 INFO - "stage_platform": "linux64", 04:04:41 INFO - "builduid": "3eb57ef47a004eb38708c1d60f0a6a73", 04:04:41 INFO - "revision": "319be5e7ce3061c7c16f24d750b6dacdbcac4c35" 04:04:41 INFO - }, 04:04:41 INFO - "sourcestamp": { 04:04:41 INFO - "repository": "", 04:04:41 INFO - "hasPatch": false, 04:04:41 INFO - "project": "", 04:04:41 INFO - "branch": "mozilla-central-linux64-talos", 04:04:41 INFO - "changes": [ 04:04:41 INFO - { 04:04:41 INFO - "category": null, 04:04:41 INFO - "files": [ 04:04:41 INFO - { 04:04:41 INFO - "url": null, 04:04:41 INFO - "name": "https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:04:41 INFO - } 04:04:41 INFO - ], 04:04:41 INFO - "repository": "", 04:04:41 INFO - "rev": "319be5e7ce3061c7c16f24d750b6dacdbcac4c35", 04:04:41 INFO - "who": "cbook@mozilla.com", 04:04:41 INFO - "when": 1449662644, 04:04:41 INFO - "number": 7145008, 04:04:41 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:04:41 INFO - "project": "", 04:04:41 INFO - "at": "Wed 09 Dec 2015 04:04:04", 04:04:41 INFO - "branch": "mozilla-central-linux64-talos", 04:04:41 INFO - "revlink": "", 04:04:41 INFO - "properties": [ 04:04:41 INFO - [ 04:04:41 INFO - "buildid", 04:04:41 INFO - "20151209030353", 04:04:41 INFO - "Change" 04:04:41 INFO - ], 04:04:41 INFO - [ 04:04:41 INFO - "builduid", 04:04:41 INFO - "3eb57ef47a004eb38708c1d60f0a6a73", 04:04:41 INFO - "Change" 04:04:41 INFO - ], 04:04:41 INFO - [ 04:04:41 INFO - "pgo_build", 04:04:41 INFO - "False", 04:04:41 INFO - "Change" 04:04:41 INFO - ] 04:04:41 INFO - ], 04:04:41 INFO - "revision": "319be5e7ce3061c7c16f24d750b6dacdbcac4c35" 04:04:41 INFO - } 04:04:41 INFO - ], 04:04:41 INFO - "revision": "319be5e7ce3061c7c16f24d750b6dacdbcac4c35" 04:04:41 INFO - } 04:04:41 INFO - } 04:04:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:04:41 INFO - Running post-action listener: _resource_record_post_action 04:04:41 INFO - ##### 04:04:41 INFO - ##### Running download-and-extract step. 04:04:41 INFO - ##### 04:04:41 INFO - Running pre-action listener: _resource_record_pre_action 04:04:41 INFO - Running main action method: download_and_extract 04:04:41 INFO - mkdir: /builds/slave/test/build/tests 04:04: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')]} 04:04:41 INFO - https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/test_packages.json 04:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/test_packages.json 04:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:04:45 INFO - Downloaded 1302 bytes. 04:04:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:04:45 INFO - Using the following test package requirements: 04:04:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'jsshell-linux-x86_64.zip'], 04:04:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:04:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:04:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:45 INFO - https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:48 INFO - Downloaded 21859993 bytes. 04:04:48 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 04:04:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:48 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 04:04:49 INFO - Return code: 0 04:04:49 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 04:04:49 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')]} 04:04:49 INFO - https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:56 INFO - Downloaded 21859993 bytes. 04:04:56 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 04:04:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:04:56 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 04:04:57 INFO - Return code: 0 04:04:57 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')]} 04:04:57 INFO - https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:59 INFO - Downloaded 11132038 bytes. 04:04:59 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 04:04:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:59 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 04:04:59 INFO - Return code: 0 04:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:59 INFO - https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uKu4M_pWTZykBKZwUUScoQ/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 04:05:01 INFO - Downloaded 57729516 bytes. 04:05:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:01 INFO - mkdir: /builds/slave/test/properties 04:05:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:01 INFO - Contents: 04:05:01 INFO - build_url:https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:05:01 INFO - Running post-action listener: _resource_record_post_action 04:05:01 INFO - Running post-action listener: set_extra_try_arguments 04:05:01 INFO - ##### 04:05:01 INFO - ##### Running populate-webroot step. 04:05:01 INFO - ##### 04:05:01 INFO - Running pre-action listener: _resource_record_pre_action 04:05:01 INFO - Running main action method: populate_webroot 04:05:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:01 INFO - '--tppagecycles', 04:05:01 INFO - '7'], 04:05:01 INFO - 'tests': ['tsvgm']}}, 04:05:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'tests': ['damp', 'tps']}, 04:05:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['damp', 'tps']}, 04:05:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:01 INFO - 'other': {'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'other_l64': {'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:01 INFO - 'ts_paint', 04:05:01 INFO - 'tpaint', 04:05:01 INFO - 'sessionrestore', 04:05:01 INFO - 'sessionrestore_no_auto_restore']}, 04:05:01 INFO - 'svgr': {'tests': ['tsvgx', 04:05:01 INFO - 'tsvgr_opacity', 04:05:01 INFO - 'tart', 04:05:01 INFO - 'tscrollx', 04:05:01 INFO - 'cart']}, 04:05:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['tsvgx', 04:05:01 INFO - 'tsvgr_opacity', 04:05:01 INFO - 'tart', 04:05:01 INFO - 'tscrollx', 04:05:01 INFO - 'cart']}, 04:05:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'tests': ['tp5o']}, 04:05:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'talos_options': ['--e10s'], 04:05:01 INFO - 'tests': ['tp5o']}, 04:05:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'talos_options': ['--xperf_path', 04:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:01 INFO - 'tests': ['tp5n']}, 04:05:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:01 INFO - 'talos_options': ['--e10s', 04:05:01 INFO - '--xperf_path', 04:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:01 INFO - 'tests': ['tp5n']}}, 04:05:01 INFO - 'talos.zip': {'path': '', 04:05:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:01 INFO - Running post-action listener: _resource_record_post_action 04:05:01 INFO - ##### 04:05:01 INFO - ##### Running create-virtualenv step. 04:05:01 INFO - ##### 04:05:01 INFO - Running pre-action listener: _resource_record_pre_action 04:05:01 INFO - Running main action method: create_virtualenv 04:05:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:01 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 04:05:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:01 INFO - Using real prefix '/usr' 04:05:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:03 INFO - Installing pip.................done. 04:05:03 INFO - Return code: 0 04:05:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:03 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')]} 04:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:03 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')]} 04:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:03 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:03 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 04:05:03 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 04:05:03 INFO - Using env: {'DISPLAY': ':0', 04:05:03 INFO - 'HOME': '/home/cltbld', 04:05:03 INFO - 'LANG': 'en_US.UTF-8', 04:05:03 INFO - 'LANGUAGE': 'en_US:en', 04:05:03 INFO - 'LOGNAME': 'cltbld', 04:05:03 INFO - 'MAIL': '/var/mail/cltbld', 04:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:03 INFO - 'MOZ_NO_REMOTE': '1', 04:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:03 INFO - 'NO_EM_RESTART': '1', 04:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:03 INFO - 'PWD': '/builds/slave/test', 04:05:03 INFO - 'SHELL': '/bin/bash', 04:05:03 INFO - 'SHLVL': '1', 04:05:03 INFO - 'TERM': 'linux', 04:05:03 INFO - 'TMOUT': '86400', 04:05:03 INFO - 'USER': 'cltbld', 04:05:03 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:03 INFO - '_': '/tools/buildbot/bin/python'} 04:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:04 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 04:05:04 INFO - Cleaning up... 04:05:04 INFO - Return code: 0 04:05:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:05:04 INFO - Using env: {'DISPLAY': ':0', 04:05:04 INFO - 'HOME': '/home/cltbld', 04:05:04 INFO - 'LANG': 'en_US.UTF-8', 04:05:04 INFO - 'LANGUAGE': 'en_US:en', 04:05:04 INFO - 'LOGNAME': 'cltbld', 04:05:04 INFO - 'MAIL': '/var/mail/cltbld', 04:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:04 INFO - 'MOZ_NO_REMOTE': '1', 04:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:04 INFO - 'NO_EM_RESTART': '1', 04:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:04 INFO - 'PWD': '/builds/slave/test', 04:05:04 INFO - 'SHELL': '/bin/bash', 04:05:04 INFO - 'SHLVL': '1', 04:05:04 INFO - 'TERM': 'linux', 04:05:04 INFO - 'TMOUT': '86400', 04:05:04 INFO - 'USER': 'cltbld', 04:05:04 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:04 INFO - '_': '/tools/buildbot/bin/python'} 04:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:04 INFO - Downloading/unpacking psutil>=0.7.1 04:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:06 INFO - Installing collected packages: psutil 04:05:06 INFO - Running setup.py install for psutil 04:05:06 INFO - building 'psutil._psutil_linux' extension 04:05:06 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 04:05:06 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 04:05:06 INFO - building 'psutil._psutil_posix' extension 04:05:06 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 04:05:06 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 04:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:06 INFO - Successfully installed psutil 04:05:06 INFO - Cleaning up... 04:05:06 INFO - Return code: 0 04:05:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:05:06 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')]} 04:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:06 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')]} 04:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:06 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:06 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 04:05:06 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 04:05:06 INFO - Using env: {'DISPLAY': ':0', 04:05:06 INFO - 'HOME': '/home/cltbld', 04:05:06 INFO - 'LANG': 'en_US.UTF-8', 04:05:06 INFO - 'LANGUAGE': 'en_US:en', 04:05:06 INFO - 'LOGNAME': 'cltbld', 04:05:06 INFO - 'MAIL': '/var/mail/cltbld', 04:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:06 INFO - 'MOZ_NO_REMOTE': '1', 04:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:06 INFO - 'NO_EM_RESTART': '1', 04:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:06 INFO - 'PWD': '/builds/slave/test', 04:05:06 INFO - 'SHELL': '/bin/bash', 04:05:06 INFO - 'SHLVL': '1', 04:05:06 INFO - 'TERM': 'linux', 04:05:06 INFO - 'TMOUT': '86400', 04:05:06 INFO - 'USER': 'cltbld', 04:05:06 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:06 INFO - '_': '/tools/buildbot/bin/python'} 04:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:05:08 INFO - Installing collected packages: mozsystemmonitor 04:05:08 INFO - Running setup.py install for mozsystemmonitor 04:05:08 INFO - Successfully installed mozsystemmonitor 04:05:08 INFO - Cleaning up... 04:05:08 INFO - Return code: 0 04:05:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:08 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:08 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 04:05:08 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 04:05:08 INFO - Using env: {'DISPLAY': ':0', 04:05:08 INFO - 'HOME': '/home/cltbld', 04:05:08 INFO - 'LANG': 'en_US.UTF-8', 04:05:08 INFO - 'LANGUAGE': 'en_US:en', 04:05:08 INFO - 'LOGNAME': 'cltbld', 04:05:08 INFO - 'MAIL': '/var/mail/cltbld', 04:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:08 INFO - 'MOZ_NO_REMOTE': '1', 04:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:08 INFO - 'NO_EM_RESTART': '1', 04:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:08 INFO - 'PWD': '/builds/slave/test', 04:05:08 INFO - 'SHELL': '/bin/bash', 04:05:08 INFO - 'SHLVL': '1', 04:05:08 INFO - 'TERM': 'linux', 04:05:08 INFO - 'TMOUT': '86400', 04:05:08 INFO - 'USER': 'cltbld', 04:05:08 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:08 INFO - '_': '/tools/buildbot/bin/python'} 04:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:08 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 04:05:08 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 04:05:08 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 04:05:08 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 04:05:08 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 04:05:08 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 04:05:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:10 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 04:05:10 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 04:05:10 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 04:05:10 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 04:05:10 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 04:05:10 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 04:05:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:11 INFO - Downloading docopt-0.6.1.tar.gz 04:05:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:11 INFO - Running setup.py install for blobuploader 04:05:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:05:11 INFO - Running setup.py install for requests 04:05:11 INFO - Running setup.py install for docopt 04:05:11 INFO - Successfully installed blobuploader requests docopt 04:05:11 INFO - Cleaning up... 04:05:11 INFO - Return code: 0 04:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:11 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')]} 04:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:11 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')]} 04:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:11 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:11 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 04:05:11 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 04:05:11 INFO - Using env: {'DISPLAY': ':0', 04:05:11 INFO - 'HOME': '/home/cltbld', 04:05:11 INFO - 'LANG': 'en_US.UTF-8', 04:05:11 INFO - 'LANGUAGE': 'en_US:en', 04:05:11 INFO - 'LOGNAME': 'cltbld', 04:05:11 INFO - 'MAIL': '/var/mail/cltbld', 04:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:11 INFO - 'MOZ_NO_REMOTE': '1', 04:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:11 INFO - 'NO_EM_RESTART': '1', 04:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:11 INFO - 'PWD': '/builds/slave/test', 04:05:11 INFO - 'SHELL': '/bin/bash', 04:05:11 INFO - 'SHLVL': '1', 04:05:11 INFO - 'TERM': 'linux', 04:05:11 INFO - 'TMOUT': '86400', 04:05:11 INFO - 'USER': 'cltbld', 04:05:11 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:11 INFO - '_': '/tools/buildbot/bin/python'} 04:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:12 INFO - Running setup.py (path:/tmp/pip-NaYQne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:12 INFO - Running setup.py (path:/tmp/pip-pECv7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:12 INFO - Running setup.py (path:/tmp/pip-jNPT5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:12 INFO - Running setup.py (path:/tmp/pip-ZOdD6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:12 INFO - Running setup.py (path:/tmp/pip-H95MYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:12 INFO - Running setup.py (path:/tmp/pip-rrbv6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:12 INFO - Running setup.py (path:/tmp/pip-mCuzi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:12 INFO - Running setup.py (path:/tmp/pip-KCAP8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:12 INFO - Running setup.py (path:/tmp/pip-uydfSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:12 INFO - Running setup.py (path:/tmp/pip-xWKCPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:12 INFO - Running setup.py (path:/tmp/pip-KXmT0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:12 INFO - Running setup.py (path:/tmp/pip-zRhRZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:13 INFO - Running setup.py (path:/tmp/pip-WX3gxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:13 INFO - Running setup.py (path:/tmp/pip-q0Rds3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:13 INFO - Running setup.py (path:/tmp/pip-DianPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:13 INFO - Running setup.py (path:/tmp/pip-zpUCYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:13 INFO - Running setup.py (path:/tmp/pip-hK1G2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:13 INFO - Running setup.py install for manifestparser 04:05:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:05:13 INFO - Running setup.py install for mozcrash 04:05:13 INFO - Running setup.py install for mozdebug 04:05:13 INFO - Running setup.py install for mozdevice 04:05:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:13 INFO - Running setup.py install for mozfile 04:05:13 INFO - Running setup.py install for mozhttpd 04:05:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:13 INFO - Running setup.py install for mozinfo 04:05:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for mozInstall 04:05:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for mozleak 04:05:14 INFO - Running setup.py install for mozlog 04:05:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for moznetwork 04:05:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for mozprocess 04:05:14 INFO - Running setup.py install for mozprofile 04:05:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for mozrunner 04:05:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:14 INFO - Running setup.py install for mozscreenshot 04:05:14 INFO - Running setup.py install for moztest 04:05:15 INFO - Running setup.py install for mozversion 04:05:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:15 INFO - Cleaning up... 04:05:15 INFO - Return code: 0 04:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:15 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:15 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 04:05:15 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 04:05:15 INFO - Using env: {'DISPLAY': ':0', 04:05:15 INFO - 'HOME': '/home/cltbld', 04:05:15 INFO - 'LANG': 'en_US.UTF-8', 04:05:15 INFO - 'LANGUAGE': 'en_US:en', 04:05:15 INFO - 'LOGNAME': 'cltbld', 04:05:15 INFO - 'MAIL': '/var/mail/cltbld', 04:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:15 INFO - 'MOZ_NO_REMOTE': '1', 04:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:15 INFO - 'NO_EM_RESTART': '1', 04:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:15 INFO - 'PWD': '/builds/slave/test', 04:05:15 INFO - 'SHELL': '/bin/bash', 04:05:15 INFO - 'SHLVL': '1', 04:05:15 INFO - 'TERM': 'linux', 04:05:15 INFO - 'TMOUT': '86400', 04:05:15 INFO - 'USER': 'cltbld', 04:05:15 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:15 INFO - '_': '/tools/buildbot/bin/python'} 04:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:15 INFO - Running setup.py (path:/tmp/pip-jGyADR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:15 INFO - Running setup.py (path:/tmp/pip-Ufebs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:15 INFO - Running setup.py (path:/tmp/pip-F4NyxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:15 INFO - Running setup.py (path:/tmp/pip-FnSCwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:15 INFO - Running setup.py (path:/tmp/pip-rMlhVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:15 INFO - Running setup.py (path:/tmp/pip-9TGvIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:15 INFO - Running setup.py (path:/tmp/pip-Ju5oSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:15 INFO - Running setup.py (path:/tmp/pip-5zKDf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:15 INFO - Running setup.py (path:/tmp/pip-o8i7if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:15 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)) 04:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:16 INFO - Running setup.py (path:/tmp/pip-5zNZOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:16 INFO - Running setup.py (path:/tmp/pip-R3A07B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:16 INFO - Running setup.py (path:/tmp/pip-u520ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:16 INFO - Running setup.py (path:/tmp/pip-sTiAll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:16 INFO - Running setup.py (path:/tmp/pip-gjSS6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:16 INFO - Running setup.py (path:/tmp/pip-3220dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:16 INFO - Running setup.py (path:/tmp/pip-kSNZbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:16 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)) 04:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:16 INFO - Running setup.py (path:/tmp/pip-Flp3q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:16 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)) 04:05:16 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)) 04:05:16 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)) 04:05:16 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)) 04:05:16 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)) 04:05:16 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)) 04:05:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:16 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 04:05:16 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 04:05:16 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 04:05:16 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 04:05:16 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 04:05:16 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 04:05:18 INFO - Downloading blessings-1.5.1.tar.gz 04:05:18 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 04:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:18 INFO - Installing collected packages: blessings 04:05:18 INFO - Running setup.py install for blessings 04:05:18 INFO - Successfully installed blessings 04:05:18 INFO - Cleaning up... 04:05:18 INFO - Return code: 0 04:05:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:18 INFO - Reading from file tmpfile_stdout 04:05:18 INFO - Current package versions: 04:05:18 INFO - argparse == 1.2.1 04:05:18 INFO - blessings == 1.5.1 04:05:18 INFO - blobuploader == 1.2.4 04:05:18 INFO - docopt == 0.6.1 04:05:18 INFO - manifestparser == 1.1 04:05:18 INFO - mozInstall == 1.12 04:05:18 INFO - mozcrash == 0.16 04:05:18 INFO - mozdebug == 0.1 04:05:18 INFO - mozdevice == 0.47 04:05:18 INFO - mozfile == 1.2 04:05:18 INFO - mozhttpd == 0.7 04:05:18 INFO - mozinfo == 0.9 04:05:18 INFO - mozleak == 0.1 04:05:18 INFO - mozlog == 3.1 04:05:18 INFO - moznetwork == 0.27 04:05:18 INFO - mozprocess == 0.22 04:05:18 INFO - mozprofile == 0.27 04:05:18 INFO - mozrunner == 6.11 04:05:18 INFO - mozscreenshot == 0.1 04:05:18 INFO - mozsystemmonitor == 0.0 04:05:18 INFO - moztest == 0.7 04:05:18 INFO - mozversion == 1.4 04:05:18 INFO - psutil == 3.1.1 04:05:18 INFO - requests == 1.2.3 04:05:18 INFO - wsgiref == 0.1.2 04:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 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 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:18 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 04:05:18 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 04:05:18 INFO - Using env: {'DISPLAY': ':0', 04:05:18 INFO - 'HOME': '/home/cltbld', 04:05:18 INFO - 'LANG': 'en_US.UTF-8', 04:05:18 INFO - 'LANGUAGE': 'en_US:en', 04:05:18 INFO - 'LOGNAME': 'cltbld', 04:05:18 INFO - 'MAIL': '/var/mail/cltbld', 04:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:18 INFO - 'MOZ_NO_REMOTE': '1', 04:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:18 INFO - 'NO_EM_RESTART': '1', 04:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:18 INFO - 'PWD': '/builds/slave/test', 04:05:18 INFO - 'SHELL': '/bin/bash', 04:05:18 INFO - 'SHLVL': '1', 04:05:18 INFO - 'TERM': 'linux', 04:05:18 INFO - 'TMOUT': '86400', 04:05:18 INFO - 'USER': 'cltbld', 04:05:18 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:18 INFO - '_': '/tools/buildbot/bin/python'} 04:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 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)) 04:05:18 INFO - Cleaning up... 04:05:18 INFO - Return code: 0 04:05:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:18 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', 'jsonschema'] in /builds/slave/test/build 04:05:18 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 jsonschema 04:05:18 INFO - Using env: {'DISPLAY': ':0', 04:05:18 INFO - 'HOME': '/home/cltbld', 04:05:18 INFO - 'LANG': 'en_US.UTF-8', 04:05:18 INFO - 'LANGUAGE': 'en_US:en', 04:05:18 INFO - 'LOGNAME': 'cltbld', 04:05:18 INFO - 'MAIL': '/var/mail/cltbld', 04:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:18 INFO - 'MOZ_NO_REMOTE': '1', 04:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:18 INFO - 'NO_EM_RESTART': '1', 04:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:18 INFO - 'PWD': '/builds/slave/test', 04:05:18 INFO - 'SHELL': '/bin/bash', 04:05:18 INFO - 'SHLVL': '1', 04:05:18 INFO - 'TERM': 'linux', 04:05:18 INFO - 'TMOUT': '86400', 04:05:18 INFO - 'USER': 'cltbld', 04:05:18 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:18 INFO - '_': '/tools/buildbot/bin/python'} 04:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:19 INFO - Downloading/unpacking jsonschema 04:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:05:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:21 INFO - warning: no files found matching '*.txt' 04:05:21 INFO - no previously-included directories found matching 'build' 04:05:21 INFO - no previously-included directories found matching 'dist' 04:05:21 INFO - no previously-included directories found matching '.git*' 04:05:21 INFO - Installing collected packages: jsonschema, functools32 04:05:21 INFO - Running setup.py install for functools32 04:05:21 INFO - warning: no files found matching '*.txt' 04:05:21 INFO - no previously-included directories found matching 'build' 04:05:21 INFO - no previously-included directories found matching 'dist' 04:05:21 INFO - no previously-included directories found matching '.git*' 04:05:21 INFO - Successfully installed jsonschema functools32 04:05:21 INFO - Cleaning up... 04:05:21 INFO - Return code: 0 04:05:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9acf393f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, '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': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', '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 04:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:05:21 INFO - Using env: {'DISPLAY': ':0', 04:05:21 INFO - 'HOME': '/home/cltbld', 04:05:21 INFO - 'LANG': 'en_US.UTF-8', 04:05:21 INFO - 'LANGUAGE': 'en_US:en', 04:05:21 INFO - 'LOGNAME': 'cltbld', 04:05:21 INFO - 'MAIL': '/var/mail/cltbld', 04:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:21 INFO - 'MOZ_NO_REMOTE': '1', 04:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:21 INFO - 'NO_EM_RESTART': '1', 04:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:21 INFO - 'PWD': '/builds/slave/test', 04:05:21 INFO - 'SHELL': '/bin/bash', 04:05:21 INFO - 'SHLVL': '1', 04:05:21 INFO - 'TERM': 'linux', 04:05:21 INFO - 'TMOUT': '86400', 04:05:21 INFO - 'USER': 'cltbld', 04:05:21 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:21 INFO - '_': '/tools/buildbot/bin/python'} 04:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:21 INFO - Downloading/unpacking flake8 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:21 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 04:05:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:05:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:05:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:05:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:23 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 04:05:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:24 INFO - no previously-included directories found matching 'docs/_build' 04:05:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:05:24 INFO - Running setup.py install for pep8 04:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:24 INFO - no previously-included directories found matching 'docs/_build' 04:05:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:05:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:05:24 INFO - Cleaning up... 04:05:24 INFO - Return code: 0 04:05:24 INFO - Running post-action listener: _resource_record_post_action 04:05:24 INFO - Running post-action listener: _start_resource_monitoring 04:05:24 INFO - Starting resource monitoring. 04:05:24 INFO - ##### 04:05:24 INFO - ##### Running install step. 04:05:24 INFO - ##### 04:05:24 INFO - Running pre-action listener: _resource_record_pre_action 04:05:24 INFO - Running main action method: install 04:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:24 INFO - Reading from file tmpfile_stdout 04:05:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:05:24 INFO - Reading from file tmpfile_stdout 04:05:24 INFO - Output received: 04:05:24 INFO - Usage: mozinstall [options] installer 04:05:24 INFO - Options: 04:05:24 INFO - -h, --help show this help message and exit 04:05:24 INFO - -d DEST, --destination=DEST 04:05:24 INFO - Directory to install application into. [default: 04:05:24 INFO - "/builds/slave/test"] 04:05:24 INFO - --app=APP Application being installed. [default: firefox] 04:05:24 INFO - mkdir: /builds/slave/test/build/application 04:05:24 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'] 04:05:24 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 04:05:39 INFO - Reading from file tmpfile_stdout 04:05:39 INFO - Output received: 04:05:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:05:39 INFO - Running post-action listener: _resource_record_post_action 04:05:39 INFO - ##### 04:05:39 INFO - ##### Running run-tests step. 04:05:39 INFO - ##### 04:05:39 INFO - Running pre-action listener: _resource_record_pre_action 04:05:39 INFO - Running main action method: run_tests 04:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:39 INFO - Python 2.7.3 04:05:39 INFO - Return code: 0 04:05:39 INFO - grabbing minidump binary from tooltool 04:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:39 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 0x1b9f0b0>, '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 0x1b9ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:39 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 04:05:39 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 04:05:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:39 INFO - Return code: 0 04:05:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:05:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:05:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:05:40 INFO - Return code: 0 04:05:40 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/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test/build 04:05:40 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/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 04:05:40 INFO - Using env: {'DISPLAY': ':0', 04:05:40 INFO - 'HOME': '/home/cltbld', 04:05:40 INFO - 'LANG': 'en_US.UTF-8', 04:05:40 INFO - 'LANGUAGE': 'en_US:en', 04:05:40 INFO - 'LOGNAME': 'cltbld', 04:05:40 INFO - 'MAIL': '/var/mail/cltbld', 04:05:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:40 INFO - 'MOZ_NO_REMOTE': '1', 04:05:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:40 INFO - 'NO_EM_RESTART': '1', 04:05:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:40 INFO - 'PWD': '/builds/slave/test', 04:05:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:40 INFO - 'SHELL': '/bin/bash', 04:05:40 INFO - 'SHLVL': '1', 04:05:40 INFO - 'TERM': 'linux', 04:05:40 INFO - 'TMOUT': '86400', 04:05:40 INFO - 'USER': 'cltbld', 04:05:40 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449659107.272114-540967176', 04:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:40 INFO - '_': '/tools/buildbot/bin/python'} 04:05:40 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/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 04:05:40 INFO - mozversion INFO | application_buildid: 20151209030353 04:05:40 INFO - mozversion INFO | application_changeset: 319be5e7ce3061c7c16f24d750b6dacdbcac4c35 04:05:40 INFO - mozversion INFO | application_display_name: Nightly 04:05:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:40 INFO - mozversion INFO | application_name: Firefox 04:05:40 INFO - mozversion INFO | application_remotingname: firefox 04:05:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:05:40 INFO - mozversion INFO | application_vendor: Mozilla 04:05:40 INFO - mozversion INFO | application_version: 45.0a1 04:05:40 INFO - mozversion INFO | platform_buildid: 20151209030353 04:05:40 INFO - mozversion INFO | platform_changeset: 319be5e7ce3061c7c16f24d750b6dacdbcac4c35 04:05:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:05:40 INFO - mozversion INFO | platform_version: 45.0a1 04:05:40 INFO - 2015-12-09 04:05:40,372 DEBUG : using testdate: 1449662740 04:05:40 INFO - 2015-12-09 04:05:40,372 DEBUG : actual date: 1449662740 04:05:40 INFO - 2015-12-09 04:05:40,382 INFO : starting webserver on 'localhost:57091' 04:05:40 INFO - 2015-12-09 04:05:40,383 INFO : Starting test suite talos-linux64-ix-042 04:05:40 INFO - 2015-12-09 04:05:40,383 INFO : Starting test dromaeo_css 04:05:40 INFO - 2015-12-09 04:05:40,383 DEBUG : operating with platform_type : linux_ 04:05:40 INFO - 2015-12-09 04:05:40,384 INFO : Initialising browser for dromaeo_css test... 04:05:40 INFO - 2015-12-09 04:05:40,400 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6v7jl/profile http://localhost:57091/getInfo.html 04:05:44 INFO - 2015-12-09 04:05:44,892 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:44 INFO - 2015-12-09 04:05:44,892 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:44 INFO - 2015-12-09 04:05:44,892 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:44 INFO - 2015-12-09 04:05:44,892 DEBUG : BROWSER_OUTPUT: __metrics 04:05:44 INFO - 2015-12-09 04:05:44,994 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:05:45 INFO - 2015-12-09 04:05:45,082 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:46 INFO - 2015-12-09 04:05:46,372 INFO : Browser initialized. 04:05:46 INFO - 2015-12-09 04:05:46,372 INFO : Running cycle 1/1 for dromaeo_css test... 04:05:46 INFO - 2015-12-09 04:05:46,373 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6v7jl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:05:58 INFO - 2015-12-09 04:05:58,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 143446016 04:05:58 INFO - 2015-12-09 04:05:58,411 DEBUG : BROWSER_OUTPUT: 04:06:49 INFO - 2015-12-09 04:06:49,573 DEBUG : BROWSER_OUTPUT: 1449662809570 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] 04:09:01 INFO - 2015-12-09 04:09:01,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57091/tests/dromaeo/cssquery-ext.html) 04:09:02 INFO - 2015-12-09 04:09:02,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 220504064 04:09:02 INFO - 2015-12-09 04:09:02,660 DEBUG : BROWSER_OUTPUT: 04:12:05 INFO - 2015-12-09 04:12:05,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-ext.html (next: http://localhost:57091/tests/dromaeo/cssquery-jquery.html) 04:12:05 INFO - 2015-12-09 04:12:05,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 223883264 04:12:05 INFO - 2015-12-09 04:12:05,732 DEBUG : BROWSER_OUTPUT: 04:15:07 INFO - 2015-12-09 04:15:07,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57091/tests/dromaeo/cssquery-mootools.html) 04:15:08 INFO - 2015-12-09 04:15:08,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 221270016 04:15:08 INFO - 2015-12-09 04:15:08,308 DEBUG : BROWSER_OUTPUT: 04:18:10 INFO - 2015-12-09 04:18:10,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57091/tests/dromaeo/cssquery-prototype.html) 04:18:10 INFO - 2015-12-09 04:18:10,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 203538432 04:18:10 INFO - 2015-12-09 04:18:10,804 DEBUG : BROWSER_OUTPUT: 04:21:13 INFO - 2015-12-09 04:21:13,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57091/tests/dromaeo/cssquery-yui.html) 04:21:14 INFO - 2015-12-09 04:21:14,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 208211968 04:21:14 INFO - 2015-12-09 04:21:14,066 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/dromaeo/cssquery-yui.html (next: http://localhost:57091/tests/dromaeo/cssquery-dojo.html) 04:24:16 INFO - 2015-12-09 04:24:16,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 251871232 04:24:16 INFO - 2015-12-09 04:24:16,737 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:24:16 INFO - 2015-12-09 04:24:16,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:24:16 INFO - 2015-12-09 04:24:16,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:24:16 INFO - 2015-12-09 04:24:16,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:24:16 INFO - 2015-12-09 04:24:16,738 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.119245052907;2710.3766133789227;2712.213458097152;2720.442309326587;2750.477409292234;4443.511213766491;4553.134904368168;4632.6062284705795;4689.202835517962;4699.10716963777;4524.389207456992;4612.146752850716;4622.815087396509;4658.440987081546;4765.999140180557;4261.552536983619;4278.315469524877;4281.314989601664;4353.194658988082;4356.194104090745;4165.375193720935;4368.912621747563;4382.145481631083;4426.601605855472;4436.2458382074965;4328.415663885398;4334.718243314174;4354.825806967718;4411.536788637211;4425.09285596452;4300.397944287803;4348.130373925196;4350.58669426404;4352.194843953878;4382.649388048949;4261.4673165854265;4268.295731204347;4269.658427325807;4292.549282325342;4314.395984562164;4369.563043695637;4473;4509.706869053533;4552.544745525454;4611.4005179326805;5018.222175562793;5025;5063.265826455144;5074.5432911037815;5080.568151707109;4989.101961646902;4996.800127994876;5045.924311135299;5052.898942021139;5067.315912351859;4496.460424749051;4593.747343896051;4627.282771170474;4679.60223381013;4681.461631912305;5029.270755740397;5052.797888084509;5060.165072763027;5061.114304996685;5172.379314482287;4884.511548845158;4922.507749225048;4922.606191504743;4962.181240095416;4967.379077615298;5026.673266237756;5058.974705126451;5059.215821547592;5065.468125846733;5109.335786347751;4735.621150307967;4834.903301933941;4937.604991600663;5016.523430274118;5020.673656212408;4891.095147397743;4959.082569724613;5045.369328833895;5074.08666440037;5083.694978301313;4154.688398370074;4157.064660451374;4157.521884983265;4161.063760653889;4200.831966721358;3640.8179591020344;3643.3806252937065;3652.196516766307;3668.3763760160837;3684.1158122050515;4173.812178451977;4267.274563324242;4276.615104640598;4281.935770963438;4374.606285434263;5006.74966251686;5014.874628134326;5018.89962200754;5024.522670346311;5064.4935506449065;4359.476862776423;4360.738355698668;4360.825566977349;4361.302191649321;4403.911921761547;4230.090530535888;4323.827046918151;4348.217320882271;4351.912961740747;4413.8234470621455;4797.832075877397;4821.325014497973;4832.927506087482;4839.782209800638;4873.171560834596;5082.745862706776;5093.541581257705;5093.694378337312;5094.643374963717;5148.3564554430695;4593.471750748573;4601.401817763669;4705.64707646921;4705.929411058768;4711.693739906895;4932.21084626458;4987.526185012418;4996.125678006407;4996.875078123076;5045.445001049955;5041.697498150123;5065.240213967934;5079.847604571869;5081.796728130834;5126.384833819965;4575.359449676981;4679.157751604744;4681.133990211822;4759.3336932830125;4871.5128487151005;4844.103840789465;4874.975625121851;4884.658073934933;4885.267209918398;4924.852254432372;4785.521447855187;4799.3760811094335;4804.3273941648895;4805.399325084364;4812.133815913029;4730.621550276039;4814.518548145157;4832.371791667061;4833.685810422311;4909.95090049095;4785.114753770564;4809.855704328876;4818.204996175732;4832.275158726219;4873.293372461044 04:24:16 INFO - 2015-12-09 04:24:16,739 DEBUG : BROWSER_OUTPUT: |1;ext.html;511.08515756795316;521.8121476268544;526.5156056428086;530.7293280426981;554.5175697143486;25716.099936502225;33990.49014264785;34279.4858077129;34326;34632.82683586579;39289.60710392895;39812.80093599535;39857.40213896794;39863.202735945335;40290.59709402905;6929.896051559231;7006.789796306093;7844.450888437812;8018.198180181965;8023.3180179684505;10136.087752102309;10386.584536618526;10386.688399348031;10400.479976001208;10404.115650169744;10023.198144148488;10113.342632728849;10116.14012808912;10119.797604047915;10127.392356458598;7087.433005359559;7284.74503392384;7286.089238845145;10053.346532475402;10217.978202179796;9821.90178098217;9954.253430992632;9957.4025558466;9958.103770660675;9960.203183745283;36309.455358169645;36786.448203276974;36886.631133688585;36902.26195476102;36973;2948.498755211619;2954.70452954705;2969.5100308449296;2997.955030674542;3598.6941110005682;27480.58779118315;27595;27815.443691126267;27917.441651167064;28013.43973120526;3317.1872891141584;3512.8594856205723;3521.102118959649;3524.0837382280533;3624.3294990426857;204828;205911;207012.96493517587;207281;207438;51746.74126629343;51798.22302665463;52157.73921130446;53002.469975300526;62090.37909620936;55113.44886551164;55146.72426637921;55286.72356638191;55338.72330638321;55341.723291383285;14471.204083775494;14604;14661.780073298909;14688.926555367154;14702.926485367505;10694;10742.496050552772;10763.623273185558;10773.299735517166;10773.515191816387;19075.2369905205;19115.61768764617;19212.519687007658;19217.231310747695;19321.613567728848;7596.620168991528;7738.303552680173;7849.882251766228;7925.722599708983;7940.444168908121;870.8998465176459;922.0456827183832;930.8743319651895;976.8241716490958;1001.6043662753317;24662.753372466046;25017.4996500069;25029.62455563168;25035.62446563303;25133.497330053295;941.2846236859899;985.6599473181741;994.7562847102362;1003.533356988989;1065.6802959112235;13197;13306.268155251553;15350.923245383701;16433.91783041101;16555.6688866222;305913;310068;311124;311217;311446;47313.290300645516;47787.76106119447;47798.5220147801;47851.5214847854;47855;980.7548112971757;1110.722319420145;1131.1572878205625;1247.8814512621286;1261.7602655495427;25670.61494077628;25739.485210295315;26292;30167.547486788153;31085.378292434478;44024.7798761017;44641.77679111713;44746.77626611846;44784;44797;327173;332072;363456;363480;365467;37651.246975060894;37828.43257351087;37956.62043379531;38069;38077;41424.792876035426;41433.37849932314;41916.371254430596;41940.790296048326;42252;34605.99356195362;34950.82524587361;35149.121271967386;35841.82079089588;36146.27707445784;34265.18569594108;35063.82468087643;35385.46921796124;35605.64394356023;35613.465798012534;34179.14552136217;34763.826180868935;35150.648493515764;35476.290474190886;35591.82204088963;29824;32034.839825800722;32066.519002215453;32096;32136.839315804205;24590.508189835746;24614;24857.1300004499;26417;26890 04:24:16 INFO - 2015-12-09 04:24:16,740 DEBUG : BROWSER_OUTPUT: |2;jquery.html;264.3681600973673;268.66014491668057;271.4679228711724;274.0285687238739;274.6896007511512;10641.467926603678;15770.4480343188;16354.672906541877;16371.427000054986;16466.75299870503;9454.574544145513;9716.0769726876;9737.659181928633;16341;16704;4437.889052773674;4601.12578610063;4601.6548758843055;4605.999999999984;4606.101810147006;4566.132434837386;4596.816127354902;4599.241125214336;4599.471060828014;4607.907841843161;3421.4525675891864;3516.3846326892817;4572.245579479382;4580.541945805426;5059.519345662175;5165.819196328111;5208.244804503363;5216.660917040399;5225.399079105913;5230.686158830464;4929.901401971976;5014.799408023675;5033.043721692867;5068.493150684939;5083.542481176675;16016.35934562616;16042.438514652047;16587.751183732253;18220.36228731988;18251.361202357988;1780.2078075256516;1817.3548390321378;1818.97271540927;1831.633673265339;1897.9145938432803;8501.82996340076;9007;9385.765355866159;10760.3543787373;12868.806967895489;1701.123921180593;1726.2577091850499;1736.40094167512;1778.662054209696;1796.0750213639985;46447.535524644656;56170;56445.71777141129;57305.999999999585;57918.13122803161;9666.468344240993;9725.270604704676;9749.561269742879;9753.902460975441;9796.608135674493;12185.573504927463;12190.51237950472;12197.93901030507;12198.878011219951;12203.267803931614;6957.756478523227;7010.789676309719;7011.404030657349;7042.471814613822;7049.68276427562;6671.266160722316;6683.465322774166;6730.822106131407;6745.392914637706;6756.628385438848;4121.402396652528;4128.050548373891;4166.958330416717;4186.1836941796055;4213.452251207324;1602.3430393538592;1646.209819286749;1656.892302000366;1669.9415520456726;1702.4381953955165;308.18485106892143;327.54961927349893;331.12582781456973;351.9155402703333;801.0627565748089;9341.673041443653;9497.337965855948;9559.187469065208;9652;9787.021297870298;752.1726101288539;838.7064527415356;842.3850589070013;886.7738726624669;960.6589660670361;8055.154208808108;8784.78038049054;8942.73171804847;9153.862692059625;9547.665831695856;481071;481381;487799;488029;490730;71919;74300.62849685717;74539.25460745323;74808;74900;1078.412265315405;1086.9239153259196;1094.2723089145788;1100.0979197058496;1100.6587957732968;14636;14868.85131148718;14989.625259368602;15006.249687515363;15262.542123736306;35249.82375088108;35293.82353088218;35494.46758298679;35885.820570896976;36413.27173456463;44944;46597.767011164724;47436.288455673886;48008.5199148004;49343.25985110298;8764.868526971974;8896.955515222382;8919.197272245528;8965.937834298018;8981.326400520118;12825.871741282841;16102.758458622895;16725.832741672428;16732.41436549715;16757.24592393321;13912.930435348164;14091;14198.290085495477;14405.135691858522;14418.855811441752;13265.469381224642;13453.529126480526;13688.589342319747;14008.579742607739;14009.43962241499;13671.726565468436;13754.862451375358;14030.438782448997;14299.356528956014;14567.854321457075;7041;8419.915800841913;8574.485530868167;8735.563221838756;8742;8748.25639820597;8801;12054.879451205727;13109.803352949522;13593.45626174942 04:24:16 INFO - 2015-12-09 04:24:16,741 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1412.4420853762758;1416.7591509443394;1444.6966137111206;1659.5104444188962;1733.878628496005;5956.5532585056135;6410.551261411703;6913.550619209755;7059.50583459158;7089.078419805431;6936.72253109875;7034.155901291852;7036.7185312587435;7066.7173313067415;7108.395786358153;2028.1076326416367;2062.247279742898;2063.164418410546;2064.1743302678974;2066.442060643625;2083.677030060343;2084.42678263478;2094.832413406924;2124.915003399862;2128.4146859613575;2039.5716899451058;2063.690446433032;2097.8846163461003;2098.0244186453297;2099.5276062885805;2063.2778527515325;2083.8853863037525;2089.56119214965;2089.56119214965;2090.540081182145;2051.3743308290964;2076.3874656976077;2092.6442504774072;2100.4013856051106;2104.2004038465284;7097.361237488651;7139.393151582121;7168.641567921583;7175.067241258603;7184.281571842826;4116.5060192777055;4167.895802604929;4201;4224.704270701052;4224.704270701052;2744.684361298456;2776.3475583237923;2777.805553611248;2799.692033876272;2858.285428642839;815.6207363575907;817.4073796497552;836.602613758466;838.861587838006;846.6190214403543;9242.815143697155;9371.76570585734;9395.671151509732;9439.433633981984;9450.4802235877;3790.77255364679;3799.0692280390926;3832.0994566276904;3873.8256778444475;3873.845046198177;8197.959010204911;8270.2556769891;8283.047449543259;8285.544295063708;8296.211859873303;4173.353130264813;4178.435911151955;4186.476690413699;4190.413342132104;4197.391378250137;3260.9021729348156;3329.667033296651;3807.904802379963;3816.3512202925567;3817.9691483299353;3415.3852306585054;3433.6051354094097;3455.2053027803245;3466.757326987087;3467.878624248139;1047.6699839550517;1070.0476575847501;1072.7103682005816;1076.520948178069;1081.2755453845941;943.0522325063405;1124.9818913882948;1157.3576664951033;1170.5727409495644;1173.5540494611994;6775.288594697486;6792.354726300993;6870.931290687129;6875.931240687529;6877.2091209510545;953.7615596100975;954.5704433005176;1045.843123531461;1055.693848783844;1075.424647813416;5285.154375299933;5369.1140961740875;5401.405845357008;5427.945720542744;5428.75570599324;8451.408401411842;8651.437656552303;8669.739907802776;8676.305895528343;8683.52240626759;8415.621297041647;8530.530820804915;8533.274671652978;8541.658333666708;8549.743507694779;6333.461655759312;6372.713227904663;6374.936250637527;6375.968120159462;6399.168108145911;6372.490200784019;6442.549021568445;6458.580192287486;6472.223333200046;6486.740530378921;7568.205338439385;7624.504407213513;7630.389568834369;7681.385489160742;7687.961560192163;7745.535267883945;7818.218178182136;7920.089189743253;7927.405444591794;7932.6033698316005;5158.200478925773;5265.6840589564745;5277.656952298088;5880.26496687914;5956.702164891824;5801.622894511843;5815.244018277766;6477.740890364333;6624.436922861418;6634.071230027704;6367.61794292344;6441.935580644134;6455.9677201613695;6458.451031662174;6534.8366290843105;6232.688365581612;6304;6351.650659213788;6368.299487056327;6424.38968298011;6339.683015849281;6372.9362706374195;6378.74485020594;6380.489560835029;6400.39196276353;5936.1986131871645;5958.344582096052;5989.101634754822;6008;6010.789622363196;5957.195778569838;6001.399860013964;6008.819735407945;6017.458428741435;6017.759289628366 04:24:16 INFO - 2015-12-09 04:24:16,742 DEBUG : BROWSER_OUTPUT: |4;prototype.html;250.4602581437003;251.1648767846909;257.63801858388956;258.28326394255936;261.02897222332916;5313.123334649783;5319.893602127955;5338.386085600162;5365.409804921455;5365.624406291561;4941.901161976758;4990.875228119299;5146.176611742122;5271.578273738101;5275.498827611371;4034.475518182632;4034.8587799427028;4036.7376120552144;4038.030872590572;4042.43405923171;4017.919641607166;4025.778582177979;4030.8992275193064;4031.6573091287128;4045.474088368508;3800.847966081353;3870.748401353903;3898.142408670102;3926.725129240954;3936.5866584008695;3975.483187185662;3977.7215594908366;3985.5217373915025;3989.122393073519;3990.880273591768;3423.9486407703903;3427.006168211216;3429.8456569454434;3429.879954201591;3435.0725304167736;5101.948980510185;5101.974490127525;5111.028904508132;5117.181250999859;5119.10415677255;4565.680402371835;4572.634189264851;4573.291139873325;4575.405197324327;4576.061907308994;5530.640508366943;5548.389677135512;5554.055810512223;5554.361248456398;5567.749451274703;3732.850685972558;3742.925141497182;3748.11919198988;3749.0439937815954;3754.9812250938844;5837.182794408786;5852.941470585282;5864.912026319608;5869.8239052828485;5884.882302353972;3582.17609949713;3654.3970244909824;3712.0719820044988;3841.1357444575306;3845.673117784964;3822.6177382261553;3926.1362500249897;3947.111899822517;3949.3681011038097;3950.7234493585747;4553.704009239455;4559.908801823945;4564.1556312082375;4570.88572785683;4572.7713614319155;5577.2191893135;5579.69311687861;5581.079121944915;5585.245991791137;5587.217789509472;1361.4503854177874;1363.4409891944454;1383.4327925550476;1388.257282353956;1389.1040279019976;905.6830109461636;930.2743859789375;932.1238036245907;934.6635211323918;940.1961323068814;4927.088488629615;4935.827246046371;4938.2839488274;4942.9258561121615;4955.851324460272;5779.075347944308;5787.450192231731;5788.594798364074;5788.710564471759;5789.681567513743;4930.704157750546;4931.038447502702;4941.160002799533;4941.72820494869;4942;3012.864421101012;3084.5373194021076;3092.6134233220846;3104.456720073978;3127.4370613289825;5407.107827208467;5463.07127788269;5473.06957817172;5475.151351540518;5476.58925580583;5922.585419020627;5945.464908158287;5945.524358051345;5954.523638108941;5954.910676339859;5465.234867118606;5466.562674985912;5467.0705979983495;5474.042042642442;5474.91787623186;5613.719314034201;5770.971145144247;5806;5825.970870145622;5846.970765146147;5678.716064196691;5680.176374425768;5706.629069110494;5709.143628455598;5711.600187986967;5517.062099443024;5522.475364840334;5523.6409633373705;5525.475079867406;5528.44715528444;3655.561332639994;3724.851005959731;3756.6243375662216;3760.5487341519192;3760.699144068523;5815.447532484407;5822.970885145716;5829.621074630136;5832.300123984979;5832.650040997553;5596.216529685928;5597.972010140086;5604.579656525859;5605.915911261252;5606.187102870143;5571.0807716726285;5571.66570005801;5576.219329293983;5584.0507113789945;5584.748686309207;5344.064788662046;5484.067708489487;5489.451054894478;5502.58730595215;5521.917171242354;5652.745626446737;5655.264815573949;5657;5660;5660.51885589713;5482.616216864782;5495.917561236504;5499.835004949858;5504.174373843955;5508.586855985737 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: |5;yui.html;626.840155760281;660.824881406427;669.323982777395;698.3016983016983;701.9751163301579;12283.850326192915;12349.259044457338;12492.188007779489;12497.187682800622;12543.560975365865;11470.197086203969;11963.222390544608;12001.819972700416;12032.398380080982;12035.398230088504;637.9011253255753;643.9903401448983;795.5306369242131;810.6878851642131;812.6058861452191;798.8522123407188;808.1675873849944;814.5479259011246;815.4169768615438;816.1756625807947;830.779843341515;848.4442690038035;849.413904405961;850.0097386544699;850.3834719828137;654.8166513376239;660.9173853268318;836.1178956201205;837.9162083791633;855.5422848775875;627.2974268818906;627.6924307089539;628.475223188638;630.0297541785644;630.0391902348908;12346.753064938652;12367.567135150226;12375.257484550955;12383.318917459535;12404.441800119017;11003.119750419946;11332.43337833105;11363.659090227224;11377.544898204062;11551.191416600841;9488.905110948872;9557.283203759745;9744.415335079917;9811.313208075437;9867.703968880945;3200.8239546824916;3249.8537565809597;3252.1219270796987;3284.638689744126;3309.7848639838335;38375.232495349934;38482;38488.422673659916;38623.806880965414;39718.40422393638;9339.392939458914;9392.389494682824;9442.055794420641;9503.524823758784;9527.237820974306;16642.251098700588;16652.50042498727;16667;16739.83260167383;16799.748003779954;6215.502759779207;6322.146510221153;6350.33321501245;6430.3891130342545;6571.638559879252;3433.261848702541;3465.0887104374006;3500.3524347995703;3534.8708222115006;3612.2956023575675;2676.34429564754;2695.191442567222;2697.5953606959115;2702.7702395410042;2711.051132103748;474.61556139527096;480.68034756886976;481.379021062825;483.439210515807;486.86124454530994;453.67562193031483;562.4027761158248;583.9124131380242;588.6997631208114;597.7369957218897;7237.89143162853;7601.277878601524;7671.769846904602;8010.879836802453;8689.348298877609;456.83325586161476;522.9660072095378;581.7731084876901;618.42486487567;627.5481653209682;3385.1770428692953;3625.655562721537;3736.7197460190596;3776.3202623528027;3879.1078052048188;48052.5194748055;48569;48579.028419431415;48745;48790.26814597784;43691;44003.11993760107;44033;44364.11271774546;44569.55430445719;36248;37343.813280933966;37488.2502349946;38052.429213561816;38113.809430953224;7640.770776876702;7802.180771018961;7856.921430785619;7994.680212791423;8064.919350806652;30142;30317;30684.84657576698;30999.380012400077;31786.682133179296;38335.80832095822;38808.41787373135;38819.417708733825;38826.6117338823;39116.2176756469;9952.55213515379;10120.291579589653;10160.187185025032;10227.539760710935;10369.896301037195;11120.944395277971;11230.21388502797;11257.437128143396;11311.264767790068;11652.825207622061;10266.691999240034;10314.225937274003;10449.164066874784;10566.366018038942;10627;10648.40428448247;10665.146788257076;10771.13830893511;10909.672709818718;10910.781784364426;10032.899671003197;10068.69793906184;10147.492625368553;10300.793984120426;10480.63317783874;8586.098459661895;8594.183552562497;8649.654013839376;8774.122587741174;8781.517016563896;8461.153884611489;8474.66101355939;8714.520701361485;8831.735047948572;8857.822843543221 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,989 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: __startTimestamp1449663856734__endTimestamp 04:24:16 INFO - 2015-12-09 04:24:16,743 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,744 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4616.39 Median:4730.62 stddev:483.70 (10.2%) stddev-sans-first:459.37 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: Values: 2629.1 2710.4 2712.2 2720.4 2750.5 4443.5 4553.1 4632.6 4689.2 4699.1 4524.4 4612.1 4622.8 4658.4 4766.0 4261.6 4278.3 4281.3 4353.2 4356.2 4165.4 4368.9 4382.1 4426.6 4436.2 4328.4 4334.7 4354.8 4411.5 4425.1 4300.4 4348.1 4350.6 4352.2 4382.6 4261.5 4268.3 4269.7 4292.5 4314.4 4369.6 4473.0 4509.7 4552.5 4611.4 5018.2 5025.0 5063.3 5074.5 5080.6 4989.1 4996.8 5045.9 5052.9 5067.3 4496.5 4593.7 4627.3 4679.6 4681.5 5029.3 5052.8 5060.2 5061.1 5172.4 4884.5 4922.5 4922.6 4962.2 4967.4 5026.7 5059.0 5059.2 5065.5 5109.3 4735.6 4834.9 4937.6 5016.5 5020.7 4891.1 4959.1 5045.4 5074.1 5083.7 4154.7 4157.1 4157.5 4161.1 4200.8 3640.8 3643.4 3652.2 3668.4 3684.1 4173.8 4267.3 4276.6 4281.9 4374.6 5006.7 5014.9 5018.9 5024.5 5064.5 4359.5 4360.7 4360.8 4361.3 4403.9 4230.1 4323.8 4348.2 4351.9 4413.8 4797.8 4821.3 4832.9 4839.8 4873.2 5082.7 5093.5 5093.7 5094.6 5148.4 4593.5 4601.4 4705.6 4705.9 4711.7 4932.2 4987.5 4996.1 4996.9 5045.4 5041.7 5065.2 5079.8 5081.8 5126.4 4575.4 4679.2 4681.1 4759.3 4871.5 4844.1 4875.0 4884.7 4885.3 4924.9 4785.5 4799.4 4804.3 4805.4 4812.1 4730.6 4814.5 4832.4 4833.7 4910.0 4785.1 4809.9 4818.2 4832.3 4873.3 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45123.99 Median:35007.32 stddev:77474.90 (221.3%) stddev-sans-first:77619.83 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: Values: 511.1 521.8 526.5 530.7 554.5 25716.1 33990.5 34279.5 34326.0 34632.8 39289.6 39812.8 39857.4 39863.2 40290.6 6929.9 7006.8 7844.5 8018.2 8023.3 10136.1 10386.6 10386.7 10400.5 10404.1 10023.2 10113.3 10116.1 10119.8 10127.4 7087.4 7284.7 7286.1 10053.3 10218.0 9821.9 9954.3 9957.4 9958.1 9960.2 36309.5 36786.4 36886.6 36902.3 36973.0 2948.5 2954.7 2969.5 2998.0 3598.7 27480.6 27595.0 27815.4 27917.4 28013.4 3317.2 3512.9 3521.1 3524.1 3624.3 204828.0 205911.0 207013.0 207281.0 207438.0 51746.7 51798.2 52157.7 53002.5 62090.4 55113.4 55146.7 55286.7 55338.7 55341.7 14471.2 14604.0 14661.8 14688.9 14702.9 10694.0 10742.5 10763.6 10773.3 10773.5 19075.2 19115.6 19212.5 19217.2 19321.6 7596.6 7738.3 7849.9 7925.7 7940.4 870.9 922.0 930.9 976.8 1001.6 24662.8 25017.5 25029.6 25035.6 25133.5 941.3 985.7 994.8 1003.5 1065.7 13197.0 13306.3 15350.9 16433.9 16555.7 305913.0 310068.0 311124.0 311217.0 311446.0 47313.3 47787.8 47798.5 47851.5 47855.0 980.8 1110.7 1131.2 1247.9 1261.8 25670.6 25739.5 26292.0 30167.5 31085.4 44024.8 44641.8 44746.8 44784.0 44797.0 327173.0 332072.0 363456.0 363480.0 365467.0 37651.2 37828.4 37956.6 38069.0 38077.0 41424.8 41433.4 41916.4 41940.8 42252.0 34606.0 34950.8 35149.1 35841.8 36146.3 34265.2 35063.8 35385.5 35605.6 35613.5 34179.1 34763.8 35150.6 35476.3 35591.8 29824.0 32034.8 32066.5 32096.0 32136.8 24590.5 24614.0 24857.1 26417.0 26890.0 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,745 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26203.63 Median:4569.19 stddev:79473.61 (1739.3%) stddev-sans-first:79672.68 04:24:16 INFO - 2015-12-09 04:24:16,746 DEBUG : BROWSER_OUTPUT: Values: 264.4 268.7 271.5 274.0 274.7 10641.5 15770.4 16354.7 16371.4 16466.8 9454.6 9716.1 9737.7 16341.0 16704.0 4437.9 4601.1 4601.7 4606.0 4606.1 4566.1 4596.8 4599.2 4599.5 4607.9 3421.5 3516.4 4572.2 4580.5 5059.5 5165.8 5208.2 5216.7 5225.4 5230.7 4929.9 5014.8 5033.0 5068.5 5083.5 16016.4 16042.4 16587.8 18220.4 18251.4 1780.2 1817.4 1819.0 1831.6 1897.9 8501.8 9007.0 9385.8 10760.4 12868.8 1701.1 1726.3 1736.4 1778.7 1796.1 46447.5 56170.0 56445.7 57306.0 57918.1 9666.5 9725.3 9749.6 9753.9 9796.6 12185.6 12190.5 12197.9 12198.9 12203.3 6957.8 7010.8 7011.4 7042.5 7049.7 6671.3 6683.5 6730.8 6745.4 6756.6 4121.4 4128.1 4167.0 4186.2 4213.5 1602.3 1646.2 1656.9 1669.9 1702.4 308.2 327.5 331.1 351.9 801.1 9341.7 9497.3 9559.2 9652.0 9787.0 752.2 838.7 842.4 886.8 960.7 8055.2 8784.8 8942.7 9153.9 9547.7 481071.0 481381.0 487799.0 488029.0 490730.0 71919.0 74300.6 74539.3 74808.0 74900.0 1078.4 1086.9 1094.3 1100.1 1100.7 14636.0 14868.9 14989.6 15006.2 15262.5 35249.8 35293.8 35494.5 35885.8 36413.3 44944.0 46597.8 47436.3 48008.5 49343.3 8764.9 8897.0 8919.2 8965.9 8981.3 12825.9 16102.8 16725.8 16732.4 16757.2 13912.9 14091.0 14198.3 14405.1 14418.9 13265.5 13453.5 13688.6 14008.6 14009.4 13671.7 13754.9 14030.4 14299.4 14567.9 7041.0 8419.9 8574.5 8735.6 8742.0 8748.3 8801.0 12054.9 13109.8 13593.5 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4920.98 Median:6008.41 stddev:2534.51 (42.2%) stddev-sans-first:2527.90 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: Values: 1412.4 1416.8 1444.7 1659.5 1733.9 5956.6 6410.6 6913.6 7059.5 7089.1 6936.7 7034.2 7036.7 7066.7 7108.4 2028.1 2062.2 2063.2 2064.2 2066.4 2083.7 2084.4 2094.8 2124.9 2128.4 2039.6 2063.7 2097.9 2098.0 2099.5 2063.3 2083.9 2089.6 2089.6 2090.5 2051.4 2076.4 2092.6 2100.4 2104.2 7097.4 7139.4 7168.6 7175.1 7184.3 4116.5 4167.9 4201.0 4224.7 4224.7 2744.7 2776.3 2777.8 2799.7 2858.3 815.6 817.4 836.6 838.9 846.6 9242.8 9371.8 9395.7 9439.4 9450.5 3790.8 3799.1 3832.1 3873.8 3873.8 8198.0 8270.3 8283.0 8285.5 8296.2 4173.4 4178.4 4186.5 4190.4 4197.4 3260.9 3329.7 3807.9 3816.4 3818.0 3415.4 3433.6 3455.2 3466.8 3467.9 1047.7 1070.0 1072.7 1076.5 1081.3 943.1 1125.0 1157.4 1170.6 1173.6 6775.3 6792.4 6870.9 6875.9 6877.2 953.8 954.6 1045.8 1055.7 1075.4 5285.2 5369.1 5401.4 5427.9 5428.8 8451.4 8651.4 8669.7 8676.3 8683.5 8415.6 8530.5 8533.3 8541.7 8549.7 6333.5 6372.7 6374.9 6376.0 6399.2 6372.5 6442.5 6458.6 6472.2 6486.7 7568.2 7624.5 7630.4 7681.4 7688.0 7745.5 7818.2 7920.1 7927.4 7932.6 5158.2 5265.7 5277.7 5880.3 5956.7 5801.6 5815.2 6477.7 6624.4 6634.1 6367.6 6441.9 6456.0 6458.5 6534.8 6232.7 6304.0 6351.7 6368.3 6424.4 6339.7 6372.9 6378.7 6380.5 6400.4 5936.2 5958.3 5989.1 6008.0 6010.8 5957.2 6001.4 6008.8 6017.5 6017.8 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4583.47 Median:5316.51 stddev:1395.83 (26.3%) stddev-sans-first:1361.33 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: Values: 250.5 251.2 257.6 258.3 261.0 5313.1 5319.9 5338.4 5365.4 5365.6 4941.9 4990.9 5146.2 5271.6 5275.5 4034.5 4034.9 4036.7 4038.0 4042.4 4017.9 4025.8 4030.9 4031.7 4045.5 3800.8 3870.7 3898.1 3926.7 3936.6 3975.5 3977.7 3985.5 3989.1 3990.9 3423.9 3427.0 3429.8 3429.9 3435.1 5101.9 5102.0 5111.0 5117.2 5119.1 4565.7 4572.6 4573.3 4575.4 4576.1 5530.6 5548.4 5554.1 5554.4 5567.7 3732.9 3742.9 3748.1 3749.0 3755.0 5837.2 5852.9 5864.9 5869.8 5884.9 3582.2 3654.4 3712.1 3841.1 3845.7 3822.6 3926.1 3947.1 3949.4 3950.7 4553.7 4559.9 4564.2 4570.9 4572.8 5577.2 5579.7 5581.1 5585.2 5587.2 1361.5 1363.4 1383.4 1388.3 1389.1 905.7 930.3 932.1 934.7 940.2 4927.1 4935.8 4938.3 4942.9 4955.9 5779.1 5787.5 5788.6 5788.7 5789.7 4930.7 4931.0 4941.2 4941.7 4942.0 3012.9 3084.5 3092.6 3104.5 3127.4 5407.1 5463.1 5473.1 5475.2 5476.6 5922.6 5945.5 5945.5 5954.5 5954.9 5465.2 5466.6 5467.1 5474.0 5474.9 5613.7 5771.0 5806.0 5826.0 5847.0 5678.7 5680.2 5706.6 5709.1 5711.6 5517.1 5522.5 5523.6 5525.5 5528.4 3655.6 3724.9 3756.6 3760.5 3760.7 5815.4 5823.0 5829.6 5832.3 5832.7 5596.2 5598.0 5604.6 5605.9 5606.2 5571.1 5571.7 5576.2 5584.1 5584.7 5344.1 5484.1 5489.5 5502.6 5521.9 5652.7 5655.3 5657.0 5660.0 5660.5 5482.6 5495.9 5499.8 5504.2 5508.6 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: 04:24:16 INFO - 2015-12-09 04:24:16,747 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12051.80 Median:44018.06 stddev:13365.64 (30.4%) stddev-sans-first:13375.60 04:24:16 INFO - 2015-12-09 04:24:16,748 DEBUG : BROWSER_OUTPUT: Values: 626.8 660.8 669.3 698.3 702.0 12283.9 12349.3 12492.2 12497.2 12543.6 11470.2 11963.2 12001.8 12032.4 12035.4 637.9 644.0 795.5 810.7 812.6 798.9 808.2 814.5 815.4 816.2 830.8 848.4 849.4 850.0 850.4 654.8 660.9 836.1 837.9 855.5 627.3 627.7 628.5 630.0 630.0 12346.8 12367.6 12375.3 12383.3 12404.4 11003.1 11332.4 11363.7 11377.5 11551.2 9488.9 9557.3 9744.4 9811.3 9867.7 3200.8 3249.9 3252.1 3284.6 3309.8 38375.2 38482.0 38488.4 38623.8 39718.4 9339.4 9392.4 9442.1 9503.5 9527.2 16642.3 16652.5 16667.0 16739.8 16799.7 6215.5 6322.1 6350.3 6430.4 6571.6 3433.3 3465.1 3500.4 3534.9 3612.3 2676.3 2695.2 2697.6 2702.8 2711.1 474.6 480.7 481.4 483.4 486.9 453.7 562.4 583.9 588.7 597.7 7237.9 7601.3 7671.8 8010.9 8689.3 456.8 523.0 581.8 618.4 627.5 3385.2 3625.7 3736.7 3776.3 3879.1 48052.5 48569.0 48579.0 48745.0 48790.3 43691.0 44003.1 44033.0 44364.1 44569.6 36248.0 37343.8 37488.3 38052.4 38113.8 7640.8 7802.2 7856.9 7994.7 8064.9 30142.0 30317.0 30684.8 30999.4 31786.7 38335.8 38808.4 38819.4 38826.6 39116.2 9952.6 10120.3 10160.2 10227.5 10369.9 11120.9 11230.2 11257.4 11311.3 11652.8 10266.7 10314.2 10449.2 10566.4 10627.0 10648.4 10665.1 10771.1 10909.7 10910.8 10032.9 10068.7 10147.5 10300.8 10480.6 8586.1 8594.2 8649.7 8774.1 8781.5 8461.2 8474.7 8714.5 8831.7 8857.8 04:24:16 INFO - 2015-12-09 04:24:16,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:24:16 INFO - 2015-12-09 04:24:16,748 DEBUG : BROWSER_OUTPUT: 04:24:17 INFO - 2015-12-09 04:24:17,467 INFO : Browser exited with error code: 0 04:24:17 INFO - 2015-12-09 04:24:17,488 INFO : Completed test dromaeo_css (00:18:37) 04:24:17 INFO - 2015-12-09 04:24:17,488 INFO : Starting test kraken 04:24:17 INFO - 2015-12-09 04:24:17,488 DEBUG : operating with platform_type : linux_ 04:24:17 INFO - 2015-12-09 04:24:17,489 INFO : Initialising browser for kraken test... 04:24:17 INFO - 2015-12-09 04:24:17,495 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN5Swv/profile http://localhost:57091/getInfo.html 04:24:21 INFO - 2015-12-09 04:24:21,619 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:24:21 INFO - 2015-12-09 04:24:21,619 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:24:21 INFO - 2015-12-09 04:24:21,619 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:24:21 INFO - 2015-12-09 04:24:21,619 DEBUG : BROWSER_OUTPUT: __metrics 04:24:21 INFO - 2015-12-09 04:24:21,777 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:24:21 INFO - 2015-12-09 04:24:21,845 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:22 INFO - 2015-12-09 04:24:22,964 INFO : Browser initialized. 04:24:22 INFO - 2015-12-09 04:24:22,965 INFO : Running cycle 1/1 for kraken test... 04:24:22 INFO - 2015-12-09 04:24:22,965 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN5Swv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:24:34 INFO - 2015-12-09 04:24:34,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 142516224 04:24:34 INFO - 2015-12-09 04:24:34,974 DEBUG : BROWSER_OUTPUT: 04:24:37 INFO - 2015-12-09 04:24:37,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57091/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:38 INFO - 2015-12-09 04:24:38,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 176050176 04:24:38 INFO - 2015-12-09 04:24:38,202 DEBUG : BROWSER_OUTPUT: 04:24:40 INFO - 2015-12-09 04:24:40,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57091/tests/kraken/driver.html?testName=audio-dft) 04:24:41 INFO - 2015-12-09 04:24:41,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 166543360 04:24:41 INFO - 2015-12-09 04:24:41,500 DEBUG : BROWSER_OUTPUT: 04:24:44 INFO - 2015-12-09 04:24:44,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57091/tests/kraken/driver.html?testName=audio-fft) 04:24:45 INFO - 2015-12-09 04:24:45,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 154382336 04:24:45 INFO - 2015-12-09 04:24:45,100 DEBUG : BROWSER_OUTPUT: 04:24:47 INFO - 2015-12-09 04:24:47,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57091/tests/kraken/driver.html?testName=audio-oscillator) 04:24:47 INFO - 2015-12-09 04:24:47,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 154578944 04:24:47 INFO - 2015-12-09 04:24:47,719 DEBUG : BROWSER_OUTPUT: 04:24:49 INFO - 2015-12-09 04:24:49,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:50 INFO - 2015-12-09 04:24:50,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 156827648 04:24:50 INFO - 2015-12-09 04:24:50,522 DEBUG : BROWSER_OUTPUT: 04:24:53 INFO - 2015-12-09 04:24:53,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57091/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:54 INFO - 2015-12-09 04:24:54,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 156852224 04:24:54 INFO - 2015-12-09 04:24:54,088 DEBUG : BROWSER_OUTPUT: 04:24:57 INFO - 2015-12-09 04:24:57,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57091/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:58 INFO - 2015-12-09 04:24:58,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 157966336 04:24:58 INFO - 2015-12-09 04:24:58,071 DEBUG : BROWSER_OUTPUT: 04:25:00 INFO - 2015-12-09 04:25:00,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57091/tests/kraken/driver.html?testName=json-parse-financial) 04:25:01 INFO - 2015-12-09 04:25:01,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 157806592 04:25:01 INFO - 2015-12-09 04:25:01,522 DEBUG : BROWSER_OUTPUT: 04:25:03 INFO - 2015-12-09 04:25:03,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:03 INFO - 2015-12-09 04:25:03,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 166563840 04:25:03 INFO - 2015-12-09 04:25:03,910 DEBUG : BROWSER_OUTPUT: 04:25:05 INFO - 2015-12-09 04:25:05,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:06 INFO - 2015-12-09 04:25:06,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 167370752 04:25:06 INFO - 2015-12-09 04:25:06,395 DEBUG : BROWSER_OUTPUT: 04:25:08 INFO - 2015-12-09 04:25:08,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:09 INFO - 2015-12-09 04:25:09,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 180084736 04:25:09 INFO - 2015-12-09 04:25:09,074 DEBUG : BROWSER_OUTPUT: 04:25:11 INFO - 2015-12-09 04:25:11,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:12 INFO - 2015-12-09 04:25:12,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 182550528 04:25:12 INFO - 2015-12-09 04:25:12,182 DEBUG : BROWSER_OUTPUT: 04:25:14 INFO - 2015-12-09 04:25:14,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:15 INFO - 2015-12-09 04:25:15,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 181207040 04:25:15 INFO - 2015-12-09 04:25:15,411 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57091/tests/kraken/driver.html?testName=ai-astar) 04:25:17 INFO - 2015-12-09 04:25:17,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 239263744 04:25:17 INFO - 2015-12-09 04:25:17,444 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;117;111;115;114;112;104;114;113;106 04:25:17 INFO - 2015-12-09 04:25:17,448 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;132;152;170;130;153;153;137;167;128 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;165;163;161;162;163;162;161 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;81;95;73;75;72;97;95;71 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;96;133;94;94;94;132;96;96;130 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;109 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;145;146;146;146;146;146;146;147 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;96;98;96;96;96 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;84;73;74;75;74;75;82;72;71 04:25:17 INFO - 2015-12-09 04:25:17,449 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;68;68;68;68 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;83;84;85;84;86;85;84 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;118;120;118;131;125;131;136;125;126 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;148;152;153;137;140;148;159;147;139 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;74;70;69;69;69;69;70;70 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1017 04:25:17 INFO - 2015-12-09 04:25:17,450 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:25:17 INFO - 2015-12-09 04:25:17,451 DEBUG : BROWSER_OUTPUT: __startTimestamp1449663917446__endTimestamp 04:25:17 INFO - 2015-12-09 04:25:17,451 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,458 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:114.00 stddev:4.06 (3.6%) stddev-sans-first:4.24 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: Values: 114.0 117.0 111.0 115.0 114.0 112.0 104.0 114.0 113.0 106.0 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.00 stddev:15.86 (10.4%) stddev-sans-first:15.81 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: Values: 164.0 132.0 152.0 170.0 130.0 153.0 153.0 137.0 167.0 128.0 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 165.0 163.0 161.0 162.0 163.0 162.0 161.0 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:78.00 stddev:11.07 (14.2%) stddev-sans-first:11.34 04:25:17 INFO - 2015-12-09 04:25:17,459 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 81.0 95.0 73.0 75.0 72.0 97.0 95.0 71.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.00 stddev:17.82 (19.0%) stddev-sans-first:18.37 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 133.0 94.0 94.0 94.0 132.0 96.0 96.0 130.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 96.0 98.0 96.0 96.0 96.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.40 Median:74.50 stddev:4.22 (5.7%) stddev-sans-first:4.45 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: Values: 74.0 84.0 73.0 74.0 75.0 74.0 75.0 82.0 72.0 71.0 04:25:17 INFO - 2015-12-09 04:25:17,460 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.15 (1.4%) stddev-sans-first:0.97 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 83.0 84.0 85.0 84.0 86.0 85.0 84.0 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:5.96 (4.7%) stddev-sans-first:6.27 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: Values: 128.0 118.0 120.0 118.0 131.0 125.0 131.0 136.0 125.0 126.0 04:25:17 INFO - 2015-12-09 04:25:17,461 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.00 stddev:6.95 (4.7%) stddev-sans-first:7.25 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: Values: 143.0 148.0 152.0 153.0 137.0 140.0 148.0 159.0 147.0 139.0 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.56 (2.2%) stddev-sans-first:1.62 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 74.0 70.0 69.0 69.0 69.0 69.0 70.0 70.0 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:25:17 INFO - 2015-12-09 04:25:17,462 DEBUG : BROWSER_OUTPUT: 04:25:18 INFO - 2015-12-09 04:25:18,355 INFO : Browser exited with error code: 0 04:25:18 INFO - 2015-12-09 04:25:18,409 INFO : Completed test kraken (00:01:00) 04:25:18 INFO - 2015-12-09 04:25:18,409 INFO : Starting test v8_7 04:25:18 INFO - 2015-12-09 04:25:18,409 DEBUG : operating with platform_type : linux_ 04:25:18 INFO - 2015-12-09 04:25:18,409 INFO : Initialising browser for v8_7 test... 04:25:18 INFO - 2015-12-09 04:25:18,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprxF8hX/profile http://localhost:57091/getInfo.html 04:25:22 INFO - 2015-12-09 04:25:22,616 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:25:22 INFO - 2015-12-09 04:25:22,616 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:25:22 INFO - 2015-12-09 04:25:22,616 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:25:22 INFO - 2015-12-09 04:25:22,616 DEBUG : BROWSER_OUTPUT: __metrics 04:25:22 INFO - 2015-12-09 04:25:22,733 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:22 INFO - 2015-12-09 04:25:22,797 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:24 INFO - 2015-12-09 04:25:24,035 INFO : Browser initialized. 04:25:24 INFO - 2015-12-09 04:25:24,036 INFO : Running cycle 1/1 for v8_7 test... 04:25:24 INFO - 2015-12-09 04:25:24,036 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprxF8hX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:25:36 INFO - 2015-12-09 04:25:36,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 142491648 04:25:36 INFO - 2015-12-09 04:25:36,055 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57091/tests/v8_7/run.html (next: http://localhost:57091/tests/v8_7/run.html) 04:25:57 INFO - 2015-12-09 04:25:57,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 443338752 04:25:57 INFO - 2015-12-09 04:25:57,689 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,689 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:25:57 INFO - 2015-12-09 04:25:57,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:25:57 INFO - 2015-12-09 04:25:57,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:25:57 INFO - 2015-12-09 04:25:57,690 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:25:57 INFO - 2015-12-09 04:25:57,690 DEBUG : BROWSER_OUTPUT: |0;Richards;167.000668002672 04:25:57 INFO - 2015-12-09 04:25:57,690 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.39117538005192 04:25:57 INFO - 2015-12-09 04:25:57,691 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 04:25:57 INFO - 2015-12-09 04:25:57,691 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 04:25:57 INFO - 2015-12-09 04:25:57,691 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 04:25:57 INFO - 2015-12-09 04:25:57,691 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 04:25:57 INFO - 2015-12-09 04:25:57,692 DEBUG : BROWSER_OUTPUT: |6;Boyer;12304.878048780487 04:25:57 INFO - 2015-12-09 04:25:57,692 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 04:25:57 INFO - 2015-12-09 04:25:57,692 DEBUG : BROWSER_OUTPUT: |8;Splay;606.060606060606 04:25:57 INFO - 2015-12-09 04:25:57,692 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:25:57 INFO - 2015-12-09 04:25:57,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:25:57 INFO - 2015-12-09 04:25:57,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1449663957687__endTimestamp 04:25:57 INFO - 2015-12-09 04:25:57,693 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:25:57 INFO - 2015-12-09 04:25:57,693 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:25:57 INFO - 2015-12-09 04:25:57,694 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,694 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,694 DEBUG : BROWSER_OUTPUT: Values: 167.0 04:25:57 INFO - 2015-12-09 04:25:57,694 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,694 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.39 Median:185.39 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: Values: 185.4 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: Values: 278.1 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: Values: 5191.7 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,695 DEBUG : BROWSER_OUTPUT: Values: 2014.1 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: Values: 785.5 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: Values: 12304.9 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: Values: 27216.2 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,696 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,697 DEBUG : BROWSER_OUTPUT: Values: 606.1 04:25:57 INFO - 2015-12-09 04:25:57,697 DEBUG : BROWSER_OUTPUT: 04:25:57 INFO - 2015-12-09 04:25:57,697 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:25:57 INFO - 2015-12-09 04:25:57,698 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:25:57 INFO - 2015-12-09 04:25:57,698 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:25:57 INFO - 2015-12-09 04:25:57,698 DEBUG : BROWSER_OUTPUT: 04:25:58 INFO - 2015-12-09 04:25:58,555 INFO : Browser exited with error code: 0 04:25:58 INFO - 2015-12-09 04:25:58,567 INFO : Completed test v8_7 (00:00:40) 04:25:58 INFO - 2015-12-09 04:25:58,746 INFO : Completed test suite (00:20:18) 04:25:58 INFO - 2015-12-09 04:25:58,746 DEBUG : Working with test: dromaeo_css 04:25:58 INFO - 2015-12-09 04:25:58,746 DEBUG : Generating results file: dromaeo_css 04:25:58 INFO - 2015-12-09 04:25:58,747 DEBUG : Working with test: kraken 04:25:58 INFO - 2015-12-09 04:25:58,747 DEBUG : Generating results file: kraken 04:25:58 INFO - 2015-12-09 04:25:58,748 INFO : javascript benchmark 04:25:58 INFO - 2015-12-09 04:25:58,748 DEBUG : Working with test: v8_7 04:25:58 INFO - 2015-12-09 04:25:58,748 DEBUG : Generating results file: v8_7 04:25:58 INFO - 2015-12-09 04:25:58,748 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:58 INFO - 2015-12-09 04:25:58,872 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:25:58 INFO - 2015-12-09 04:25:58,872 DEBUG : process_Request line: dromaeo_css 6266.84 graph.html#tests=[[72,94,35]] 04:25:58 INFO - 2015-12-09 04:25:58,872 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:58 INFO - 2015-12-09 04:25:58,910 DEBUG : process_Request line: kraken 1530.20 graph.html#tests=[[232,94,35]] 04:25:58 INFO - 2015-12-09 04:25:58,910 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:58 INFO - 2015-12-09 04:25:58,937 DEBUG : process_Request line: v8_7 19741.87 graph.html#tests=[[230,94,35]] 04:25:58 INFO - 2015-12-09 04:25:58,939 INFO : javascript benchmark 04:25:58 INFO - 2015-12-09 04:25:58,942 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.119245052907, 2710.3766133789227, 2712.213458097152, 2720.442309326587, 2750.477409292234, 4443.511213766491, 4553.134904368168, 4632.6062284705795, 4689.202835517962, 4699.10716963777, 4524.389207456992, 4612.146752850716, 4622.815087396509, 4658.440987081546, 4765.999140180557, 4261.552536983619, 4278.315469524877, 4281.314989601664, 4353.194658988082, 4356.194104090745, 4165.375193720935, 4368.912621747563, 4382.145481631083, 4426.601605855472, 4436.2458382074965, 4328.415663885398, 4334.718243314174, 4354.825806967718, 4411.536788637211, 4425.09285596452, 4300.397944287803, 4348.130373925196, 4350.58669426404, 4352.194843953878, 4382.649388048949, 4261.4673165854265, 4268.295731204347, 4269.658427325807, 4292.549282325342, 4314.395984562164, 4369.563043695637, 4473.0, 4509.706869053533, 4552.544745525454, 4611.4005179326805, 5018.222175562793, 5025.0, 5063.265826455144, 5074.5432911037815, 5080.568151707109, 4989.101961646902, 4996.800127994876, 5045.924311135299, 5052.898942021139, 5067.315912351859, 4496.460424749051, 4593.747343896051, 4627.282771170474, 4679.60223381013, 4681.461631912305, 5029.270755740397, 5052.797888084509, 5060.165072763027, 5061.114304996685, 5172.379314482287, 4884.511548845158, 4922.507749225048, 4922.606191504743, 4962.181240095416, 4967.379077615298, 5026.673266237756, 5058.974705126451, 5059.215821547592, 5065.468125846733, 5109.335786347751, 4735.621150307967, 4834.903301933941, 4937.604991600663, 5016.523430274118, 5020.673656212408, 4891.095147397743, 4959.082569724613, 5045.369328833895, 5074.08666440037, 5083.694978301313, 4154.688398370074, 4157.064660451374, 4157.521884983265, 4161.063760653889, 4200.831966721358, 3640.8179591020344, 3643.3806252937065, 3652.196516766307, 3668.3763760160837, 3684.1158122050515, 4173.812178451977, 4267.274563324242, 4276.615104640598, 4281.935770963438, 4374.606285434263, 5006.74966251686, 5014.874628134326, 5018.89962200754, 5024.522670346311, 5064.4935506449065, 4359.476862776423, 4360.738355698668, 4360.825566977349, 4361.302191649321, 4403.911921761547, 4230.090530535888, 4323.827046918151, 4348.217320882271, 4351.912961740747, 4413.8234470621455, 4797.832075877397, 4821.325014497973, 4832.927506087482, 4839.782209800638, 4873.171560834596, 5082.745862706776, 5093.541581257705, 5093.694378337312, 5094.643374963717, 5148.3564554430695, 4593.471750748573, 4601.401817763669, 4705.64707646921, 4705.929411058768, 4711.693739906895, 4932.21084626458, 4987.526185012418, 4996.125678006407, 4996.875078123076, 5045.445001049955, 5041.697498150123, 5065.240213967934, 5079.847604571869, 5081.796728130834, 5126.384833819965, 4575.359449676981, 4679.157751604744, 4681.133990211822, 4759.3336932830125, 4871.5128487151005, 4844.103840789465, 4874.975625121851, 4884.658073934933, 4885.267209918398, 4924.852254432372, 4785.521447855187, 4799.3760811094335, 4804.3273941648895, 4805.399325084364, 4812.133815913029, 4730.621550276039, 4814.518548145157, 4832.371791667061, 4833.685810422311, 4909.95090049095, 4785.114753770564, 4809.855704328876, 4818.204996175732, 4832.275158726219, 4873.293372461044], "unit": "ms", "name": "dojo.html", "value": 4586.492134781728}, {"lowerIsBetter": false, "replicates": [511.08515756795316, 521.8121476268544, 526.5156056428086, 530.7293280426981, 554.5175697143486, 25716.099936502225, 33990.49014264785, 34279.4858077129, 34326.0, 34632.82683586579, 39289.60710392895, 39812.80093599535, 39857.40213896794, 39863.202735945335, 40290.59709402905, 6929.896051559231, 7006.789796306093, 7844.450888437812, 8018.198180181965, 8023.3180179684505, 10136.087752102309, 10386.584536618526, 10386.688399348031, 10400.479976001208, 10404.115650169744, 10023.198144148488, 10113.342632728849, 10116.14012808912, 10119.797604047915, 10127.392356458598, 7087.433005359559, 7284.74503392384, 7286.089238845145, 10053.346532475402, 10217.978202179796, 9821.90178098217, 9954.253430992632, 9957.4025558466, 9958.103770660675, 9960.203183745283, 36309.455358169645, 36786.448203276974, 36886.631133688585, 36902.26195476102, 36973.0, 2948.498755211619, 2954.70452954705, 2969.5100308449296, 2997.955030674542, 3598.6941110005682, 27480.58779118315, 27595.0, 27815.443691126267, 27917.441651167064, 28013.43973120526, 3317.1872891141584, 3512.8594856205723, 3521.102118959649, 3524.0837382280533, 3624.3294990426857, 204828.0, 205911.0, 207012.96493517587, 207281.0, 207438.0, 51746.74126629343, 51798.22302665463, 52157.73921130446, 53002.469975300526, 62090.37909620936, 55113.44886551164, 55146.72426637921, 55286.72356638191, 55338.72330638321, 55341.723291383285, 14471.204083775494, 14604.0, 14661.780073298909, 14688.926555367154, 14702.926485367505, 10694.0, 10742.496050552772, 10763.623273185558, 10773.299735517166, 10773.515191816387, 19075.2369905205, 19115.61768764617, 19212.519687007658, 19217.231310747695, 19321.613567728848, 7596.620168991528, 7738.303552680173, 7849.882251766228, 7925.722599708983, 7940.444168908121, 870.8998465176459, 922.0456827183832, 930.8743319651895, 976.8241716490958, 1001.6043662753317, 24662.753372466046, 25017.4996500069, 25029.62455563168, 25035.62446563303, 25133.497330053295, 941.2846236859899, 985.6599473181741, 994.7562847102362, 1003.533356988989, 1065.6802959112235, 13197.0, 13306.268155251553, 15350.923245383701, 16433.91783041101, 16555.6688866222, 305913.0, 310068.0, 311124.0, 311217.0, 311446.0, 47313.290300645516, 47787.76106119447, 47798.5220147801, 47851.5214847854, 47855.0, 980.7548112971757, 1110.722319420145, 1131.1572878205625, 1247.8814512621286, 1261.7602655495427, 25670.61494077628, 25739.485210295315, 26292.0, 30167.547486788153, 31085.378292434478, 44024.7798761017, 44641.77679111713, 44746.77626611846, 44784.0, 44797.0, 327173.0, 332072.0, 363456.0, 363480.0, 365467.0, 37651.246975060894, 37828.43257351087, 37956.62043379531, 38069.0, 38077.0, 41424.792876035426, 41433.37849932314, 41916.371254430596, 41940.790296048326, 42252.0, 34605.99356195362, 34950.82524587361, 35149.121271967386, 35841.82079089588, 36146.27707445784, 34265.18569594108, 35063.82468087643, 35385.46921796124, 35605.64394356023, 35613.465798012534, 34179.14552136217, 34763.826180868935, 35150.648493515764, 35476.290474190886, 35591.82204088963, 29824.0, 32034.839825800722, 32066.519002215453, 32096.0, 32136.839315804205, 24590.508189835746, 24614.0, 24857.1300004499, 26417.0, 26890.0], "unit": "ms", "name": "ext.html", "value": 17806.90000963636}, {"lowerIsBetter": false, "replicates": [264.3681600973673, 268.66014491668057, 271.4679228711724, 274.0285687238739, 274.6896007511512, 10641.467926603678, 15770.4480343188, 16354.672906541877, 16371.427000054986, 16466.75299870503, 9454.574544145513, 9716.0769726876, 9737.659181928633, 16341.0, 16704.0, 4437.889052773674, 4601.12578610063, 4601.6548758843055, 4605.999999999984, 4606.101810147006, 4566.132434837386, 4596.816127354902, 4599.241125214336, 4599.471060828014, 4607.907841843161, 3421.4525675891864, 3516.3846326892817, 4572.245579479382, 4580.541945805426, 5059.519345662175, 5165.819196328111, 5208.244804503363, 5216.660917040399, 5225.399079105913, 5230.686158830464, 4929.901401971976, 5014.799408023675, 5033.043721692867, 5068.493150684939, 5083.542481176675, 16016.35934562616, 16042.438514652047, 16587.751183732253, 18220.36228731988, 18251.361202357988, 1780.2078075256516, 1817.3548390321378, 1818.97271540927, 1831.633673265339, 1897.9145938432803, 8501.82996340076, 9007.0, 9385.765355866159, 10760.3543787373, 12868.806967895489, 1701.123921180593, 1726.2577091850499, 1736.40094167512, 1778.662054209696, 1796.0750213639985, 46447.535524644656, 56170.0, 56445.71777141129, 57305.999999999585, 57918.13122803161, 9666.468344240993, 9725.270604704676, 9749.561269742879, 9753.902460975441, 9796.608135674493, 12185.573504927463, 12190.51237950472, 12197.93901030507, 12198.878011219951, 12203.267803931614, 6957.756478523227, 7010.789676309719, 7011.404030657349, 7042.471814613822, 7049.68276427562, 6671.266160722316, 6683.465322774166, 6730.822106131407, 6745.392914637706, 6756.628385438848, 4121.402396652528, 4128.050548373891, 4166.958330416717, 4186.1836941796055, 4213.452251207324, 1602.3430393538592, 1646.209819286749, 1656.892302000366, 1669.9415520456726, 1702.4381953955165, 308.18485106892143, 327.54961927349893, 331.12582781456973, 351.9155402703333, 801.0627565748089, 9341.673041443653, 9497.337965855948, 9559.187469065208, 9652.0, 9787.021297870298, 752.1726101288539, 838.7064527415356, 842.3850589070013, 886.7738726624669, 960.6589660670361, 8055.154208808108, 8784.78038049054, 8942.73171804847, 9153.862692059625, 9547.665831695856, 481071.0, 481381.0, 487799.0, 488029.0, 490730.0, 71919.0, 74300.62849685717, 74539.25460745323, 74808.0, 74900.0, 1078.412265315405, 1086.9239153259196, 1094.2723089145788, 1100.0979197058496, 1100.6587957732968, 14636.0, 14868.85131148718, 14989.625259368602, 15006.249687515363, 15262.542123736306, 35249.82375088108, 35293.82353088218, 35494.46758298679, 35885.820570896976, 36413.27173456463, 44944.0, 46597.767011164724, 47436.288455673886, 48008.5199148004, 49343.25985110298, 8764.868526971974, 8896.955515222382, 8919.197272245528, 8965.937834298018, 8981.326400520118, 12825.871741282841, 16102.758458622895, 16725.832741672428, 16732.41436549715, 16757.24592393321, 13912.930435348164, 14091.0, 14198.290085495477, 14405.135691858522, 14418.855811441752, 13265.469381224642, 13453.529126480526, 13688.589342319747, 14008.579742607739, 14009.43962241499, 13671.726565468436, 13754.862451375358, 14030.438782448997, 14299.356528956014, 14567.854321457075, 7041.0, 8419.915800841913, 8574.485530868167, 8735.563221838756, 8742.0, 8748.25639820597, 8801.0, 12054.879451205727, 13109.803352949522, 13593.45626174942], "unit": "ms", "name": "jquery.html", "value": 7834.129922163234}, {"lowerIsBetter": false, "replicates": [1412.4420853762758, 1416.7591509443394, 1444.6966137111206, 1659.5104444188962, 1733.878628496005, 5956.5532585056135, 6410.551261411703, 6913.550619209755, 7059.50583459158, 7089.078419805431, 6936.72253109875, 7034.155901291852, 7036.7185312587435, 7066.7173313067415, 7108.395786358153, 2028.1076326416367, 2062.247279742898, 2063.164418410546, 2064.1743302678974, 2066.442060643625, 2083.677030060343, 2084.42678263478, 2094.832413406924, 2124.915003399862, 2128.4146859613575, 2039.5716899451058, 2063.690446433032, 2097.8846163461003, 2098.0244186453297, 2099.5276062885805, 2063.2778527515325, 2083.8853863037525, 2089.56119214965, 2089.56119214965, 2090.540081182145, 2051.3743308290964, 2076.3874656976077, 2092.6442504774072, 2100.4013856051106, 2104.2004038465284, 7097.361237488651, 7139.393151582121, 7168.641567921583, 7175.067241258603, 7184.281571842826, 4116.5060192777055, 4167.895802604929, 4201.0, 4224.704270701052, 4224.704270701052, 2744.684361298456, 2776.3475583237923, 2777.805553611248, 2799.692033876272, 2858.285428642839, 815.6207363575907, 817.4073796497552, 836.602613758466, 838.861587838006, 846.6190214403543, 9242.815143697155, 9371.76570585734, 9395.671151509732, 9439.433633981984, 9450.4802235877, 3790.77255364679, 3799.0692280390926, 3832.0994566276904, 3873.8256778444475, 3873.845046198177, 8197.959010204911, 8270.2556769891, 8283.047449543259, 8285.544295063708, 8296.211859873303, 4173.353130264813, 4178.435911151955, 4186.476690413699, 4190.413342132104, 4197.391378250137, 3260.9021729348156, 3329.667033296651, 3807.904802379963, 3816.3512202925567, 3817.9691483299353, 3415.3852306585054, 3433.6051354094097, 3455.2053027803245, 3466.757326987087, 3467.878624248139, 1047.6699839550517, 1070.0476575847501, 1072.7103682005816, 1076.520948178069, 1081.2755453845941, 943.0522325063405, 1124.9818913882948, 1157.3576664951033, 1170.5727409495644, 1173.5540494611994, 6775.288594697486, 6792.354726300993, 6870.931290687129, 6875.931240687529, 6877.2091209510545, 953.7615596100975, 954.5704433005176, 1045.843123531461, 1055.693848783844, 1075.424647813416, 5285.154375299933, 5369.1140961740875, 5401.405845357008, 5427.945720542744, 5428.75570599324, 8451.408401411842, 8651.437656552303, 8669.739907802776, 8676.305895528343, 8683.52240626759, 8415.621297041647, 8530.530820804915, 8533.274671652978, 8541.658333666708, 8549.743507694779, 6333.461655759312, 6372.713227904663, 6374.936250637527, 6375.968120159462, 6399.168108145911, 6372.490200784019, 6442.549021568445, 6458.580192287486, 6472.223333200046, 6486.740530378921, 7568.205338439385, 7624.504407213513, 7630.389568834369, 7681.385489160742, 7687.961560192163, 7745.535267883945, 7818.218178182136, 7920.089189743253, 7927.405444591794, 7932.6033698316005, 5158.200478925773, 5265.6840589564745, 5277.656952298088, 5880.26496687914, 5956.702164891824, 5801.622894511843, 5815.244018277766, 6477.740890364333, 6624.436922861418, 6634.071230027704, 6367.61794292344, 6441.935580644134, 6455.9677201613695, 6458.451031662174, 6534.8366290843105, 6232.688365581612, 6304.0, 6351.650659213788, 6368.299487056327, 6424.38968298011, 6339.683015849281, 6372.9362706374195, 6378.74485020594, 6380.489560835029, 6400.39196276353, 5936.1986131871645, 5958.344582096052, 5989.101634754822, 6008.0, 6010.789622363196, 5957.195778569838, 6001.399860013964, 6008.819735407945, 6017.458428741435, 6017.759289628366], "unit": "ms", "name": "mootools.html", "value": 4058.1145811350943}, {"lowerIsBetter": false, "replicates": [250.4602581437003, 251.1648767846909, 257.63801858388956, 258.28326394255936, 261.02897222332916, 5313.123334649783, 5319.893602127955, 5338.386085600162, 5365.409804921455, 5365.624406291561, 4941.901161976758, 4990.875228119299, 5146.176611742122, 5271.578273738101, 5275.498827611371, 4034.475518182632, 4034.8587799427028, 4036.7376120552144, 4038.030872590572, 4042.43405923171, 4017.919641607166, 4025.778582177979, 4030.8992275193064, 4031.6573091287128, 4045.474088368508, 3800.847966081353, 3870.748401353903, 3898.142408670102, 3926.725129240954, 3936.5866584008695, 3975.483187185662, 3977.7215594908366, 3985.5217373915025, 3989.122393073519, 3990.880273591768, 3423.9486407703903, 3427.006168211216, 3429.8456569454434, 3429.879954201591, 3435.0725304167736, 5101.948980510185, 5101.974490127525, 5111.028904508132, 5117.181250999859, 5119.10415677255, 4565.680402371835, 4572.634189264851, 4573.291139873325, 4575.405197324327, 4576.061907308994, 5530.640508366943, 5548.389677135512, 5554.055810512223, 5554.361248456398, 5567.749451274703, 3732.850685972558, 3742.925141497182, 3748.11919198988, 3749.0439937815954, 3754.9812250938844, 5837.182794408786, 5852.941470585282, 5864.912026319608, 5869.8239052828485, 5884.882302353972, 3582.17609949713, 3654.3970244909824, 3712.0719820044988, 3841.1357444575306, 3845.673117784964, 3822.6177382261553, 3926.1362500249897, 3947.111899822517, 3949.3681011038097, 3950.7234493585747, 4553.704009239455, 4559.908801823945, 4564.1556312082375, 4570.88572785683, 4572.7713614319155, 5577.2191893135, 5579.69311687861, 5581.079121944915, 5585.245991791137, 5587.217789509472, 1361.4503854177874, 1363.4409891944454, 1383.4327925550476, 1388.257282353956, 1389.1040279019976, 905.6830109461636, 930.2743859789375, 932.1238036245907, 934.6635211323918, 940.1961323068814, 4927.088488629615, 4935.827246046371, 4938.2839488274, 4942.9258561121615, 4955.851324460272, 5779.075347944308, 5787.450192231731, 5788.594798364074, 5788.710564471759, 5789.681567513743, 4930.704157750546, 4931.038447502702, 4941.160002799533, 4941.72820494869, 4942.0, 3012.864421101012, 3084.5373194021076, 3092.6134233220846, 3104.456720073978, 3127.4370613289825, 5407.107827208467, 5463.07127788269, 5473.06957817172, 5475.151351540518, 5476.58925580583, 5922.585419020627, 5945.464908158287, 5945.524358051345, 5954.523638108941, 5954.910676339859, 5465.234867118606, 5466.562674985912, 5467.0705979983495, 5474.042042642442, 5474.91787623186, 5613.719314034201, 5770.971145144247, 5806.0, 5825.970870145622, 5846.970765146147, 5678.716064196691, 5680.176374425768, 5706.629069110494, 5709.143628455598, 5711.600187986967, 5517.062099443024, 5522.475364840334, 5523.6409633373705, 5525.475079867406, 5528.44715528444, 3655.561332639994, 3724.851005959731, 3756.6243375662216, 3760.5487341519192, 3760.699144068523, 5815.447532484407, 5822.970885145716, 5829.621074630136, 5832.300123984979, 5832.650040997553, 5596.216529685928, 5597.972010140086, 5604.579656525859, 5605.915911261252, 5606.187102870143, 5571.0807716726285, 5571.66570005801, 5576.219329293983, 5584.0507113789945, 5584.748686309207, 5344.064788662046, 5484.067708489487, 5489.451054894478, 5502.58730595215, 5521.917171242354, 5652.745626446737, 5655.264815573949, 5657.0, 5660.0, 5660.51885589713, 5482.616216864782, 5495.917561236504, 5499.835004949858, 5504.174373843955, 5508.586855985737], "unit": "ms", "name": "prototype.html", "value": 4117.118204263962}, {"lowerIsBetter": false, "replicates": [626.840155760281, 660.824881406427, 669.323982777395, 698.3016983016983, 701.9751163301579, 12283.850326192915, 12349.259044457338, 12492.188007779489, 12497.187682800622, 12543.560975365865, 11470.197086203969, 11963.222390544608, 12001.819972700416, 12032.398380080982, 12035.398230088504, 637.9011253255753, 643.9903401448983, 795.5306369242131, 810.6878851642131, 812.6058861452191, 798.8522123407188, 808.1675873849944, 814.5479259011246, 815.4169768615438, 816.1756625807947, 830.779843341515, 848.4442690038035, 849.413904405961, 850.0097386544699, 850.3834719828137, 654.8166513376239, 660.9173853268318, 836.1178956201205, 837.9162083791633, 855.5422848775875, 627.2974268818906, 627.6924307089539, 628.475223188638, 630.0297541785644, 630.0391902348908, 12346.753064938652, 12367.567135150226, 12375.257484550955, 12383.318917459535, 12404.441800119017, 11003.119750419946, 11332.43337833105, 11363.659090227224, 11377.544898204062, 11551.191416600841, 9488.905110948872, 9557.283203759745, 9744.415335079917, 9811.313208075437, 9867.703968880945, 3200.8239546824916, 3249.8537565809597, 3252.1219270796987, 3284.638689744126, 3309.7848639838335, 38375.232495349934, 38482.0, 38488.422673659916, 38623.806880965414, 39718.40422393638, 9339.392939458914, 9392.389494682824, 9442.055794420641, 9503.524823758784, 9527.237820974306, 16642.251098700588, 16652.50042498727, 16667.0, 16739.83260167383, 16799.748003779954, 6215.502759779207, 6322.146510221153, 6350.33321501245, 6430.3891130342545, 6571.638559879252, 3433.261848702541, 3465.0887104374006, 3500.3524347995703, 3534.8708222115006, 3612.2956023575675, 2676.34429564754, 2695.191442567222, 2697.5953606959115, 2702.7702395410042, 2711.051132103748, 474.61556139527096, 480.68034756886976, 481.379021062825, 483.439210515807, 486.86124454530994, 453.67562193031483, 562.4027761158248, 583.9124131380242, 588.6997631208114, 597.7369957218897, 7237.89143162853, 7601.277878601524, 7671.769846904602, 8010.879836802453, 8689.348298877609, 456.83325586161476, 522.9660072095378, 581.7731084876901, 618.42486487567, 627.5481653209682, 3385.1770428692953, 3625.655562721537, 3736.7197460190596, 3776.3202623528027, 3879.1078052048188, 48052.5194748055, 48569.0, 48579.028419431415, 48745.0, 48790.26814597784, 43691.0, 44003.11993760107, 44033.0, 44364.11271774546, 44569.55430445719, 36248.0, 37343.813280933966, 37488.2502349946, 38052.429213561816, 38113.809430953224, 7640.770776876702, 7802.180771018961, 7856.921430785619, 7994.680212791423, 8064.919350806652, 30142.0, 30317.0, 30684.84657576698, 30999.380012400077, 31786.682133179296, 38335.80832095822, 38808.41787373135, 38819.417708733825, 38826.6117338823, 39116.2176756469, 9952.55213515379, 10120.291579589653, 10160.187185025032, 10227.539760710935, 10369.896301037195, 11120.944395277971, 11230.21388502797, 11257.437128143396, 11311.264767790068, 11652.825207622061, 10266.691999240034, 10314.225937274003, 10449.164066874784, 10566.366018038942, 10627.0, 10648.40428448247, 10665.146788257076, 10771.13830893511, 10909.672709818718, 10910.781784364426, 10032.899671003197, 10068.69793906184, 10147.492625368553, 10300.793984120426, 10480.63317783874, 8586.098459661895, 8594.183552562497, 8649.654013839376, 8774.122587741174, 8781.517016563896, 8461.153884611489, 8474.66101355939, 8714.520701361485, 8831.735047948572, 8857.822843543221], "unit": "ms", "name": "yui.html", "value": 5665.8770254844585}], "name": "dromaeo_css", "value": 6266.841782189779}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 117.0, 111.0, 115.0, 114.0, 112.0, 104.0, 114.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [164.0, 132.0, 152.0, 170.0, 130.0, 153.0, 153.0, 137.0, 167.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 165.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 81.0, 95.0, 73.0, 75.0, 72.0, 97.0, 95.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 133.0, 94.0, 94.0, 94.0, 132.0, 96.0, 96.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [74.0, 84.0, 73.0, 74.0, 75.0, 74.0, 75.0, 82.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 75.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 83.0, 84.0, 85.0, 84.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [128.0, 118.0, 120.0, 118.0, 131.0, 125.0, 131.0, 136.0, 125.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [143.0, 148.0, 152.0, 153.0, 137.0, 140.0, 148.0, 159.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 74.0, 70.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1530.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "Richards", "value": 211.38837599999997}, {"lowerIsBetter": false, "replicates": [185.39117538005192], "unit": "score", "name": "DeltaBlue", "value": 356.6404920000001}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19741.865743964878}]} 04:25:58 INFO - RETURN: dromaeo_css: 6266.84 04:25:58 INFO - RETURN: kraken: 1530.20 04:25:58 INFO - RETURN: v8_7: 19741.87 04:25:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19741.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1530.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6266.84"}}} 04:25:59 INFO - Return code: 0 04:25:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:25:59 INFO - # TBPL SUCCESS # 04:25:59 INFO - Running post-action listener: _resource_record_post_action 04:25:59 INFO - Running post-run listener: _resource_record_post_run 04:26:00 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 506658816; Read time: 0; Write time: 700980 04:26:00 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232005632; Read time: 0; Write time: 448896 04:26:00 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 274653184; Read time: 0; Write time: 252084 04:26:00 INFO - Running post-run listener: _upload_blobber_files 04:26:00 INFO - Blob upload gear active. 04:26:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:26:00 INFO - Copying logs to upload dir... 04:26:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.831953 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-09 04:25:58.637366) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:25:58.640400) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009902 build_url: 'https://queue.taskcluster.net/v1/task/uKu4M_pWTZykBKZwUUScoQ/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-12-09 04:25:58.693714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:25:58.694056) ========= 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=c402a24d74c70935940d60dd000001de-1449659107.272114-540967176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:25:58.743837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:25:58.744157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:25:58.744441) ========= ========= Total master_lag: 0.25 =========