builder: ash_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1449221013.3 results: success (0) buildid: 20151204001616 builduid: fcf1862637734b3c8cd29337980c4649 revision: 4bbcd673cb707256ed66b42f5c0c904f48d3d1cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.300139) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.300716) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.301021) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.355320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.358531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.423956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.427797) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.489970) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.490315) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.490699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.491008) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 01:23:33-- 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% 39.1M=0s 2015-12-04 01:23:33 (39.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.696070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.699525) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:33.749226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 01:23:33.752926) ========= bash -c 'python archiver_client.py mozharness --repo projects/ash --rev 4bbcd673cb707256ed66b42f5c0c904f48d3d1cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/ash --rev 4bbcd673cb707256ed66b42f5c0c904f48d3d1cd --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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 01:23:34,049 truncating revision to first 12 chars 2015-12-04 01:23:34,049 Setting DEBUG logging. 2015-12-04 01:23:34,049 attempt 1/10 2015-12-04 01:23:34,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/ash/4bbcd673cb70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 01:23:34,785 unpacking tar archive at: ash-4bbcd673cb70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.023914 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 01:23:34.817946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:34.818263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:34.833131) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:34.833494) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 01:23:34.833906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-04 01:23:34.834215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-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', 'Ash-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Ash-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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:23:35 INFO - MultiFileLogger online at 20151204 01:23:35 in /builds/slave/test 01:23:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Ash-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Ash-Non-PGO 01:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:23:35 INFO - {'append_to_log': False, 01:23:35 INFO - 'base_work_dir': '/builds/slave/test', 01:23:35 INFO - 'blob_upload_branch': 'Ash-Non-PGO', 01:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:23:35 INFO - 'branch': 'Ash-Non-PGO', 01:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:23:35 INFO - 'config_files': ('talos/linux_config.py',), 01:23:35 INFO - 'default_actions': ('clobber', 01:23:35 INFO - 'read-buildbot-config', 01:23:35 INFO - 'download-and-extract', 01:23:35 INFO - 'populate-webroot', 01:23:35 INFO - 'create-virtualenv', 01:23:35 INFO - 'install', 01:23:35 INFO - 'run-tests'), 01:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:23:35 INFO - 'download_minidump_stackwalk': True, 01:23:35 INFO - 'download_symbols': 'ondemand', 01:23:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:23:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:23:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:23:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:23:35 INFO - 'installer_path': 'installer.exe', 01:23:35 INFO - 'log_level': 'info', 01:23:35 INFO - 'log_name': 'talos', 01:23:35 INFO - 'log_to_console': True, 01:23:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:23:35 INFO - 'opt_config_files': (), 01:23:35 INFO - 'pip_index': False, 01:23:35 INFO - 'sps_profile': False, 01:23:35 INFO - 'sps_profile_interval': 0, 01:23:35 INFO - 'suite': 'dromaeojs', 01:23:35 INFO - 'system_bits': '64', 01:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:23:35 INFO - 'title': 'talos-linux64-ix-007', 01:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:23:35 INFO - 'use_talos_json': True, 01:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:23:35 INFO - 'work_dir': 'build'} 01:23:35 INFO - ##### 01:23:35 INFO - ##### Running clobber step. 01:23:35 INFO - ##### 01:23:35 INFO - Running pre-action listener: _resource_record_pre_action 01:23:35 INFO - Running main action method: clobber 01:23:35 INFO - rmtree: /builds/slave/test/build 01:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:23:36 INFO - Running post-action listener: _resource_record_post_action 01:23:36 INFO - ##### 01:23:36 INFO - ##### Running read-buildbot-config step. 01:23:36 INFO - ##### 01:23:36 INFO - Running pre-action listener: _resource_record_pre_action 01:23:36 INFO - Running main action method: read_buildbot_config 01:23:36 INFO - Using buildbot properties: 01:23:36 INFO - { 01:23:36 INFO - "properties": { 01:23:36 INFO - "buildnumber": 3, 01:23:36 INFO - "product": "firefox", 01:23:36 INFO - "script_repo_revision": "production", 01:23:36 INFO - "builddir": "ash_ubuntu64_hw_test-dromaeojs", 01:23:36 INFO - "repository": "", 01:23:36 INFO - "buildername": "Ubuntu HW 12.04 x64 ash talos dromaeojs", 01:23:36 INFO - "buildid": "20151204001616", 01:23:36 INFO - "slavename": "talos-linux64-ix-007", 01:23:36 INFO - "pgo_build": "False", 01:23:36 INFO - "basedir": "/builds/slave/test", 01:23:36 INFO - "project": "", 01:23:36 INFO - "platform": "ubuntu64_hw", 01:23:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:23:36 INFO - "slavebuilddir": "test", 01:23:36 INFO - "scheduler": "tests-ash-linux64-talos", 01:23:36 INFO - "branch": "ash", 01:23:36 INFO - "repo_path": "projects/ash", 01:23:36 INFO - "stage_platform": "linux64", 01:23:36 INFO - "builduid": "fcf1862637734b3c8cd29337980c4649", 01:23:36 INFO - "revision": "4bbcd673cb707256ed66b42f5c0c904f48d3d1cd" 01:23:36 INFO - }, 01:23:36 INFO - "sourcestamp": { 01:23:36 INFO - "repository": "", 01:23:36 INFO - "hasPatch": false, 01:23:36 INFO - "project": "", 01:23:36 INFO - "branch": "ash-linux64-talos", 01:23:36 INFO - "changes": [ 01:23:36 INFO - { 01:23:36 INFO - "category": null, 01:23:36 INFO - "files": [ 01:23:36 INFO - { 01:23:36 INFO - "url": null, 01:23:36 INFO - "name": "https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:23:36 INFO - } 01:23:36 INFO - ], 01:23:36 INFO - "repository": "", 01:23:36 INFO - "rev": "4bbcd673cb707256ed66b42f5c0c904f48d3d1cd", 01:23:36 INFO - "who": "nthomas@mozilla.com", 01:23:36 INFO - "when": 1449221009, 01:23:36 INFO - "number": 6743515, 01:23:36 INFO - "comments": "Bug 1222231, prefixes for everyone", 01:23:36 INFO - "project": "", 01:23:36 INFO - "at": "Fri 04 Dec 2015 01:23:29", 01:23:36 INFO - "branch": "ash-linux64-talos", 01:23:36 INFO - "revlink": "", 01:23:36 INFO - "properties": [ 01:23:36 INFO - [ 01:23:36 INFO - "buildid", 01:23:36 INFO - "20151204001616", 01:23:36 INFO - "Change" 01:23:36 INFO - ], 01:23:36 INFO - [ 01:23:36 INFO - "builduid", 01:23:36 INFO - "fcf1862637734b3c8cd29337980c4649", 01:23:36 INFO - "Change" 01:23:36 INFO - ], 01:23:36 INFO - [ 01:23:36 INFO - "pgo_build", 01:23:36 INFO - "False", 01:23:36 INFO - "Change" 01:23:36 INFO - ] 01:23:36 INFO - ], 01:23:36 INFO - "revision": "4bbcd673cb707256ed66b42f5c0c904f48d3d1cd" 01:23:36 INFO - } 01:23:36 INFO - ], 01:23:36 INFO - "revision": "4bbcd673cb707256ed66b42f5c0c904f48d3d1cd" 01:23:36 INFO - } 01:23:36 INFO - } 01:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:23:36 INFO - Running post-action listener: _resource_record_post_action 01:23:36 INFO - ##### 01:23:36 INFO - ##### Running download-and-extract step. 01:23:36 INFO - ##### 01:23:36 INFO - Running pre-action listener: _resource_record_pre_action 01:23:36 INFO - Running main action method: download_and_extract 01:23:36 INFO - mkdir: /builds/slave/test/build/tests 01:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:36 INFO - https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/test_packages.json 01:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/test_packages.json 01:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:23:40 INFO - Downloaded 1302 bytes. 01:23:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:23:40 INFO - Using the following test package requirements: 01:23:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:23:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:23:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'jsshell-linux-x86_64.zip'], 01:23:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:23:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:23:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:23:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:23:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:23:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:23:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:23:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:23:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:40 INFO - https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:41 INFO - Downloaded 21791043 bytes. 01:23:41 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 01:23:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:41 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 01:23:42 INFO - Return code: 0 01:23:42 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 01:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:42 INFO - https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:45 INFO - Downloaded 21791043 bytes. 01:23:45 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 01:23:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:23:45 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 01:23:46 INFO - Return code: 0 01:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:46 INFO - https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:47 INFO - Downloaded 11132001 bytes. 01:23:47 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 01:23:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:23:47 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 01:23:47 INFO - Return code: 0 01:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:47 INFO - https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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 01:23:48 INFO - Downloaded 53022173 bytes. 01:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:23:48 INFO - mkdir: /builds/slave/test/properties 01:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:23:48 INFO - Writing to file /builds/slave/test/properties/build_url 01:23:48 INFO - Contents: 01:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:23:48 INFO - Running post-action listener: _resource_record_post_action 01:23:48 INFO - Running post-action listener: set_extra_try_arguments 01:23:48 INFO - ##### 01:23:48 INFO - ##### Running populate-webroot step. 01:23:48 INFO - ##### 01:23:48 INFO - Running pre-action listener: _resource_record_pre_action 01:23:48 INFO - Running main action method: populate_webroot 01:23:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:23:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:23:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:23:48 INFO - '../fennec_ids.txt'], 01:23:48 INFO - 'tests': ['tcheck2']}, 01:23:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:23:48 INFO - '--tppagecycles', 01:23:48 INFO - '7'], 01:23:48 INFO - 'tests': ['tsvgm']}}, 01:23:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:23:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:23:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:23:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:23:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'tests': ['damp', 'tps']}, 01:23:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['damp', 'tps']}, 01:23:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:23:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:23:48 INFO - 'other': {'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'other_l64': {'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'other_nol64': {'tests': ['a11yr', 01:23:48 INFO - 'ts_paint', 01:23:48 INFO - 'tpaint', 01:23:48 INFO - 'sessionrestore', 01:23:48 INFO - 'sessionrestore_no_auto_restore']}, 01:23:48 INFO - 'svgr': {'tests': ['tsvgx', 01:23:48 INFO - 'tsvgr_opacity', 01:23:48 INFO - 'tart', 01:23:48 INFO - 'tscrollx', 01:23:48 INFO - 'cart']}, 01:23:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['tsvgx', 01:23:48 INFO - 'tsvgr_opacity', 01:23:48 INFO - 'tart', 01:23:48 INFO - 'tscrollx', 01:23:48 INFO - 'cart']}, 01:23:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'tests': ['tp5o']}, 01:23:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'talos_options': ['--e10s'], 01:23:48 INFO - 'tests': ['tp5o']}, 01:23:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'talos_options': ['--xperf_path', 01:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:48 INFO - 'tests': ['tp5n']}, 01:23:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:48 INFO - 'talos_options': ['--e10s', 01:23:48 INFO - '--xperf_path', 01:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:48 INFO - 'tests': ['tp5n']}}, 01:23:48 INFO - 'talos.zip': {'path': '', 01:23:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:23:48 INFO - Running post-action listener: _resource_record_post_action 01:23:48 INFO - ##### 01:23:48 INFO - ##### Running create-virtualenv step. 01:23:48 INFO - ##### 01:23:48 INFO - Running pre-action listener: _resource_record_pre_action 01:23:48 INFO - Running main action method: create_virtualenv 01:23:48 INFO - Creating virtualenv /builds/slave/test/build/venv 01:23:48 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 01:23:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:23:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:23:48 INFO - Using real prefix '/usr' 01:23:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:23:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:23:51 INFO - Installing pip.................done. 01:23:51 INFO - Return code: 0 01:23:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:23:51 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')]} 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:51 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')]} 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:51 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:23:51 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 01:23:51 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 01:23:51 INFO - Using env: {'DISPLAY': ':0', 01:23:51 INFO - 'HOME': '/home/cltbld', 01:23:51 INFO - 'LANG': 'en_US.UTF-8', 01:23:51 INFO - 'LANGUAGE': 'en_US:en', 01:23:51 INFO - 'LOGNAME': 'cltbld', 01:23:51 INFO - 'MAIL': '/var/mail/cltbld', 01:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:51 INFO - 'MOZ_NO_REMOTE': '1', 01:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:51 INFO - 'NO_EM_RESTART': '1', 01:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:51 INFO - 'PWD': '/builds/slave/test', 01:23:51 INFO - 'SHELL': '/bin/bash', 01:23:51 INFO - 'SHLVL': '1', 01:23:51 INFO - 'TERM': 'linux', 01:23:51 INFO - 'TMOUT': '86400', 01:23:51 INFO - 'USER': 'cltbld', 01:23:51 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:51 INFO - '_': '/tools/buildbot/bin/python'} 01:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:51 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 01:23:51 INFO - Cleaning up... 01:23:51 INFO - Return code: 0 01:23:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:23:51 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')]} 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:51 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')]} 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:51 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:23:51 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 01:23:51 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 01:23:51 INFO - Using env: {'DISPLAY': ':0', 01:23:51 INFO - 'HOME': '/home/cltbld', 01:23:51 INFO - 'LANG': 'en_US.UTF-8', 01:23:51 INFO - 'LANGUAGE': 'en_US:en', 01:23:51 INFO - 'LOGNAME': 'cltbld', 01:23:51 INFO - 'MAIL': '/var/mail/cltbld', 01:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:51 INFO - 'MOZ_NO_REMOTE': '1', 01:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:51 INFO - 'NO_EM_RESTART': '1', 01:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:51 INFO - 'PWD': '/builds/slave/test', 01:23:51 INFO - 'SHELL': '/bin/bash', 01:23:51 INFO - 'SHLVL': '1', 01:23:51 INFO - 'TERM': 'linux', 01:23:51 INFO - 'TMOUT': '86400', 01:23:51 INFO - 'USER': 'cltbld', 01:23:51 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:51 INFO - '_': '/tools/buildbot/bin/python'} 01:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:51 INFO - Downloading/unpacking psutil>=0.7.1 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:23:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:23:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:53 INFO - Installing collected packages: psutil 01:23:53 INFO - Running setup.py install for psutil 01:23:53 INFO - building 'psutil._psutil_linux' extension 01:23:53 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 01:23:53 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 01:23:53 INFO - building 'psutil._psutil_posix' extension 01:23:53 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 01:23:53 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 01:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:54 INFO - Successfully installed psutil 01:23:54 INFO - Cleaning up... 01:23:54 INFO - Return code: 0 01:23:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:54 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:23:54 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 01:23:54 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 01:23:54 INFO - Using env: {'DISPLAY': ':0', 01:23:54 INFO - 'HOME': '/home/cltbld', 01:23:54 INFO - 'LANG': 'en_US.UTF-8', 01:23:54 INFO - 'LANGUAGE': 'en_US:en', 01:23:54 INFO - 'LOGNAME': 'cltbld', 01:23:54 INFO - 'MAIL': '/var/mail/cltbld', 01:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:54 INFO - 'MOZ_NO_REMOTE': '1', 01:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:54 INFO - 'NO_EM_RESTART': '1', 01:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:54 INFO - 'PWD': '/builds/slave/test', 01:23:54 INFO - 'SHELL': '/bin/bash', 01:23:54 INFO - 'SHLVL': '1', 01:23:54 INFO - 'TERM': 'linux', 01:23:54 INFO - 'TMOUT': '86400', 01:23:54 INFO - 'USER': 'cltbld', 01:23:54 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:54 INFO - '_': '/tools/buildbot/bin/python'} 01:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:23:54 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 01:23:54 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 01:23:54 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 01:23:54 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 01:23:54 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 01:23:54 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 01:23:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:23:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:23:56 INFO - Installing collected packages: mozsystemmonitor 01:23:56 INFO - Running setup.py install for mozsystemmonitor 01:23:56 INFO - Successfully installed mozsystemmonitor 01:23:56 INFO - Cleaning up... 01:23:56 INFO - Return code: 0 01:23:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:23:56 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')]} 01:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:56 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')]} 01:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:56 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:23:56 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 01:23:56 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 01:23:56 INFO - Using env: {'DISPLAY': ':0', 01:23:56 INFO - 'HOME': '/home/cltbld', 01:23:56 INFO - 'LANG': 'en_US.UTF-8', 01:23:56 INFO - 'LANGUAGE': 'en_US:en', 01:23:56 INFO - 'LOGNAME': 'cltbld', 01:23:56 INFO - 'MAIL': '/var/mail/cltbld', 01:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:56 INFO - 'MOZ_NO_REMOTE': '1', 01:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:56 INFO - 'NO_EM_RESTART': '1', 01:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:56 INFO - 'PWD': '/builds/slave/test', 01:23:56 INFO - 'SHELL': '/bin/bash', 01:23:56 INFO - 'SHLVL': '1', 01:23:56 INFO - 'TERM': 'linux', 01:23:56 INFO - 'TMOUT': '86400', 01:23:56 INFO - 'USER': 'cltbld', 01:23:56 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:56 INFO - '_': '/tools/buildbot/bin/python'} 01:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:23:56 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 01:23:56 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 01:23:56 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 01:23:56 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 01:23:56 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 01:23:56 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 01:23:58 INFO - Downloading blobuploader-1.2.4.tar.gz 01:23:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:23:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:23:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 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 01:23:58 INFO - Downloading docopt-0.6.1.tar.gz 01:23:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:23:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:23:59 INFO - Running setup.py install for blobuploader 01:23:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:23:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:23:59 INFO - Running setup.py install for requests 01:23:59 INFO - Running setup.py install for docopt 01:23:59 INFO - Successfully installed blobuploader requests docopt 01:23:59 INFO - Cleaning up... 01:23:59 INFO - Return code: 0 01:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23: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')]} 01:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23: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')]} 01:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:59 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:23:59 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 01:23:59 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 01:23:59 INFO - Using env: {'DISPLAY': ':0', 01:23:59 INFO - 'HOME': '/home/cltbld', 01:23:59 INFO - 'LANG': 'en_US.UTF-8', 01:23:59 INFO - 'LANGUAGE': 'en_US:en', 01:23:59 INFO - 'LOGNAME': 'cltbld', 01:23:59 INFO - 'MAIL': '/var/mail/cltbld', 01:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:59 INFO - 'MOZ_NO_REMOTE': '1', 01:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:59 INFO - 'NO_EM_RESTART': '1', 01:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:59 INFO - 'PWD': '/builds/slave/test', 01:23:59 INFO - 'SHELL': '/bin/bash', 01:23:59 INFO - 'SHLVL': '1', 01:23:59 INFO - 'TERM': 'linux', 01:23:59 INFO - 'TMOUT': '86400', 01:23:59 INFO - 'USER': 'cltbld', 01:23:59 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:59 INFO - '_': '/tools/buildbot/bin/python'} 01:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:23:59 INFO - Running setup.py (path:/tmp/pip-i9UYKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:23:59 INFO - Running setup.py (path:/tmp/pip-f79zo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:23:59 INFO - Running setup.py (path:/tmp/pip-WwnRrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:00 INFO - Running setup.py (path:/tmp/pip-hyzTlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:00 INFO - Running setup.py (path:/tmp/pip-Xrpfl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:00 INFO - Running setup.py (path:/tmp/pip-Hc_om1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:00 INFO - Running setup.py (path:/tmp/pip-fjZJe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:00 INFO - Running setup.py (path:/tmp/pip-4lfby_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:00 INFO - Running setup.py (path:/tmp/pip-DKXc7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:00 INFO - Running setup.py (path:/tmp/pip-3WQk8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:00 INFO - Running setup.py (path:/tmp/pip-sa_I1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:00 INFO - Running setup.py (path:/tmp/pip-_8L4g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:00 INFO - Running setup.py (path:/tmp/pip-8nhuvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:00 INFO - Running setup.py (path:/tmp/pip-Bah3zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:00 INFO - Running setup.py (path:/tmp/pip-UjDGcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:00 INFO - Running setup.py (path:/tmp/pip-TuBppA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:01 INFO - Running setup.py (path:/tmp/pip-041L3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:24:01 INFO - Running setup.py install for manifestparser 01:24:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Running setup.py install for mozcrash 01:24:01 INFO - Running setup.py install for mozdebug 01:24:01 INFO - Running setup.py install for mozdevice 01:24:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Running setup.py install for mozfile 01:24:01 INFO - Running setup.py install for mozhttpd 01:24:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Running setup.py install for mozinfo 01:24:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Running setup.py install for mozInstall 01:24:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:24:01 INFO - Running setup.py install for mozleak 01:24:01 INFO - Running setup.py install for mozlog 01:24:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Running setup.py install for moznetwork 01:24:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Running setup.py install for mozprocess 01:24:02 INFO - Running setup.py install for mozprofile 01:24:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Running setup.py install for mozrunner 01:24:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Running setup.py install for mozscreenshot 01:24:02 INFO - Running setup.py install for moztest 01:24:02 INFO - Running setup.py install for mozversion 01:24:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:24:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:24:02 INFO - Cleaning up... 01:24:02 INFO - Return code: 0 01:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24:02 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')]} 01:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:02 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')]} 01:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:02 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:24:02 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 01:24:02 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 01:24:02 INFO - Using env: {'DISPLAY': ':0', 01:24:02 INFO - 'HOME': '/home/cltbld', 01:24:02 INFO - 'LANG': 'en_US.UTF-8', 01:24:02 INFO - 'LANGUAGE': 'en_US:en', 01:24:02 INFO - 'LOGNAME': 'cltbld', 01:24:02 INFO - 'MAIL': '/var/mail/cltbld', 01:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:02 INFO - 'MOZ_NO_REMOTE': '1', 01:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:02 INFO - 'NO_EM_RESTART': '1', 01:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:02 INFO - 'PWD': '/builds/slave/test', 01:24:02 INFO - 'SHELL': '/bin/bash', 01:24:02 INFO - 'SHLVL': '1', 01:24:02 INFO - 'TERM': 'linux', 01:24:02 INFO - 'TMOUT': '86400', 01:24:02 INFO - 'USER': 'cltbld', 01:24:02 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:02 INFO - '_': '/tools/buildbot/bin/python'} 01:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:24:03 INFO - Running setup.py (path:/tmp/pip-qgcqpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:24:03 INFO - Running setup.py (path:/tmp/pip-w7aryt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:24:03 INFO - Running setup.py (path:/tmp/pip-O6MHqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:24:03 INFO - Running setup.py (path:/tmp/pip-LyrB4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:24:03 INFO - Running setup.py (path:/tmp/pip-qeU3Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:24:03 INFO - Running setup.py (path:/tmp/pip-revmvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:24:03 INFO - Running setup.py (path:/tmp/pip-msOWg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:24:03 INFO - Running setup.py (path:/tmp/pip-DOrkxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:24:03 INFO - Running setup.py (path:/tmp/pip-dduz0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:24:03 INFO - Running setup.py (path:/tmp/pip-CQkOim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:24:03 INFO - Running setup.py (path:/tmp/pip-klFmSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:24:03 INFO - Running setup.py (path:/tmp/pip-RbOk77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:24:03 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)) 01:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:24:03 INFO - Running setup.py (path:/tmp/pip-11nJpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:24:04 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)) 01:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:24:04 INFO - Running setup.py (path:/tmp/pip-aYW47m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:24:04 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)) 01:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:04 INFO - Running setup.py (path:/tmp/pip-r3PfOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:24:04 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)) 01:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:24:04 INFO - Running setup.py (path:/tmp/pip-CcOqJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:24:04 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)) 01:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:24:04 INFO - Running setup.py (path:/tmp/pip-PwvIj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:24:04 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)) 01:24:04 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)) 01:24:04 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)) 01:24:04 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)) 01:24:04 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)) 01:24:04 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)) 01:24:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:05 INFO - Downloading blessings-1.5.1.tar.gz 01:24:05 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 01:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:24:06 INFO - Installing collected packages: blessings 01:24:06 INFO - Running setup.py install for blessings 01:24:06 INFO - Successfully installed blessings 01:24:06 INFO - Cleaning up... 01:24:06 INFO - Return code: 0 01:24:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:06 INFO - Reading from file tmpfile_stdout 01:24:06 INFO - Current package versions: 01:24:06 INFO - argparse == 1.2.1 01:24:06 INFO - blessings == 1.5.1 01:24:06 INFO - blobuploader == 1.2.4 01:24:06 INFO - docopt == 0.6.1 01:24:06 INFO - manifestparser == 1.1 01:24:06 INFO - mozInstall == 1.12 01:24:06 INFO - mozcrash == 0.16 01:24:06 INFO - mozdebug == 0.1 01:24:06 INFO - mozdevice == 0.47 01:24:06 INFO - mozfile == 1.2 01:24:06 INFO - mozhttpd == 0.7 01:24:06 INFO - mozinfo == 0.9 01:24:06 INFO - mozleak == 0.1 01:24:06 INFO - mozlog == 3.1 01:24:06 INFO - moznetwork == 0.27 01:24:06 INFO - mozprocess == 0.22 01:24:06 INFO - mozprofile == 0.27 01:24:06 INFO - mozrunner == 6.11 01:24:06 INFO - mozscreenshot == 0.1 01:24:06 INFO - mozsystemmonitor == 0.0 01:24:06 INFO - moztest == 0.7 01:24:06 INFO - mozversion == 1.4 01:24:06 INFO - psutil == 3.1.1 01:24:06 INFO - requests == 1.2.3 01:24:06 INFO - wsgiref == 0.1.2 01:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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', '-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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:24:06 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 01:24:06 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 01:24:06 INFO - Using env: {'DISPLAY': ':0', 01:24:06 INFO - 'HOME': '/home/cltbld', 01:24:06 INFO - 'LANG': 'en_US.UTF-8', 01:24:06 INFO - 'LANGUAGE': 'en_US:en', 01:24:06 INFO - 'LOGNAME': 'cltbld', 01:24:06 INFO - 'MAIL': '/var/mail/cltbld', 01:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:06 INFO - 'MOZ_NO_REMOTE': '1', 01:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:06 INFO - 'NO_EM_RESTART': '1', 01:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:06 INFO - 'PWD': '/builds/slave/test', 01:24:06 INFO - 'SHELL': '/bin/bash', 01:24:06 INFO - 'SHLVL': '1', 01:24:06 INFO - 'TERM': 'linux', 01:24:06 INFO - 'TMOUT': '86400', 01:24:06 INFO - 'USER': 'cltbld', 01:24:06 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:06 INFO - '_': '/tools/buildbot/bin/python'} 01:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 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)) 01:24:06 INFO - Cleaning up... 01:24:06 INFO - Return code: 0 01:24:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:24: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')]} 01:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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')]} 01:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:24: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', 'jsonschema'] in /builds/slave/test/build 01:24: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 jsonschema 01:24:06 INFO - Using env: {'DISPLAY': ':0', 01:24:06 INFO - 'HOME': '/home/cltbld', 01:24:06 INFO - 'LANG': 'en_US.UTF-8', 01:24:06 INFO - 'LANGUAGE': 'en_US:en', 01:24:06 INFO - 'LOGNAME': 'cltbld', 01:24:06 INFO - 'MAIL': '/var/mail/cltbld', 01:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:06 INFO - 'MOZ_NO_REMOTE': '1', 01:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:06 INFO - 'NO_EM_RESTART': '1', 01:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:06 INFO - 'PWD': '/builds/slave/test', 01:24:06 INFO - 'SHELL': '/bin/bash', 01:24:06 INFO - 'SHLVL': '1', 01:24:06 INFO - 'TERM': 'linux', 01:24:06 INFO - 'TMOUT': '86400', 01:24:06 INFO - 'USER': 'cltbld', 01:24:06 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:06 INFO - '_': '/tools/buildbot/bin/python'} 01:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:06 INFO - Downloading/unpacking jsonschema 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:24:08 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 01:24:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:24:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:24:08 INFO - warning: no files found matching '*.txt' 01:24:08 INFO - no previously-included directories found matching 'build' 01:24:08 INFO - no previously-included directories found matching 'dist' 01:24:08 INFO - no previously-included directories found matching '.git*' 01:24:08 INFO - Installing collected packages: jsonschema, functools32 01:24:08 INFO - Running setup.py install for functools32 01:24:08 INFO - warning: no files found matching '*.txt' 01:24:08 INFO - no previously-included directories found matching 'build' 01:24:08 INFO - no previously-included directories found matching 'dist' 01:24:08 INFO - no previously-included directories found matching '.git*' 01:24:08 INFO - Successfully installed jsonschema functools32 01:24:08 INFO - Cleaning up... 01:24:09 INFO - Return code: 0 01:24:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:24:09 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 0x7f535cfb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, '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': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', '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 01:24:09 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 01:24:09 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 01:24:09 INFO - Using env: {'DISPLAY': ':0', 01:24:09 INFO - 'HOME': '/home/cltbld', 01:24:09 INFO - 'LANG': 'en_US.UTF-8', 01:24:09 INFO - 'LANGUAGE': 'en_US:en', 01:24:09 INFO - 'LOGNAME': 'cltbld', 01:24:09 INFO - 'MAIL': '/var/mail/cltbld', 01:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:09 INFO - 'MOZ_NO_REMOTE': '1', 01:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:09 INFO - 'NO_EM_RESTART': '1', 01:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:09 INFO - 'PWD': '/builds/slave/test', 01:24:09 INFO - 'SHELL': '/bin/bash', 01:24:09 INFO - 'SHLVL': '1', 01:24:09 INFO - 'TERM': 'linux', 01:24:09 INFO - 'TMOUT': '86400', 01:24:09 INFO - 'USER': 'cltbld', 01:24:09 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:09 INFO - '_': '/tools/buildbot/bin/python'} 01:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:24:09 INFO - Downloading/unpacking flake8 01:24:09 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 01:24:09 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 01:24:09 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 01:24:09 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 01:24:09 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 01:24:09 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 01:24:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:24:10 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 01:24:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:24:11 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 01:24:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:11 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 01:24:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24: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 01:24:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:11 INFO - no previously-included directories found matching 'docs/_build' 01:24:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:24:11 INFO - Running setup.py install for pep8 01:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:24:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:24:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:24:11 INFO - no previously-included directories found matching 'docs/_build' 01:24:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:24:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:24:11 INFO - Cleaning up... 01:24:11 INFO - Return code: 0 01:24:11 INFO - Running post-action listener: _resource_record_post_action 01:24:11 INFO - Running post-action listener: _start_resource_monitoring 01:24:11 INFO - Starting resource monitoring. 01:24:11 INFO - ##### 01:24:11 INFO - ##### Running install step. 01:24:11 INFO - ##### 01:24:11 INFO - Running pre-action listener: _resource_record_pre_action 01:24:11 INFO - Running main action method: install 01:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:24:12 INFO - Reading from file tmpfile_stdout 01:24:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:24:12 INFO - Reading from file tmpfile_stdout 01:24:12 INFO - Output received: 01:24:12 INFO - Usage: mozinstall [options] installer 01:24:12 INFO - Options: 01:24:12 INFO - -h, --help show this help message and exit 01:24:12 INFO - -d DEST, --destination=DEST 01:24:12 INFO - Directory to install application into. [default: 01:24:12 INFO - "/builds/slave/test"] 01:24:12 INFO - --app=APP Application being installed. [default: firefox] 01:24:12 INFO - mkdir: /builds/slave/test/build/application 01:24:12 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'] 01:24:12 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 01:24:27 INFO - Reading from file tmpfile_stdout 01:24:27 INFO - Output received: 01:24:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:24:27 INFO - Running post-action listener: _resource_record_post_action 01:24:27 INFO - ##### 01:24:27 INFO - ##### Running run-tests step. 01:24:27 INFO - ##### 01:24:27 INFO - Running pre-action listener: _resource_record_pre_action 01:24:27 INFO - Running main action method: run_tests 01:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:24:27 INFO - Python 2.7.3 01:24:27 INFO - Return code: 0 01:24:27 INFO - grabbing minidump binary from tooltool 01:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:24:27 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 0x1afc0b0>, '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 0x1afcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:24:27 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 01:24:27 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 01:24:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:24:27 INFO - Return code: 0 01:24:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:24:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:24:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:24:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:24:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:24:28 INFO - Return code: 0 01:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test/build 01:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Ash-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 01:24:28 INFO - Using env: {'DISPLAY': ':0', 01:24:28 INFO - 'HOME': '/home/cltbld', 01:24:28 INFO - 'LANG': 'en_US.UTF-8', 01:24:28 INFO - 'LANGUAGE': 'en_US:en', 01:24:28 INFO - 'LOGNAME': 'cltbld', 01:24:28 INFO - 'MAIL': '/var/mail/cltbld', 01:24:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:24:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:24:28 INFO - 'MOZ_NO_REMOTE': '1', 01:24:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:24:28 INFO - 'NO_EM_RESTART': '1', 01:24:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:24:28 INFO - 'PWD': '/builds/slave/test', 01:24:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:24:28 INFO - 'SHELL': '/bin/bash', 01:24:28 INFO - 'SHLVL': '1', 01:24:28 INFO - 'TERM': 'linux', 01:24:28 INFO - 'TMOUT': '86400', 01:24:28 INFO - 'USER': 'cltbld', 01:24:28 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745', 01:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:24:28 INFO - '_': '/tools/buildbot/bin/python'} 01:24:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Ash-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 01:24:28 INFO - mozversion INFO | application_buildid: 20151204001616 01:24:28 INFO - mozversion INFO | application_changeset: 4bbcd673cb707256ed66b42f5c0c904f48d3d1cd 01:24:28 INFO - mozversion INFO | application_display_name: Nightly 01:24:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:24:28 INFO - mozversion INFO | application_name: Firefox 01:24:28 INFO - mozversion INFO | application_remotingname: firefox 01:24:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/ash 01:24:28 INFO - mozversion INFO | application_vendor: Mozilla 01:24:28 INFO - mozversion INFO | application_version: 45.0a1 01:24:28 INFO - mozversion INFO | platform_buildid: 20151204001616 01:24:28 INFO - mozversion INFO | platform_changeset: 4bbcd673cb707256ed66b42f5c0c904f48d3d1cd 01:24:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/ash 01:24:28 INFO - mozversion INFO | platform_version: 45.0a1 01:24:28 INFO - 2015-12-04 01:24:28,697 DEBUG : using testdate: 1449221068 01:24:28 INFO - 2015-12-04 01:24:28,697 DEBUG : actual date: 1449221068 01:24:28 INFO - 2015-12-04 01:24:28,705 INFO : starting webserver on 'localhost:36293' 01:24:28 INFO - 2015-12-04 01:24:28,706 INFO : Starting test suite talos-linux64-ix-007 01:24:28 INFO - 2015-12-04 01:24:28,706 INFO : Starting test dromaeo_css 01:24:28 INFO - 2015-12-04 01:24:28,706 DEBUG : operating with platform_type : linux_ 01:24:28 INFO - 2015-12-04 01:24:28,707 INFO : Initialising browser for dromaeo_css test... 01:24:28 INFO - 2015-12-04 01:24:28,724 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrdu2O/profile http://localhost:36293/getInfo.html 01:24:33 INFO - 2015-12-04 01:24:33,310 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:24:33 INFO - 2015-12-04 01:24:33,310 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:24:33 INFO - 2015-12-04 01:24:33,310 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:24:33 INFO - 2015-12-04 01:24:33,311 DEBUG : BROWSER_OUTPUT: __metrics 01:24:33 INFO - 2015-12-04 01:24:33,412 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] 01:24:33 INFO - 2015-12-04 01:24:33,468 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] 01:24:34 INFO - 2015-12-04 01:24:34,395 INFO : Browser initialized. 01:24:34 INFO - 2015-12-04 01:24:34,395 INFO : Running cycle 1/1 for dromaeo_css test... 01:24:34 INFO - 2015-12-04 01:24:34,395 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrdu2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:24:46 INFO - 2015-12-04 01:24:46,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 150589440 01:24:46 INFO - 2015-12-04 01:24:46,374 DEBUG : BROWSER_OUTPUT: 01:25:37 INFO - 2015-12-04 01:25:37,710 DEBUG : BROWSER_OUTPUT: 1449221137709 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] 01:27:49 INFO - 2015-12-04 01:27:49,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36293/tests/dromaeo/cssquery-ext.html) 01:27:50 INFO - 2015-12-04 01:27:50,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 246427648 01:27:50 INFO - 2015-12-04 01:27:50,602 DEBUG : BROWSER_OUTPUT: 01:30:53 INFO - 2015-12-04 01:30:53,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-ext.html (next: http://localhost:36293/tests/dromaeo/cssquery-jquery.html) 01:30:53 INFO - 2015-12-04 01:30:53,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 225746944 01:30:53 INFO - 2015-12-04 01:30:53,684 DEBUG : BROWSER_OUTPUT: 01:33:55 INFO - 2015-12-04 01:33:55,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36293/tests/dromaeo/cssquery-mootools.html) 01:33:56 INFO - 2015-12-04 01:33:56,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 226734080 01:33:56 INFO - 2015-12-04 01:33:56,337 DEBUG : BROWSER_OUTPUT: 01:36:58 INFO - 2015-12-04 01:36:58,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36293/tests/dromaeo/cssquery-prototype.html) 01:36:58 INFO - 2015-12-04 01:36:58,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 215379968 01:36:58 INFO - 2015-12-04 01:36:58,822 DEBUG : BROWSER_OUTPUT: 01:40:01 INFO - 2015-12-04 01:40:01,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36293/tests/dromaeo/cssquery-yui.html) 01:40:02 INFO - 2015-12-04 01:40:02,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 214028288 01:40:02 INFO - 2015-12-04 01:40:02,240 DEBUG : BROWSER_OUTPUT: 01:43:04 INFO - 2015-12-04 01:43:04,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/dromaeo/cssquery-yui.html (next: http://localhost:36293/tests/dromaeo/cssquery-dojo.html) 01:43:05 INFO - 2015-12-04 01:43:05,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 236765184 01:43:05 INFO - 2015-12-04 01:43:05,012 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,012 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:43:05 INFO - 2015-12-04 01:43:05,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:43:05 INFO - 2015-12-04 01:43:05,013 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:43:05 INFO - 2015-12-04 01:43:05,013 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:43:05 INFO - 2015-12-04 01:43:05,016 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2584.870756462177;2669.3326668332907;2675.0637276953057;2686.7178946210647;2701.5542435498146;4428.844990425336;4530;4599.793009314581;4616.722996620205;4628.745419001958;4544.97727511362;4566.315052742082;4577.382053422795;4590.63274938005;4704.4589872164715;4217.472815898012;4240.173166232578;4271.039016221356;4323.178596066753;4326.8269269229195;4255.276602977501;4368.082702632451;4407.162639098577;4413.3821265022925;4438.400815889862;4080.285949958775;4178.8537401191115;4180.184863951531;4356.477222733276;4411.029573493826;4182.519010313792;4255.510616279105;4267.935980960288;4274.914501709979;4275.935860962088;4229.70392072555;4246.745195288262;4252.702310838243;4257.723247988871;4287.8284868605215;4313.09425020746;4422.491413487458;4432.534583868712;4546.681732278742;4605.055963527502;4814.831480898151;4815.301781241736;4824.782884770194;4895.143349913787;4940.950590494085;4949.82675606352;4957.727324997124;4995.650304478688;5010.398752149729;5013.974930125326;4556.817727290904;4583.518730533313;4584.243599805995;4604.58558729716;4625.352450656911;4759.881002974884;4923.48303428142;4923.606111511071;5010.398752149693;5094.312267843794;4870.391201099863;4872.4153101628035;4876.512348765166;4882.633802464829;4884.902301953941;4969.850904472872;4970.950290497121;4974.129527332702;4981.800727970913;5009.223570346602;4714.198586240347;4768.880777980578;4793.856184314406;4833.299171620166;4943.134951383494;4862.708237505761;4873.585745211626;4874.878128046827;4921.261810728348;4927.7536123193695;4072.1448495815616;4077.1437998020156;4085.530164031115;4089.3048181809163;4117.773522456294;3433.3991551478393;3538.0270425633157;3542.1498840278664;3562.625924277965;3627.238279961185;4240.363945408213;4240.851570195028;4259.361095835649;4272.038791271939;4316.870493885189;4881.072596206709;4886.60907127429;4892.19278818998;4897.951020489821;4931.334269873593;4093.4269202311702;4176.916461670749;4181.933606930274;4221.303484925014;4225.366195070703;4391.978040109779;4399.692021558524;4404.075144219686;4416.933745993812;4418.270985287456;4728.267118596623;4729.6452766042685;4732.290156476418;4734.360861283752;4773.11697335994;4742.834000809955;4831.0820944020525;4845.709257444564;4903.509649035068;4979.9004019918675;4710.9764451177525;4728.645351598575;4732.19552676039;4768.66619336657;4769.928451073168;4891.9755401222765;4895.069936712156;4900.852974410774;4913.508649135058;4955.132851751001;4687.3906392170165;4782.043591281688;4782.139214941344;4851.75741212945;4965.702057876539;4752.643551733565;4769.189237829647;4772.546608072227;4814.879628009187;4819.879503012453;4758;4760.690555113906;4768.690035147704;4771.260454629538;4813.687110337957;4510;4680.3915490985955;4685.695429797052;4686.367340409001;4691.366665500113;4882.267659851051;4894.583960363267;4896.730679812645;4898.289747986593;4927.236278376858;4781.402324709411;4784.354112194809;4788.952110478851;4789.3294938709305;4835.29888166221 01:43:05 INFO - 2015-12-04 01:43:05,017 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.6118708684548;576.6251936241446;578.0779656447966;581.8312689320098;584.330941072472;28533;29221.707782922193;37478.62521374789;38069.80965095178;38147.237055258876;40334.79832600833;40669.59330406695;40801.79599102;40808.38787418183;40845.183096338056;7069.328413800681;7982.2416870397365;8148.388870834681;8157.184281571855;8163.142869998654;7097.290270972913;7196.208417074117;7198.172210195842;7198.3521483066515;7200.38796702281;9739.074787895139;9866.654667086654;9878.407295562254;9888.85166722496;9893.25800564957;9787.559559819789;9822.705318840446;9855.113039826414;9857.408555486694;9864.50677466131;7216.8917466238045;7399.408047356199;9973.950130249303;10006.9499652502;10311.896881031169;38050.04874878123;38418.61581384178;38595.22809543793;38788.224235515416;38798.224035519415;2931.1060126661573;2979.478591246545;2999.8500074996164;3043.9543406848916;3608.2422989374118;27888.581671274744;28647;28654.140375788553;28664.71335286662;29205;3361.96638033619;3388.390089783838;3398.558187435642;3440.913977150566;3494.7204223662047;226101;226587;226857;226950;227332;56329.71835140798;56666.433335666115;56720.43279567151;56840;57002.42997569971;51346.71633209199;52613.47386526086;60862.695686521285;61498.38501615016;61647.6917615418;12977.870221297855;13517.121387110003;13518.594442166554;13529.932350338186;13594.456221751218;9212.631494740135;9224.215941645036;9230.123138301851;9237.353385262966;9238.86141707875;19291.06885766779;19618.215271388985;19704.113314900864;19768.40694779159;19780;7350.77947661571;7648.38812894967;7668.884966725504;7796.5711885845685;7814.960925195452;800.9559474228856;896.2740180453853;905.5879574793453;909.3907082254905;942.4109931292942;25262.30670167411;25932.481350372887;26044.08845690392;26161.776249018665;26748.465030699277;925.3060204846365;1003.6687892995294;1094.9397783121844;1119.904808091305;1120.2046546951756;13860;14009.08940918837;14124.152550846982;14147.858521414653;14233.146011239358;261196;264837;265608;265829;265985;46755.76622116868;47115.29327060097;47124.293135602995;47210.5278947213;47217.76391118091;1203.7773011992808;1206.6259459567561;1223.993880030612;1224.6326102169314;1227.110344999868;25118.874405628587;25888.48223035491;26350;26498;26646.733532664424;41674;42142.57857421387;42160.789196053825;42197;42203.788981054895;247114;250309;250618;315110;320235;25984.35039124037;26030.86984565065;26167.607485888107;26178;26413.471730565667;34426.13934651654;34569.654303457646;35225.82387088048;35389.82305088458;35544.46683299804;29895.70104299016;30088.398232035674;30380.392392151593;32577.674223257465;33948.32103357869;32301.676983229867;33192.33615327728;33193.17017074592;33593;33594.66405336013;33240;33786.32427351488;33957.830210849774;34023.48964765481;34068.488972664934;28080.43839123247;29893;30328.84835575808;30532.847335763177;30704.16197975253;23356;23523.411914701584;23545.175918842757;23727.881360593088;23780.16769413062 01:43:05 INFO - 2015-12-04 01:43:05,020 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.25692192566726;332.3336709896657;333.3433136720661;336.8383176075484;337.6960735338197;12706.93646531766;13076.215427074381;14897.702045959075;15580.065196088242;16109.516714498555;8429.241368276855;9577.185939195177;9869.506524673756;13197.604071877859;14478.565643030699;4406.361077643748;4531.093781243748;4533.387992620987;4534.909301813962;4538;3353.4634458486526;4361.629261512775;4956.3804524434445;5320.042392369372;5353.946460535403;5297.682139071649;5305.6551324164;5321.068812957737;5332.840014799563;5336.733163341837;5300.92048619271;6396.488280937514;6639.601623902581;6677.23211830636;6677.232118306384;6299.307076221612;6360.586561873463;6374.298827129012;6389.073584330246;6481.708323125471;15996.920015399848;16010.199490025452;17206.655866882717;20609.793902060937;20994.265200718055;1924.3361040441166;1939.9612007759765;1965.1746266568075;2030.9492262693402;2134.338355109921;13441.66395840102;13514.932425337909;13896.235707036109;14151.716965660733;14239.715205695931;1847.9836090150363;1875.9812401875943;1908.799576044523;1931.401265607652;1940.8932508712014;51451;51520.74239628815;52206.477935220544;52338.73830630822;61807.690961545355;15091.094534327756;15115.470958516618;15162.469313573973;15209.315580798891;15230.086194828345;23551.764482354956;23567;23765.643515347285;23845.165419210243;23864.522709545712;8084.3936704747375;8144.063432705197;8152.551609661526;8236.382271329554;8242.340612750966;6791.694373753193;6816.147981502312;6825.180978282638;6837.111175547247;6861;7645.388368930583;7663.386929045663;7673.309402153833;7688.692452301957;7692.7692169235015;2589.4173810892776;2985.8805647773847;3037.240689827543;3049.862756175977;3060.9846950765104;367.15920541958616;367.3021259606715;375.2832090706737;850.3537311643196;852.577973902922;9617.759556011155;9924.354916930377;9983.301168918106;10041.146502547364;10212.489375531193;390.97654140751644;391.1082731372475;394.3296396126596;401.44199562608;404.4378314143343;5383.16560933056;5430.15832545956;5443.700596467233;5466.070767969455;5527.474889885454;436728;440545;469104;477804;477934;65489.67255163693;72592.2740772596;73026;73931;74124.25875741281;420.45131103909694;423.713993054693;423.7288135593223;423.74363510076574;425.24943474766445;8121.228483294078;9254.861177082485;9335.813283734424;9486.905130948602;9582.616695332108;32396.83801580977;32971.505427419084;33112.17219569434;34343.82828085944;34375.65624343824;41887.37168942407;42234.36648450337;42739.35890961576;42843.143137137704;44864.4108471315;8638.870416943877;8737.344699147463;8739.650413983623;8756.387052906235;8837.116288371111;15063.623409414853;15338.463153789564;15516.922415388302;15586.844131558993;15881;12954.546590869275;12967.870321296667;13125.60623181306;13299.734005320033;13365.131266467648;12682.239065656091;12867.099303048697;12933.805992909925;13304.002199834858;13748.725025499634;12603.93698031504;12660.240385576895;12748.426320815772;13098.410571524495;13523.797143042666;8325.83348333042;8737.781555461164;8777.868331974898;8971.32715046361;9021.233195178484;8900.020997690119;11717.589884354007;12770.23378597287;12947.417366218731;13314.134581252187 01:43:05 INFO - 2015-12-04 01:43:05,021 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1262.1669697999323;1571.3635977429142;1634.7793047938524;1662.659154873251;1688.1981058996978;5713.942860571398;6013.849653758658;6915.239323674392;7194.0647715797;7212.927870721304;7069.434445244381;7071.540349877255;7112;7120.1099862517185;7130.75042373517;2100.191426300874;2140.4862832920144;2141.100737690166;2141.625215587266;2143.506993391521;2081.521250112475;2086.457521044524;2102.6530622447276;2105.968410473844;2106.8735875847424;2033.186725309873;2054.6507093794016;2067.5968186203695;2096.1929657082055;2096.727425434691;2091.341227513336;2117.6400011998;2120.342693764938;2123.7026816245816;2125.1499400240027;2069.2757534862826;2103.905324260412;2116.8941552922292;2117.5976564452703;2118.8834614096218;5892.381299963485;7150.213476517579;7227.421806255487;7233.565986040801;7237;3517.5778906531123;4178.415021896937;4297.763623000734;4299.871003869889;4303.074838909618;2668.839055011057;2698.77060449862;2768.7784977201977;2769.515334816399;2815.5776633504934;882.0782282514723;914.1178762494159;915.8626206069076;919.5034681272105;919.7608621758324;9491.952540237324;9588.520573971273;9614.423134611876;9633.518324083769;9638.228941684649;3977.7016723745833;3998.280309544252;4045.7572545647354;4051.6353528182603;4117.444145040441;8347.54088525137;8366.121557236524;8372.372072094617;8375.539345335943;8405.201505856934;4356.063446358985;4374.125174964956;4410.162069206905;4412.955870441318;4420.292753159479;3987.6610488108836;3988.980055099706;3997.600239975979;4000.5399379071196;4000.9199816003515;3335;3344.5317655528247;3362.6637336266667;3364.3944090064024;3367.8316084195694;1086.4079076903106;1089.003561740998;1089.700332408578;1093.8468614393832;1096.3257596578046;970.6263088710756;985.3053597213947;985.6500942165571;1059.7403636109048;1211.1582450197204;6713.1944166700305;6729.360710732472;6764.5603035802515;6770.221424536143;6775.661216939232;435.7603318174991;1101.7741363020561;1117.435694974049;1146.7190538318166;1148.5635458525708;4828.227483602606;5258.368995720538;5407.567394608422;5411.891762164813;5419.810306639328;7468.663910124057;8505.914940850636;8679.17547832955;8685.565721713889;8687.131286871389;8394;8514.531700756517;8522.232999030117;8575.571221438902;8586.356023298153;6436.485081193493;6538.444232240313;6563.278039415756;6599.53803233769;6614.86770264592;6767.763128290486;6802.693878775368;6806.081179040964;6846.554973926679;6848.6918088687125;7649.847003060019;7746.690132394641;7808;7923.286904178421;7943.4836735612;7959.482633628795;8041.517508949481;8065.153158918229;8072.475289106189;8074.555899425588;5902.763889444374;6021.909671355021;6025.367336429612;6025.427584379477;6027.186329845415;6745.089412929388;6801.149856267966;6807.693653785493;6812.82967925786;6818.420434262945;6329.8734025320155;6436.9034464484;6495.188101487314;6560.212774466903;6626.966865165836;6470.838229044311;6519.054737063194;6527.3472652734345;6527.9020814688765;6572.572782769104;6416.262129855127;6442.8389290268115;6474.676266186766;6480.740770369321;6486.513511486563;5937.2578427696535;5938.673372964356;5965.28416590012;5975.40245975399;5998.4601385875485;6073.939260607337;6088.817335479943;6123.112148738319;6125.019996800491;6147.66187859672 01:43:05 INFO - 2015-12-04 01:43:05,022 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.44873413615335;293.7532472722912;299.77816415852277;299.79913457983145;300.6692638098091;5210.713410762407;5214.556762675173;5215.713135777535;5283.6037297202765;5326.334208223972;5209.791608335671;5223.503767142115;5225.242339860718;5230.9738451307785;5231.319928409311;4099.6105369989955;4099.73351732138;4101.897452563695;4103.8563650272245;4119.505659320871;3889.105505733683;3974.4237085622713;3985.7409268397605;4048.291548978917;4074.775887326196;4055.371417430288;4059.309917314049;4061.4923134608175;4071.796410179479;4081.1225586499045;3823.3500304948225;3943.4479172915817;4061.3298805697023;4070.3487442009136;4071.531773846001;3500.7374446916583;3550.4496802995577;3550.520679708258;3585.4084076127406;3589.587197472298;5069.822556210552;5078.390593128848;5085.1355269604255;5088.084144853925;5088.542031217171;4672.836450724209;4680.063987202573;4687.250039993619;4687.343771871941;4692.389989301403;5375.838724838261;5507.366652834935;5520.282363292787;5526.977509160818;5528.530074943635;3891.610838916086;3894.4547763313158;3895.941560876589;3897.61023897608;3898.083950271684;5791.102379131242;5792.478676919055;5793.507551858097;5797.101449275369;5804.216430781875;4010.538788039413;4011.679065674739;4015.377616469452;4018.4976877890263;4019.055521952339;3851.383778595411;4079.4900637420324;4079.6124368184974;4080.4287399764057;4082.408050832613;4124.938125928114;4442.933355999663;4505.594496495331;4525.728456292633;4550.2492088804975;5418.91871621926;5505.03661859173;5508.283923089973;5539.307586551681;5558.416366281483;1373.4643489039283;1398.9300534973413;1399.657084014423;1401.31335645535;1404.5224623627812;925.7130289610243;929.874466946967;935.6865450074165;942.4863449419945;945.5697657565792;4877.439094504107;4888.877778055577;4893.804247830047;4894.975525122423;4900.436449808247;5737.454941780524;5739.512141467939;5740.770369185269;5744.138379243147;5747.8563035924435;4812.181929072066;4821.54195351441;4860.3195552622665;4862.343583616166;4874.512548745097;2845.374017716099;2905.1575043237226;3049.2224482756756;3082.737967272762;3087.7529797616135;5383.596230282745;5484.424135465799;5503;5511.311086114236;5512.944870551243;5960.135780311917;5967.19442875215;5967.46292833647;5975.7609695612555;5978.760849566055;5491.121420572689;5504.614676972574;5511.862203444946;5511.9724401378535;5511.9724401378535;5644.2380278663495;5799.101139323411;5806.2451881255165;5807.303123625192;5809.157672137601;5666.631668941505;5673.319201695823;5675.801346952837;5677.51741102011;5677.574181936288;5487.780488780404;5495.697736624365;5503.2020357048805;5505.889882202414;5510.338759348904;3918.2555314490155;3954.2289253595272;3957.881263562098;3959.40608908666;3962.0293028208275;5635.690037048002;5772.307323121252;5775.220345253337;5778.56660750437;5780;5514.117741161395;5549.334079910436;5554.555635549227;5555.111182210827;5561.388247292875;5540.916886246629;5547.916781248366;5554.416786237549;5555.583331250092;5559.221708960829;5308;5434.891302174014;5446.836594902159;5453.754581043783;5454.754536045808;5589.972050139723;5593.216949626974;5599.944000559943;5601.775928962796;5609.691466969356;5249.501297376743;5384.838454846361;5394.757235924314;5467.4532546745;5469.835904922858 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: |5;yui.html;741.0292516802992;750.5534207146745;770.7456539342018;778.8559116563437;817.5380909785972;12617.5583854565;12731.999999999989;12788.360581970888;12799.424025918832;12852.100352975296;11279.830802537968;12951.546695865647;13303.068785185042;13308.068435209516;13330.733385332287;627.9466245369126;634.2515831319041;810.2302812328282;816.9632366543519;830.1864173110356;815.7185770909057;818.0510607695074;819.6967122164807;822.5763731678161;824.1428913929506;844.9028361738386;848.7962888906649;853.5007020892785;853.6030745703247;853.8121613245077;655.9868802623945;664.8537321789198;833.7082021292559;845.8858054162671;847.1232274595764;627.5952010952956;627.886980343538;628.0641843652925;628.1206311164361;628.1833616298793;12741.55404560836;12857.871421285854;12899;12915.22508649484;12915.677108072374;10738.838917416246;10757.354558726502;11326.263792853439;11464.19750617457;11819.409029548575;9250.583723732449;9650.469224192666;9680.612775488971;9708.077732615391;9747.707568772948;3285.3100848821778;3300.3894279558117;3327.800331980089;3335.0995231287416;3341.532185494033;42044;42145.36781948273;42434.36348454776;42576.99999999969;42638.57361426377;9240.7689807754;9375.90624093764;9419.90580094204;9445;9463.456688582872;16437.09595972233;16456.506304810875;16475.34098636041;16479.670406591802;16480.917595411946;6322.905156422566;6477.838054048592;6504.414602685781;6507.837304067436;6558.311377305409;3525.506429099928;3527.5414196154334;3536.3575218593633;3573.6069032406413;3583.426651735762;2655;2682.6646669166353;2690.340866487723;2691.35407502202;2691.650085488874;460.13035363163647;467.07286037216096;476.8688610632104;477.10304627301144;479.6905995632797;473.55722399556527;509.8725318670332;548.4214154067497;559.4740943513085;582.8542864283929;7265.5277406969435;7362.558246505227;7372.2259162788205;7403.51877127985;7461.626918654046;419.74815110933804;476.66197302232604;524.0828550037435;555.5028249716481;596.3946594206883;3521.8591256349973;3550.520679708258;3683.778973261613;3721;3745.7939813309986;49566.25650615244;49735.50264497309;49831.501684982686;49878;49944.25083623749;46946.76526617413;47139.5286047142;47507.28739068917;47898;48285.5171448288;43723;44163.11673766507;44618.55381446209;44661.33008004883;44984.77507612441;7536.9246307538415;7626.122995855548;7811.804704882424;7945.642446090055;8059.113497515152;33742.32515349728;34039.829800850835;34658.82670586631;34836;34860.47709284312;43594;43706.78146609246;43773.78113109414;43982.56017439913;44333.11333773371;10200.693979180636;10212.387256764618;10255.692329230134;10286.485675716034;10452.425116618355;10828.079613232963;11019.83470247931;11118.166137539554;11284.605038823602;11376.919192676682;10018.699439016842;10255.692329230134;10296.948515257376;10495.842562361418;10882.347059176474;10059.949700251453;10208.897911020795;10277.640282590073;10300.227482938659;10793.56825726962;9830.852537211804;10112.89887101149;10222.080012798884;10325.225608079574;10728.731781705208;9222.677206298016;9267.67563135287;9294.209992150472;9413.952930235306;9616;8610.61252243638;8673.956630216808;8698.91301086981;8777.736667899973;9023.639054438012 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1449222185011__endTimestamp 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4544.73 Median:4714.20 stddev:469.15 (10.0%) stddev-sans-first:444.69 01:43:05 INFO - 2015-12-04 01:43:05,024 DEBUG : BROWSER_OUTPUT: Values: 2584.9 2669.3 2675.1 2686.7 2701.6 4428.8 4530.0 4599.8 4616.7 4628.7 4545.0 4566.3 4577.4 4590.6 4704.5 4217.5 4240.2 4271.0 4323.2 4326.8 4255.3 4368.1 4407.2 4413.4 4438.4 4080.3 4178.9 4180.2 4356.5 4411.0 4182.5 4255.5 4267.9 4274.9 4275.9 4229.7 4246.7 4252.7 4257.7 4287.8 4313.1 4422.5 4432.5 4546.7 4605.1 4814.8 4815.3 4824.8 4895.1 4941.0 4949.8 4957.7 4995.7 5010.4 5014.0 4556.8 4583.5 4584.2 4604.6 4625.4 4759.9 4923.5 4923.6 5010.4 5094.3 4870.4 4872.4 4876.5 4882.6 4884.9 4969.9 4971.0 4974.1 4981.8 5009.2 4714.2 4768.9 4793.9 4833.3 4943.1 4862.7 4873.6 4874.9 4921.3 4927.8 4072.1 4077.1 4085.5 4089.3 4117.8 3433.4 3538.0 3542.1 3562.6 3627.2 4240.4 4240.9 4259.4 4272.0 4316.9 4881.1 4886.6 4892.2 4898.0 4931.3 4093.4 4176.9 4181.9 4221.3 4225.4 4392.0 4399.7 4404.1 4416.9 4418.3 4728.3 4729.6 4732.3 4734.4 4773.1 4742.8 4831.1 4845.7 4903.5 4979.9 4711.0 4728.6 4732.2 4768.7 4769.9 4892.0 4895.1 4900.9 4913.5 4955.1 4687.4 4782.0 4782.1 4851.8 4965.7 4752.6 4769.2 4772.5 4814.9 4819.9 4758.0 4760.7 4768.7 4771.3 4813.7 4510.0 4680.4 4685.7 4686.4 4691.4 4882.3 4894.6 4896.7 4898.3 4927.2 4781.4 4784.4 4789.0 4789.3 4835.3 01:43:05 INFO - 2015-12-04 01:43:05,025 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,025 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41581.79 Median:33953.08 stddev:67246.47 (198.1%) stddev-sans-first:67364.60 01:43:05 INFO - 2015-12-04 01:43:05,025 DEBUG : BROWSER_OUTPUT: Values: 566.6 576.6 578.1 581.8 584.3 28533.0 29221.7 37478.6 38069.8 38147.2 40334.8 40669.6 40801.8 40808.4 40845.2 7069.3 7982.2 8148.4 8157.2 8163.1 7097.3 7196.2 7198.2 7198.4 7200.4 9739.1 9866.7 9878.4 9888.9 9893.3 9787.6 9822.7 9855.1 9857.4 9864.5 7216.9 7399.4 9974.0 10006.9 10311.9 38050.0 38418.6 38595.2 38788.2 38798.2 2931.1 2979.5 2999.9 3044.0 3608.2 27888.6 28647.0 28654.1 28664.7 29205.0 3362.0 3388.4 3398.6 3440.9 3494.7 226101.0 226587.0 226857.0 226950.0 227332.0 56329.7 56666.4 56720.4 56840.0 57002.4 51346.7 52613.5 60862.7 61498.4 61647.7 12977.9 13517.1 13518.6 13529.9 13594.5 9212.6 9224.2 9230.1 9237.4 9238.9 19291.1 19618.2 19704.1 19768.4 19780.0 7350.8 7648.4 7668.9 7796.6 7815.0 801.0 896.3 905.6 909.4 942.4 25262.3 25932.5 26044.1 26161.8 26748.5 925.3 1003.7 1094.9 1119.9 1120.2 13860.0 14009.1 14124.2 14147.9 14233.1 261196.0 264837.0 265608.0 265829.0 265985.0 46755.8 47115.3 47124.3 47210.5 47217.8 1203.8 1206.6 1224.0 1224.6 1227.1 25118.9 25888.5 26350.0 26498.0 26646.7 41674.0 42142.6 42160.8 42197.0 42203.8 247114.0 250309.0 250618.0 315110.0 320235.0 25984.4 26030.9 26167.6 26178.0 26413.5 34426.1 34569.7 35225.8 35389.8 35544.5 29895.7 30088.4 30380.4 32577.7 33948.3 32301.7 33192.3 33193.2 33593.0 33594.7 33240.0 33786.3 33957.8 34023.5 34068.5 28080.4 29893.0 30328.8 30532.8 30704.2 23356.0 23523.4 23545.2 23727.9 23780.2 01:43:05 INFO - 2015-12-04 01:43:05,025 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,025 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25723.74 Median:423.72 stddev:75266.50 (17763.2%) stddev-sans-first:75453.49 01:43:05 INFO - 2015-12-04 01:43:05,026 DEBUG : BROWSER_OUTPUT: Values: 330.3 332.3 333.3 336.8 337.7 12706.9 13076.2 14897.7 15580.1 16109.5 8429.2 9577.2 9869.5 13197.6 14478.6 4406.4 4531.1 4533.4 4534.9 4538.0 3353.5 4361.6 4956.4 5320.0 5353.9 5297.7 5305.7 5321.1 5332.8 5336.7 5300.9 6396.5 6639.6 6677.2 6677.2 6299.3 6360.6 6374.3 6389.1 6481.7 15996.9 16010.2 17206.7 20609.8 20994.3 1924.3 1940.0 1965.2 2030.9 2134.3 13441.7 13514.9 13896.2 14151.7 14239.7 1848.0 1876.0 1908.8 1931.4 1940.9 51451.0 51520.7 52206.5 52338.7 61807.7 15091.1 15115.5 15162.5 15209.3 15230.1 23551.8 23567.0 23765.6 23845.2 23864.5 8084.4 8144.1 8152.6 8236.4 8242.3 6791.7 6816.1 6825.2 6837.1 6861.0 7645.4 7663.4 7673.3 7688.7 7692.8 2589.4 2985.9 3037.2 3049.9 3061.0 367.2 367.3 375.3 850.4 852.6 9617.8 9924.4 9983.3 10041.1 10212.5 391.0 391.1 394.3 401.4 404.4 5383.2 5430.2 5443.7 5466.1 5527.5 436728.0 440545.0 469104.0 477804.0 477934.0 65489.7 72592.3 73026.0 73931.0 74124.3 420.5 423.7 423.7 423.7 425.2 8121.2 9254.9 9335.8 9486.9 9582.6 32396.8 32971.5 33112.2 34343.8 34375.7 41887.4 42234.4 42739.4 42843.1 44864.4 8638.9 8737.3 8739.7 8756.4 8837.1 15063.6 15338.5 15516.9 15586.8 15881.0 12954.5 12967.9 13125.6 13299.7 13365.1 12682.2 12867.1 12933.8 13304.0 13748.7 12603.9 12660.2 12748.4 13098.4 13523.8 8325.8 8737.8 8777.9 8971.3 9021.2 8900.0 11717.6 12770.2 12947.4 13314.1 01:43:05 INFO - 2015-12-04 01:43:05,026 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,026 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4997.16 Median:6081.38 stddev:2566.92 (42.2%) stddev-sans-first:2558.77 01:43:05 INFO - 2015-12-04 01:43:05,027 DEBUG : BROWSER_OUTPUT: Values: 1262.2 1571.4 1634.8 1662.7 1688.2 5713.9 6013.8 6915.2 7194.1 7212.9 7069.4 7071.5 7112.0 7120.1 7130.8 2100.2 2140.5 2141.1 2141.6 2143.5 2081.5 2086.5 2102.7 2106.0 2106.9 2033.2 2054.7 2067.6 2096.2 2096.7 2091.3 2117.6 2120.3 2123.7 2125.1 2069.3 2103.9 2116.9 2117.6 2118.9 5892.4 7150.2 7227.4 7233.6 7237.0 3517.6 4178.4 4297.8 4299.9 4303.1 2668.8 2698.8 2768.8 2769.5 2815.6 882.1 914.1 915.9 919.5 919.8 9492.0 9588.5 9614.4 9633.5 9638.2 3977.7 3998.3 4045.8 4051.6 4117.4 8347.5 8366.1 8372.4 8375.5 8405.2 4356.1 4374.1 4410.2 4413.0 4420.3 3987.7 3989.0 3997.6 4000.5 4000.9 3335.0 3344.5 3362.7 3364.4 3367.8 1086.4 1089.0 1089.7 1093.8 1096.3 970.6 985.3 985.7 1059.7 1211.2 6713.2 6729.4 6764.6 6770.2 6775.7 435.8 1101.8 1117.4 1146.7 1148.6 4828.2 5258.4 5407.6 5411.9 5419.8 7468.7 8505.9 8679.2 8685.6 8687.1 8394.0 8514.5 8522.2 8575.6 8586.4 6436.5 6538.4 6563.3 6599.5 6614.9 6767.8 6802.7 6806.1 6846.6 6848.7 7649.8 7746.7 7808.0 7923.3 7943.5 7959.5 8041.5 8065.2 8072.5 8074.6 5902.8 6021.9 6025.4 6025.4 6027.2 6745.1 6801.1 6807.7 6812.8 6818.4 6329.9 6436.9 6495.2 6560.2 6627.0 6470.8 6519.1 6527.3 6527.9 6572.6 6416.3 6442.8 6474.7 6480.7 6486.5 5937.3 5938.7 5965.3 5975.4 5998.5 6073.9 6088.8 6123.1 6125.0 6147.7 01:43:05 INFO - 2015-12-04 01:43:05,027 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,027 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4592.72 Median:5228.11 stddev:1364.09 (26.1%) stddev-sans-first:1329.19 01:43:05 INFO - 2015-12-04 01:43:05,027 DEBUG : BROWSER_OUTPUT: Values: 292.4 293.8 299.8 299.8 300.7 5210.7 5214.6 5215.7 5283.6 5326.3 5209.8 5223.5 5225.2 5231.0 5231.3 4099.6 4099.7 4101.9 4103.9 4119.5 3889.1 3974.4 3985.7 4048.3 4074.8 4055.4 4059.3 4061.5 4071.8 4081.1 3823.4 3943.4 4061.3 4070.3 4071.5 3500.7 3550.4 3550.5 3585.4 3589.6 5069.8 5078.4 5085.1 5088.1 5088.5 4672.8 4680.1 4687.3 4687.3 4692.4 5375.8 5507.4 5520.3 5527.0 5528.5 3891.6 3894.5 3895.9 3897.6 3898.1 5791.1 5792.5 5793.5 5797.1 5804.2 4010.5 4011.7 4015.4 4018.5 4019.1 3851.4 4079.5 4079.6 4080.4 4082.4 4124.9 4442.9 4505.6 4525.7 4550.2 5418.9 5505.0 5508.3 5539.3 5558.4 1373.5 1398.9 1399.7 1401.3 1404.5 925.7 929.9 935.7 942.5 945.6 4877.4 4888.9 4893.8 4895.0 4900.4 5737.5 5739.5 5740.8 5744.1 5747.9 4812.2 4821.5 4860.3 4862.3 4874.5 2845.4 2905.2 3049.2 3082.7 3087.8 5383.6 5484.4 5503.0 5511.3 5512.9 5960.1 5967.2 5967.5 5975.8 5978.8 5491.1 5504.6 5511.9 5512.0 5512.0 5644.2 5799.1 5806.2 5807.3 5809.2 5666.6 5673.3 5675.8 5677.5 5677.6 5487.8 5495.7 5503.2 5505.9 5510.3 3918.3 3954.2 3957.9 3959.4 3962.0 5635.7 5772.3 5775.2 5778.6 5780.0 5514.1 5549.3 5554.6 5555.1 5561.4 5540.9 5547.9 5554.4 5555.6 5559.2 5308.0 5434.9 5446.8 5453.8 5454.8 5590.0 5593.2 5599.9 5601.8 5609.7 5249.5 5384.8 5394.8 5467.5 5469.8 01:43:05 INFO - 2015-12-04 01:43:05,028 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,028 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12750.66 Median:463.60 stddev:14721.63 (3175.5%) stddev-sans-first:14735.30 01:43:05 INFO - 2015-12-04 01:43:05,029 DEBUG : BROWSER_OUTPUT: Values: 741.0 750.6 770.7 778.9 817.5 12617.6 12732.0 12788.4 12799.4 12852.1 11279.8 12951.5 13303.1 13308.1 13330.7 627.9 634.3 810.2 817.0 830.2 815.7 818.1 819.7 822.6 824.1 844.9 848.8 853.5 853.6 853.8 656.0 664.9 833.7 845.9 847.1 627.6 627.9 628.1 628.1 628.2 12741.6 12857.9 12899.0 12915.2 12915.7 10738.8 10757.4 11326.3 11464.2 11819.4 9250.6 9650.5 9680.6 9708.1 9747.7 3285.3 3300.4 3327.8 3335.1 3341.5 42044.0 42145.4 42434.4 42577.0 42638.6 9240.8 9375.9 9419.9 9445.0 9463.5 16437.1 16456.5 16475.3 16479.7 16480.9 6322.9 6477.8 6504.4 6507.8 6558.3 3525.5 3527.5 3536.4 3573.6 3583.4 2655.0 2682.7 2690.3 2691.4 2691.7 460.1 467.1 476.9 477.1 479.7 473.6 509.9 548.4 559.5 582.9 7265.5 7362.6 7372.2 7403.5 7461.6 419.7 476.7 524.1 555.5 596.4 3521.9 3550.5 3683.8 3721.0 3745.8 49566.3 49735.5 49831.5 49878.0 49944.3 46946.8 47139.5 47507.3 47898.0 48285.5 43723.0 44163.1 44618.6 44661.3 44984.8 7536.9 7626.1 7811.8 7945.6 8059.1 33742.3 34039.8 34658.8 34836.0 34860.5 43594.0 43706.8 43773.8 43982.6 44333.1 10200.7 10212.4 10255.7 10286.5 10452.4 10828.1 11019.8 11118.2 11284.6 11376.9 10018.7 10255.7 10296.9 10495.8 10882.3 10059.9 10208.9 10277.6 10300.2 10793.6 9830.9 10112.9 10222.1 10325.2 10728.7 9222.7 9267.7 9294.2 9414.0 9616.0 8610.6 8674.0 8698.9 8777.7 9023.6 01:43:05 INFO - 2015-12-04 01:43:05,029 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:43:05 INFO - 2015-12-04 01:43:05,029 DEBUG : BROWSER_OUTPUT: 01:43:05 INFO - 2015-12-04 01:43:05,826 INFO : Browser exited with error code: 0 01:43:05 INFO - 2015-12-04 01:43:05,844 INFO : Completed test dromaeo_css (00:18:37) 01:43:05 INFO - 2015-12-04 01:43:05,844 INFO : Starting test kraken 01:43:05 INFO - 2015-12-04 01:43:05,844 DEBUG : operating with platform_type : linux_ 01:43:05 INFO - 2015-12-04 01:43:05,845 INFO : Initialising browser for kraken test... 01:43:05 INFO - 2015-12-04 01:43:05,851 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPc2Ka/profile http://localhost:36293/getInfo.html 01:43:10 INFO - 2015-12-04 01:43:10,271 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:43:10 INFO - 2015-12-04 01:43:10,271 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:43:10 INFO - 2015-12-04 01:43:10,271 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:43:10 INFO - 2015-12-04 01:43:10,271 DEBUG : BROWSER_OUTPUT: __metrics 01:43:10 INFO - 2015-12-04 01:43:10,393 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] 01:43:10 INFO - 2015-12-04 01:43:10,469 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] 01:43:11 INFO - 2015-12-04 01:43:11,271 INFO : Browser initialized. 01:43:11 INFO - 2015-12-04 01:43:11,271 INFO : Running cycle 1/1 for kraken test... 01:43:11 INFO - 2015-12-04 01:43:11,272 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPc2Ka/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:43:23 INFO - 2015-12-04 01:43:23,258 DEBUG : BROWSER_OUTPUT: RSS: Main: 150224896 01:43:23 INFO - 2015-12-04 01:43:23,258 DEBUG : BROWSER_OUTPUT: 01:43:25 INFO - 2015-12-04 01:43:25,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36293/tests/kraken/driver.html?testName=audio-beat-detection) 01:43:26 INFO - 2015-12-04 01:43:26,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 189841408 01:43:26 INFO - 2015-12-04 01:43:26,481 DEBUG : BROWSER_OUTPUT: 01:43:29 INFO - 2015-12-04 01:43:29,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36293/tests/kraken/driver.html?testName=audio-dft) 01:43:29 INFO - 2015-12-04 01:43:29,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 177872896 01:43:29 INFO - 2015-12-04 01:43:29,798 DEBUG : BROWSER_OUTPUT: 01:43:32 INFO - 2015-12-04 01:43:32,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36293/tests/kraken/driver.html?testName=audio-fft) 01:43:33 INFO - 2015-12-04 01:43:33,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 161914880 01:43:33 INFO - 2015-12-04 01:43:33,400 DEBUG : BROWSER_OUTPUT: 01:43:35 INFO - 2015-12-04 01:43:35,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36293/tests/kraken/driver.html?testName=audio-oscillator) 01:43:36 INFO - 2015-12-04 01:43:36,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 164638720 01:43:36 INFO - 2015-12-04 01:43:36,026 DEBUG : BROWSER_OUTPUT: 01:43:38 INFO - 2015-12-04 01:43:38,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:43:38 INFO - 2015-12-04 01:43:38,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 165392384 01:43:38 INFO - 2015-12-04 01:43:38,846 DEBUG : BROWSER_OUTPUT: 01:43:41 INFO - 2015-12-04 01:43:41,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36293/tests/kraken/driver.html?testName=imaging-darkroom) 01:43:42 INFO - 2015-12-04 01:43:42,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 165462016 01:43:42 INFO - 2015-12-04 01:43:42,419 DEBUG : BROWSER_OUTPUT: 01:43:45 INFO - 2015-12-04 01:43:45,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36293/tests/kraken/driver.html?testName=imaging-desaturate) 01:43:46 INFO - 2015-12-04 01:43:46,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 165195776 01:43:46 INFO - 2015-12-04 01:43:46,393 DEBUG : BROWSER_OUTPUT: 01:43:49 INFO - 2015-12-04 01:43:49,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36293/tests/kraken/driver.html?testName=json-parse-financial) 01:43:49 INFO - 2015-12-04 01:43:49,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 166658048 01:43:49 INFO - 2015-12-04 01:43:49,814 DEBUG : BROWSER_OUTPUT: 01:43:51 INFO - 2015-12-04 01:43:51,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:43:52 INFO - 2015-12-04 01:43:52,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 176713728 01:43:52 INFO - 2015-12-04 01:43:52,142 DEBUG : BROWSER_OUTPUT: 01:43:54 INFO - 2015-12-04 01:43:54,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:43:54 INFO - 2015-12-04 01:43:54,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 176160768 01:43:54 INFO - 2015-12-04 01:43:54,652 DEBUG : BROWSER_OUTPUT: 01:43:56 INFO - 2015-12-04 01:43:56,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:43:57 INFO - 2015-12-04 01:43:57,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 190148608 01:43:57 INFO - 2015-12-04 01:43:57,356 DEBUG : BROWSER_OUTPUT: 01:43:59 INFO - 2015-12-04 01:43:59,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:44:00 INFO - 2015-12-04 01:44:00,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 193581056 01:44:00 INFO - 2015-12-04 01:44:00,497 DEBUG : BROWSER_OUTPUT: 01:44:03 INFO - 2015-12-04 01:44:03,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:44:03 INFO - 2015-12-04 01:44:03,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 192405504 01:44:03 INFO - 2015-12-04 01:44:03,733 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36293/tests/kraken/driver.html?testName=ai-astar) 01:44:05 INFO - 2015-12-04 01:44:05,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 249929728 01:44:05 INFO - 2015-12-04 01:44:05,737 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,738 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;106;112;112;113;103;113;112;111 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;129;161;172;143;149;153;140;170;129 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;160;160;159;160;163;161;163;161 01:44:05 INFO - 2015-12-04 01:44:05,739 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;92;95;75;72;74;107;91;71 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;94;135;94;94;94;135;94;95;135 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;110;110;110;110 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;146;146;148;146;146;146 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;95;95;95;96;95 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;70;71;69;70;70;79;68;69 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;68;67;69;68;69;68 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;87;87;85;86;85;86;85;86 01:44:05 INFO - 2015-12-04 01:44:05,740 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;124;128;127;118;118;120;123;122;125 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;160;149;145;146;143;149;145;147;135 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;68;68;70;69;67;71;68 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,985 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1449222245737__endTimestamp 01:44:05 INFO - 2015-12-04 01:44:05,741 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.27 (2.9%) stddev-sans-first:3.46 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 106.0 112.0 112.0 113.0 103.0 113.0 112.0 111.0 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:157.00 stddev:15.58 (9.9%) stddev-sans-first:15.99 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: Values: 162.0 129.0 161.0 172.0 143.0 149.0 153.0 140.0 170.0 129.0 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,749 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.36 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 160.0 160.0 159.0 160.0 163.0 161.0 163.0 161.0 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:12.55 (16.7%) stddev-sans-first:13.01 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 92.0 95.0 75.0 72.0 74.0 107.0 91.0 71.0 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:94.00 stddev:19.55 (20.8%) stddev-sans-first:20.42 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: Values: 97.0 94.0 135.0 94.0 94.0 94.0 135.0 94.0 95.0 135.0 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,750 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.60 Median:70.00 stddev:3.06 (4.4%) stddev-sans-first:3.24 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 71.0 69.0 70.0 70.0 79.0 68.0 69.0 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 68.0 67.0 69.0 68.0 69.0 68.0 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.18 (1.4%) stddev-sans-first:0.83 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 87.0 87.0 85.0 86.0 85.0 86.0 85.0 86.0 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:4.12 (3.3%) stddev-sans-first:3.63 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 130.0 124.0 128.0 127.0 118.0 118.0 120.0 123.0 122.0 125.0 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:148.00 stddev:6.62 (4.5%) stddev-sans-first:6.56 01:44:05 INFO - 2015-12-04 01:44:05,751 DEBUG : BROWSER_OUTPUT: Values: 154.0 160.0 149.0 145.0 146.0 143.0 149.0 145.0 147.0 135.0 01:44:05 INFO - 2015-12-04 01:44:05,752 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-04 01:44:05,752 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 01:44:05 INFO - 2015-12-04 01:44:05,752 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 70.0 69.0 67.0 71.0 68.0 01:44:05 INFO - 2015-12-04 01:44:05,752 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:05 INFO - 2015-12-04 01:44:05,752 DEBUG : BROWSER_OUTPUT: 01:44:06 INFO - 2015-12-04 01:44:06,662 INFO : Browser exited with error code: 0 01:44:06 INFO - 2015-12-04 01:44:06,715 INFO : Completed test kraken (00:01:00) 01:44:06 INFO - 2015-12-04 01:44:06,716 INFO : Starting test v8_7 01:44:06 INFO - 2015-12-04 01:44:06,716 DEBUG : operating with platform_type : linux_ 01:44:06 INFO - 2015-12-04 01:44:06,716 INFO : Initialising browser for v8_7 test... 01:44:06 INFO - 2015-12-04 01:44:06,722 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9FKstn/profile http://localhost:36293/getInfo.html 01:44:11 INFO - 2015-12-04 01:44:11,240 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:44:11 INFO - 2015-12-04 01:44:11,240 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:44:11 INFO - 2015-12-04 01:44:11,240 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:44:11 INFO - 2015-12-04 01:44:11,240 DEBUG : BROWSER_OUTPUT: __metrics 01:44:11 INFO - 2015-12-04 01:44:11,341 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] 01:44:11 INFO - 2015-12-04 01:44:11,402 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] 01:44:11 ERROR - 2015-12-04 01:44:11,417 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 01:44:12 INFO - 2015-12-04 01:44:12,242 INFO : Browser initialized. 01:44:12 INFO - 2015-12-04 01:44:12,242 INFO : Running cycle 1/1 for v8_7 test... 01:44:12 INFO - 2015-12-04 01:44:12,243 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9FKstn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:44:24 INFO - 2015-12-04 01:44:24,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 151121920 01:44:24 INFO - 2015-12-04 01:44:24,205 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36293/tests/v8_7/run.html (next: http://localhost:36293/tests/v8_7/run.html) 01:44:45 INFO - 2015-12-04 01:44:45,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 453378048 01:44:45 INFO - 2015-12-04 01:44:45,862 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,863 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |0;Richards;167.02856188408217 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.52984212552946 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 01:44:45 INFO - 2015-12-04 01:44:45,864 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: |6;Boyer;12047.619047619048 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: |7;RegExp;26973.684210526317 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: |8;Splay;598.8023952095808 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:44:45 INFO - 2015-12-04 01:44:45,865 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:44:45 INFO - 2015-12-04 01:44:45,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1449222285863__endTimestamp 01:44:45 INFO - 2015-12-04 01:44:45,866 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:44:45 INFO - 2015-12-04 01:44:45,867 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:44:45 INFO - 2015-12-04 01:44:45,867 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,867 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: Values: 167.0 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.53 Median:192.53 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: Values: 192.5 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,868 DEBUG : BROWSER_OUTPUT: Values: 278.6 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: Values: 5143.6 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: Values: 1986.1 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: Values: 784.9 01:44:45 INFO - 2015-12-04 01:44:45,869 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12047.62 Median:12047.62 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: Values: 12047.6 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26973.68 Median:26973.68 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: Values: 26973.7 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.80 Median:598.80 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: Values: 598.8 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:44:45 INFO - 2015-12-04 01:44:45,870 DEBUG : BROWSER_OUTPUT: 01:44:46 INFO - 2015-12-04 01:44:46,726 INFO : Browser exited with error code: 0 01:44:46 INFO - 2015-12-04 01:44:46,740 INFO : Completed test v8_7 (00:00:40) 01:44:46 INFO - 2015-12-04 01:44:46,886 INFO : Completed test suite (00:20:18) 01:44:46 INFO - 2015-12-04 01:44:46,886 DEBUG : Working with test: dromaeo_css 01:44:46 INFO - 2015-12-04 01:44:46,886 DEBUG : Generating results file: dromaeo_css 01:44:46 INFO - 2015-12-04 01:44:46,887 DEBUG : Working with test: kraken 01:44:46 INFO - 2015-12-04 01:44:46,887 DEBUG : Generating results file: kraken 01:44:46 INFO - 2015-12-04 01:44:46,888 INFO : javascript benchmark 01:44:46 INFO - 2015-12-04 01:44:46,888 DEBUG : Working with test: v8_7 01:44:46 INFO - 2015-12-04 01:44:46,888 DEBUG : Generating results file: v8_7 01:44:46 INFO - 2015-12-04 01:44:46,888 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:46 INFO - 2015-12-04 01:44:46,937 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,144,35]] 01:44:46 INFO - 2015-12-04 01:44:46,937 DEBUG : process_Request line: dromaeo_css 6279.50 graph.html#tests=[[72,144,35]] 01:44:46 INFO - 2015-12-04 01:44:46,938 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:46 INFO - 2015-12-04 01:44:46,964 DEBUG : process_Request line: kraken 1526.90 graph.html#tests=[[232,144,35]] 01:44:46 INFO - 2015-12-04 01:44:46,964 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:44:46 INFO - 2015-12-04 01:44:46,995 DEBUG : process_Request line: v8_7 19786.89 graph.html#tests=[[230,144,35]] 01:44:46 INFO - 2015-12-04 01:44:46,996 INFO : javascript benchmark 01:44:47 INFO - 2015-12-04 01:44:47,000 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2584.870756462177, 2669.3326668332907, 2675.0637276953057, 2686.7178946210647, 2701.5542435498146, 4428.844990425336, 4530.0, 4599.793009314581, 4616.722996620205, 4628.745419001958, 4544.97727511362, 4566.315052742082, 4577.382053422795, 4590.63274938005, 4704.4589872164715, 4217.472815898012, 4240.173166232578, 4271.039016221356, 4323.178596066753, 4326.8269269229195, 4255.276602977501, 4368.082702632451, 4407.162639098577, 4413.3821265022925, 4438.400815889862, 4080.285949958775, 4178.8537401191115, 4180.184863951531, 4356.477222733276, 4411.029573493826, 4182.519010313792, 4255.510616279105, 4267.935980960288, 4274.914501709979, 4275.935860962088, 4229.70392072555, 4246.745195288262, 4252.702310838243, 4257.723247988871, 4287.8284868605215, 4313.09425020746, 4422.491413487458, 4432.534583868712, 4546.681732278742, 4605.055963527502, 4814.831480898151, 4815.301781241736, 4824.782884770194, 4895.143349913787, 4940.950590494085, 4949.82675606352, 4957.727324997124, 4995.650304478688, 5010.398752149729, 5013.974930125326, 4556.817727290904, 4583.518730533313, 4584.243599805995, 4604.58558729716, 4625.352450656911, 4759.881002974884, 4923.48303428142, 4923.606111511071, 5010.398752149693, 5094.312267843794, 4870.391201099863, 4872.4153101628035, 4876.512348765166, 4882.633802464829, 4884.902301953941, 4969.850904472872, 4970.950290497121, 4974.129527332702, 4981.800727970913, 5009.223570346602, 4714.198586240347, 4768.880777980578, 4793.856184314406, 4833.299171620166, 4943.134951383494, 4862.708237505761, 4873.585745211626, 4874.878128046827, 4921.261810728348, 4927.7536123193695, 4072.1448495815616, 4077.1437998020156, 4085.530164031115, 4089.3048181809163, 4117.773522456294, 3433.3991551478393, 3538.0270425633157, 3542.1498840278664, 3562.625924277965, 3627.238279961185, 4240.363945408213, 4240.851570195028, 4259.361095835649, 4272.038791271939, 4316.870493885189, 4881.072596206709, 4886.60907127429, 4892.19278818998, 4897.951020489821, 4931.334269873593, 4093.4269202311702, 4176.916461670749, 4181.933606930274, 4221.303484925014, 4225.366195070703, 4391.978040109779, 4399.692021558524, 4404.075144219686, 4416.933745993812, 4418.270985287456, 4728.267118596623, 4729.6452766042685, 4732.290156476418, 4734.360861283752, 4773.11697335994, 4742.834000809955, 4831.0820944020525, 4845.709257444564, 4903.509649035068, 4979.9004019918675, 4710.9764451177525, 4728.645351598575, 4732.19552676039, 4768.66619336657, 4769.928451073168, 4891.9755401222765, 4895.069936712156, 4900.852974410774, 4913.508649135058, 4955.132851751001, 4687.3906392170165, 4782.043591281688, 4782.139214941344, 4851.75741212945, 4965.702057876539, 4752.643551733565, 4769.189237829647, 4772.546608072227, 4814.879628009187, 4819.879503012453, 4758.0, 4760.690555113906, 4768.690035147704, 4771.260454629538, 4813.687110337957, 4510.0, 4680.3915490985955, 4685.695429797052, 4686.367340409001, 4691.366665500113, 4882.267659851051, 4894.583960363267, 4896.730679812645, 4898.289747986593, 4927.236278376858, 4781.402324709411, 4784.354112194809, 4788.952110478851, 4789.3294938709305, 4835.29888166221], "unit": "ms", "name": "dojo.html", "value": 4515.846628348594}, {"lowerIsBetter": false, "replicates": [566.6118708684548, 576.6251936241446, 578.0779656447966, 581.8312689320098, 584.330941072472, 28533.0, 29221.707782922193, 37478.62521374789, 38069.80965095178, 38147.237055258876, 40334.79832600833, 40669.59330406695, 40801.79599102, 40808.38787418183, 40845.183096338056, 7069.328413800681, 7982.2416870397365, 8148.388870834681, 8157.184281571855, 8163.142869998654, 7097.290270972913, 7196.208417074117, 7198.172210195842, 7198.3521483066515, 7200.38796702281, 9739.074787895139, 9866.654667086654, 9878.407295562254, 9888.85166722496, 9893.25800564957, 9787.559559819789, 9822.705318840446, 9855.113039826414, 9857.408555486694, 9864.50677466131, 7216.8917466238045, 7399.408047356199, 9973.950130249303, 10006.9499652502, 10311.896881031169, 38050.04874878123, 38418.61581384178, 38595.22809543793, 38788.224235515416, 38798.224035519415, 2931.1060126661573, 2979.478591246545, 2999.8500074996164, 3043.9543406848916, 3608.2422989374118, 27888.581671274744, 28647.0, 28654.140375788553, 28664.71335286662, 29205.0, 3361.96638033619, 3388.390089783838, 3398.558187435642, 3440.913977150566, 3494.7204223662047, 226101.0, 226587.0, 226857.0, 226950.0, 227332.0, 56329.71835140798, 56666.433335666115, 56720.43279567151, 56840.0, 57002.42997569971, 51346.71633209199, 52613.47386526086, 60862.695686521285, 61498.38501615016, 61647.6917615418, 12977.870221297855, 13517.121387110003, 13518.594442166554, 13529.932350338186, 13594.456221751218, 9212.631494740135, 9224.215941645036, 9230.123138301851, 9237.353385262966, 9238.86141707875, 19291.06885766779, 19618.215271388985, 19704.113314900864, 19768.40694779159, 19780.0, 7350.77947661571, 7648.38812894967, 7668.884966725504, 7796.5711885845685, 7814.960925195452, 800.9559474228856, 896.2740180453853, 905.5879574793453, 909.3907082254905, 942.4109931292942, 25262.30670167411, 25932.481350372887, 26044.08845690392, 26161.776249018665, 26748.465030699277, 925.3060204846365, 1003.6687892995294, 1094.9397783121844, 1119.904808091305, 1120.2046546951756, 13860.0, 14009.08940918837, 14124.152550846982, 14147.858521414653, 14233.146011239358, 261196.0, 264837.0, 265608.0, 265829.0, 265985.0, 46755.76622116868, 47115.29327060097, 47124.293135602995, 47210.5278947213, 47217.76391118091, 1203.7773011992808, 1206.6259459567561, 1223.993880030612, 1224.6326102169314, 1227.110344999868, 25118.874405628587, 25888.48223035491, 26350.0, 26498.0, 26646.733532664424, 41674.0, 42142.57857421387, 42160.789196053825, 42197.0, 42203.788981054895, 247114.0, 250309.0, 250618.0, 315110.0, 320235.0, 25984.35039124037, 26030.86984565065, 26167.607485888107, 26178.0, 26413.471730565667, 34426.13934651654, 34569.654303457646, 35225.82387088048, 35389.82305088458, 35544.46683299804, 29895.70104299016, 30088.398232035674, 30380.392392151593, 32577.674223257465, 33948.32103357869, 32301.676983229867, 33192.33615327728, 33193.17017074592, 33593.0, 33594.66405336013, 33240.0, 33786.32427351488, 33957.830210849774, 34023.48964765481, 34068.488972664934, 28080.43839123247, 29893.0, 30328.84835575808, 30532.847335763177, 30704.16197975253, 23356.0, 23523.411914701584, 23545.175918842757, 23727.881360593088, 23780.16769413062], "unit": "ms", "name": "ext.html", "value": 17077.758844020656}, {"lowerIsBetter": false, "replicates": [330.25692192566726, 332.3336709896657, 333.3433136720661, 336.8383176075484, 337.6960735338197, 12706.93646531766, 13076.215427074381, 14897.702045959075, 15580.065196088242, 16109.516714498555, 8429.241368276855, 9577.185939195177, 9869.506524673756, 13197.604071877859, 14478.565643030699, 4406.361077643748, 4531.093781243748, 4533.387992620987, 4534.909301813962, 4538.0, 3353.4634458486526, 4361.629261512775, 4956.3804524434445, 5320.042392369372, 5353.946460535403, 5297.682139071649, 5305.6551324164, 5321.068812957737, 5332.840014799563, 5336.733163341837, 5300.92048619271, 6396.488280937514, 6639.601623902581, 6677.23211830636, 6677.232118306384, 6299.307076221612, 6360.586561873463, 6374.298827129012, 6389.073584330246, 6481.708323125471, 15996.920015399848, 16010.199490025452, 17206.655866882717, 20609.793902060937, 20994.265200718055, 1924.3361040441166, 1939.9612007759765, 1965.1746266568075, 2030.9492262693402, 2134.338355109921, 13441.66395840102, 13514.932425337909, 13896.235707036109, 14151.716965660733, 14239.715205695931, 1847.9836090150363, 1875.9812401875943, 1908.799576044523, 1931.401265607652, 1940.8932508712014, 51451.0, 51520.74239628815, 52206.477935220544, 52338.73830630822, 61807.690961545355, 15091.094534327756, 15115.470958516618, 15162.469313573973, 15209.315580798891, 15230.086194828345, 23551.764482354956, 23567.0, 23765.643515347285, 23845.165419210243, 23864.522709545712, 8084.3936704747375, 8144.063432705197, 8152.551609661526, 8236.382271329554, 8242.340612750966, 6791.694373753193, 6816.147981502312, 6825.180978282638, 6837.111175547247, 6861.0, 7645.388368930583, 7663.386929045663, 7673.309402153833, 7688.692452301957, 7692.7692169235015, 2589.4173810892776, 2985.8805647773847, 3037.240689827543, 3049.862756175977, 3060.9846950765104, 367.15920541958616, 367.3021259606715, 375.2832090706737, 850.3537311643196, 852.577973902922, 9617.759556011155, 9924.354916930377, 9983.301168918106, 10041.146502547364, 10212.489375531193, 390.97654140751644, 391.1082731372475, 394.3296396126596, 401.44199562608, 404.4378314143343, 5383.16560933056, 5430.15832545956, 5443.700596467233, 5466.070767969455, 5527.474889885454, 436728.0, 440545.0, 469104.0, 477804.0, 477934.0, 65489.67255163693, 72592.2740772596, 73026.0, 73931.0, 74124.25875741281, 420.45131103909694, 423.713993054693, 423.7288135593223, 423.74363510076574, 425.24943474766445, 8121.228483294078, 9254.861177082485, 9335.813283734424, 9486.905130948602, 9582.616695332108, 32396.83801580977, 32971.505427419084, 33112.17219569434, 34343.82828085944, 34375.65624343824, 41887.37168942407, 42234.36648450337, 42739.35890961576, 42843.143137137704, 44864.4108471315, 8638.870416943877, 8737.344699147463, 8739.650413983623, 8756.387052906235, 8837.116288371111, 15063.623409414853, 15338.463153789564, 15516.922415388302, 15586.844131558993, 15881.0, 12954.546590869275, 12967.870321296667, 13125.60623181306, 13299.734005320033, 13365.131266467648, 12682.239065656091, 12867.099303048697, 12933.805992909925, 13304.002199834858, 13748.725025499634, 12603.93698031504, 12660.240385576895, 12748.426320815772, 13098.410571524495, 13523.797143042666, 8325.83348333042, 8737.781555461164, 8777.868331974898, 8971.32715046361, 9021.233195178484, 8900.020997690119, 11717.589884354007, 12770.23378597287, 12947.417366218731, 13314.134581252187], "unit": "ms", "name": "jquery.html", "value": 8047.78080677867}, {"lowerIsBetter": false, "replicates": [1262.1669697999323, 1571.3635977429142, 1634.7793047938524, 1662.659154873251, 1688.1981058996978, 5713.942860571398, 6013.849653758658, 6915.239323674392, 7194.0647715797, 7212.927870721304, 7069.434445244381, 7071.540349877255, 7112.0, 7120.1099862517185, 7130.75042373517, 2100.191426300874, 2140.4862832920144, 2141.100737690166, 2141.625215587266, 2143.506993391521, 2081.521250112475, 2086.457521044524, 2102.6530622447276, 2105.968410473844, 2106.8735875847424, 2033.186725309873, 2054.6507093794016, 2067.5968186203695, 2096.1929657082055, 2096.727425434691, 2091.341227513336, 2117.6400011998, 2120.342693764938, 2123.7026816245816, 2125.1499400240027, 2069.2757534862826, 2103.905324260412, 2116.8941552922292, 2117.5976564452703, 2118.8834614096218, 5892.381299963485, 7150.213476517579, 7227.421806255487, 7233.565986040801, 7237.0, 3517.5778906531123, 4178.415021896937, 4297.763623000734, 4299.871003869889, 4303.074838909618, 2668.839055011057, 2698.77060449862, 2768.7784977201977, 2769.515334816399, 2815.5776633504934, 882.0782282514723, 914.1178762494159, 915.8626206069076, 919.5034681272105, 919.7608621758324, 9491.952540237324, 9588.520573971273, 9614.423134611876, 9633.518324083769, 9638.228941684649, 3977.7016723745833, 3998.280309544252, 4045.7572545647354, 4051.6353528182603, 4117.444145040441, 8347.54088525137, 8366.121557236524, 8372.372072094617, 8375.539345335943, 8405.201505856934, 4356.063446358985, 4374.125174964956, 4410.162069206905, 4412.955870441318, 4420.292753159479, 3987.6610488108836, 3988.980055099706, 3997.600239975979, 4000.5399379071196, 4000.9199816003515, 3335.0, 3344.5317655528247, 3362.6637336266667, 3364.3944090064024, 3367.8316084195694, 1086.4079076903106, 1089.003561740998, 1089.700332408578, 1093.8468614393832, 1096.3257596578046, 970.6263088710756, 985.3053597213947, 985.6500942165571, 1059.7403636109048, 1211.1582450197204, 6713.1944166700305, 6729.360710732472, 6764.5603035802515, 6770.221424536143, 6775.661216939232, 435.7603318174991, 1101.7741363020561, 1117.435694974049, 1146.7190538318166, 1148.5635458525708, 4828.227483602606, 5258.368995720538, 5407.567394608422, 5411.891762164813, 5419.810306639328, 7468.663910124057, 8505.914940850636, 8679.17547832955, 8685.565721713889, 8687.131286871389, 8394.0, 8514.531700756517, 8522.232999030117, 8575.571221438902, 8586.356023298153, 6436.485081193493, 6538.444232240313, 6563.278039415756, 6599.53803233769, 6614.86770264592, 6767.763128290486, 6802.693878775368, 6806.081179040964, 6846.554973926679, 6848.6918088687125, 7649.847003060019, 7746.690132394641, 7808.0, 7923.286904178421, 7943.4836735612, 7959.482633628795, 8041.517508949481, 8065.153158918229, 8072.475289106189, 8074.555899425588, 5902.763889444374, 6021.909671355021, 6025.367336429612, 6025.427584379477, 6027.186329845415, 6745.089412929388, 6801.149856267966, 6807.693653785493, 6812.82967925786, 6818.420434262945, 6329.8734025320155, 6436.9034464484, 6495.188101487314, 6560.212774466903, 6626.966865165836, 6470.838229044311, 6519.054737063194, 6527.3472652734345, 6527.9020814688765, 6572.572782769104, 6416.262129855127, 6442.8389290268115, 6474.676266186766, 6480.740770369321, 6486.513511486563, 5937.2578427696535, 5938.673372964356, 5965.28416590012, 5975.40245975399, 5998.4601385875485, 6073.939260607337, 6088.817335479943, 6123.112148738319, 6125.019996800491, 6147.66187859672], "unit": "ms", "name": "mootools.html", "value": 4118.8658468408075}, {"lowerIsBetter": false, "replicates": [292.44873413615335, 293.7532472722912, 299.77816415852277, 299.79913457983145, 300.6692638098091, 5210.713410762407, 5214.556762675173, 5215.713135777535, 5283.6037297202765, 5326.334208223972, 5209.791608335671, 5223.503767142115, 5225.242339860718, 5230.9738451307785, 5231.319928409311, 4099.6105369989955, 4099.73351732138, 4101.897452563695, 4103.8563650272245, 4119.505659320871, 3889.105505733683, 3974.4237085622713, 3985.7409268397605, 4048.291548978917, 4074.775887326196, 4055.371417430288, 4059.309917314049, 4061.4923134608175, 4071.796410179479, 4081.1225586499045, 3823.3500304948225, 3943.4479172915817, 4061.3298805697023, 4070.3487442009136, 4071.531773846001, 3500.7374446916583, 3550.4496802995577, 3550.520679708258, 3585.4084076127406, 3589.587197472298, 5069.822556210552, 5078.390593128848, 5085.1355269604255, 5088.084144853925, 5088.542031217171, 4672.836450724209, 4680.063987202573, 4687.250039993619, 4687.343771871941, 4692.389989301403, 5375.838724838261, 5507.366652834935, 5520.282363292787, 5526.977509160818, 5528.530074943635, 3891.610838916086, 3894.4547763313158, 3895.941560876589, 3897.61023897608, 3898.083950271684, 5791.102379131242, 5792.478676919055, 5793.507551858097, 5797.101449275369, 5804.216430781875, 4010.538788039413, 4011.679065674739, 4015.377616469452, 4018.4976877890263, 4019.055521952339, 3851.383778595411, 4079.4900637420324, 4079.6124368184974, 4080.4287399764057, 4082.408050832613, 4124.938125928114, 4442.933355999663, 4505.594496495331, 4525.728456292633, 4550.2492088804975, 5418.91871621926, 5505.03661859173, 5508.283923089973, 5539.307586551681, 5558.416366281483, 1373.4643489039283, 1398.9300534973413, 1399.657084014423, 1401.31335645535, 1404.5224623627812, 925.7130289610243, 929.874466946967, 935.6865450074165, 942.4863449419945, 945.5697657565792, 4877.439094504107, 4888.877778055577, 4893.804247830047, 4894.975525122423, 4900.436449808247, 5737.454941780524, 5739.512141467939, 5740.770369185269, 5744.138379243147, 5747.8563035924435, 4812.181929072066, 4821.54195351441, 4860.3195552622665, 4862.343583616166, 4874.512548745097, 2845.374017716099, 2905.1575043237226, 3049.2224482756756, 3082.737967272762, 3087.7529797616135, 5383.596230282745, 5484.424135465799, 5503.0, 5511.311086114236, 5512.944870551243, 5960.135780311917, 5967.19442875215, 5967.46292833647, 5975.7609695612555, 5978.760849566055, 5491.121420572689, 5504.614676972574, 5511.862203444946, 5511.9724401378535, 5511.9724401378535, 5644.2380278663495, 5799.101139323411, 5806.2451881255165, 5807.303123625192, 5809.157672137601, 5666.631668941505, 5673.319201695823, 5675.801346952837, 5677.51741102011, 5677.574181936288, 5487.780488780404, 5495.697736624365, 5503.2020357048805, 5505.889882202414, 5510.338759348904, 3918.2555314490155, 3954.2289253595272, 3957.881263562098, 3959.40608908666, 3962.0293028208275, 5635.690037048002, 5772.307323121252, 5775.220345253337, 5778.56660750437, 5780.0, 5514.117741161395, 5549.334079910436, 5554.555635549227, 5555.111182210827, 5561.388247292875, 5540.916886246629, 5547.916781248366, 5554.416786237549, 5555.583331250092, 5559.221708960829, 5308.0, 5434.891302174014, 5446.836594902159, 5453.754581043783, 5454.754536045808, 5589.972050139723, 5593.216949626974, 5599.944000559943, 5601.775928962796, 5609.691466969356, 5249.501297376743, 5384.838454846361, 5394.757235924314, 5467.4532546745, 5469.835904922858], "unit": "ms", "name": "prototype.html", "value": 4150.528909693092}, {"lowerIsBetter": false, "replicates": [741.0292516802992, 750.5534207146745, 770.7456539342018, 778.8559116563437, 817.5380909785972, 12617.5583854565, 12731.999999999989, 12788.360581970888, 12799.424025918832, 12852.100352975296, 11279.830802537968, 12951.546695865647, 13303.068785185042, 13308.068435209516, 13330.733385332287, 627.9466245369126, 634.2515831319041, 810.2302812328282, 816.9632366543519, 830.1864173110356, 815.7185770909057, 818.0510607695074, 819.6967122164807, 822.5763731678161, 824.1428913929506, 844.9028361738386, 848.7962888906649, 853.5007020892785, 853.6030745703247, 853.8121613245077, 655.9868802623945, 664.8537321789198, 833.7082021292559, 845.8858054162671, 847.1232274595764, 627.5952010952956, 627.886980343538, 628.0641843652925, 628.1206311164361, 628.1833616298793, 12741.55404560836, 12857.871421285854, 12899.0, 12915.22508649484, 12915.677108072374, 10738.838917416246, 10757.354558726502, 11326.263792853439, 11464.19750617457, 11819.409029548575, 9250.583723732449, 9650.469224192666, 9680.612775488971, 9708.077732615391, 9747.707568772948, 3285.3100848821778, 3300.3894279558117, 3327.800331980089, 3335.0995231287416, 3341.532185494033, 42044.0, 42145.36781948273, 42434.36348454776, 42576.99999999969, 42638.57361426377, 9240.7689807754, 9375.90624093764, 9419.90580094204, 9445.0, 9463.456688582872, 16437.09595972233, 16456.506304810875, 16475.34098636041, 16479.670406591802, 16480.917595411946, 6322.905156422566, 6477.838054048592, 6504.414602685781, 6507.837304067436, 6558.311377305409, 3525.506429099928, 3527.5414196154334, 3536.3575218593633, 3573.6069032406413, 3583.426651735762, 2655.0, 2682.6646669166353, 2690.340866487723, 2691.35407502202, 2691.650085488874, 460.13035363163647, 467.07286037216096, 476.8688610632104, 477.10304627301144, 479.6905995632797, 473.55722399556527, 509.8725318670332, 548.4214154067497, 559.4740943513085, 582.8542864283929, 7265.5277406969435, 7362.558246505227, 7372.2259162788205, 7403.51877127985, 7461.626918654046, 419.74815110933804, 476.66197302232604, 524.0828550037435, 555.5028249716481, 596.3946594206883, 3521.8591256349973, 3550.520679708258, 3683.778973261613, 3721.0, 3745.7939813309986, 49566.25650615244, 49735.50264497309, 49831.501684982686, 49878.0, 49944.25083623749, 46946.76526617413, 47139.5286047142, 47507.28739068917, 47898.0, 48285.5171448288, 43723.0, 44163.11673766507, 44618.55381446209, 44661.33008004883, 44984.77507612441, 7536.9246307538415, 7626.122995855548, 7811.804704882424, 7945.642446090055, 8059.113497515152, 33742.32515349728, 34039.829800850835, 34658.82670586631, 34836.0, 34860.47709284312, 43594.0, 43706.78146609246, 43773.78113109414, 43982.56017439913, 44333.11333773371, 10200.693979180636, 10212.387256764618, 10255.692329230134, 10286.485675716034, 10452.425116618355, 10828.079613232963, 11019.83470247931, 11118.166137539554, 11284.605038823602, 11376.919192676682, 10018.699439016842, 10255.692329230134, 10296.948515257376, 10495.842562361418, 10882.347059176474, 10059.949700251453, 10208.897911020795, 10277.640282590073, 10300.227482938659, 10793.56825726962, 9830.852537211804, 10112.89887101149, 10222.080012798884, 10325.225608079574, 10728.731781705208, 9222.677206298016, 9267.67563135287, 9294.209992150472, 9413.952930235306, 9616.0, 8610.61252243638, 8673.956630216808, 8698.91301086981, 8777.736667899973, 9023.639054438012], "unit": "ms", "name": "yui.html", "value": 5778.001297291528}], "name": "dromaeo_css", "value": 6279.500877570282}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 112.0, 112.0, 113.0, 103.0, 113.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [162.0, 129.0, 161.0, 172.0, 143.0, 149.0, 153.0, 140.0, 170.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 160.0, 160.0, 159.0, 160.0, 163.0, 161.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 92.0, 95.0, 75.0, 72.0, 74.0, 107.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 135.0, 94.0, 94.0, 94.0, 135.0, 94.0, 95.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 69.0, 70.0, 70.0, 79.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 87.0, 87.0, 85.0, 86.0, 85.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [130.0, 124.0, 128.0, 127.0, 118.0, 118.0, 120.0, 123.0, 122.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [154.0, 160.0, 149.0, 145.0, 146.0, 143.0, 149.0, 145.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 67.0, 71.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1526.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [192.52984212552946], "unit": "score", "name": "DeltaBlue", "value": 343.41689200000013}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12047.619047619048], "unit": "score", "name": "Boyer", "value": 55.31906324110671}, {"lowerIsBetter": false, "replicates": [26973.684210526317], "unit": "score", "name": "RegExp", "value": 33.77310243902437}, {"lowerIsBetter": false, "replicates": [598.8023952095808], "unit": "score", "name": "Splay", "value": 136.08996999999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19786.889154429722}]} 01:44:47 INFO - RETURN: dromaeo_css: 6279.50 01:44:47 INFO - RETURN: kraken: 1526.90 01:44:47 INFO - RETURN: v8_7: 19786.89 01:44:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,144,35]]", "result": "19786.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,144,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,144,35]]", "result": "6279.50"}}} 01:44:47 INFO - Return code: 0 01:44:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:44:47 ERROR - # TBPL SUCCESS # 01:44:47 INFO - Running post-action listener: _resource_record_post_action 01:44:47 INFO - Running post-run listener: _resource_record_post_run 01:44:48 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 561131520; Read time: 12; Write time: 470176 01:44:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243757056; Read time: 0; Write time: 274132 01:44:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317374464; Read time: 12; Write time: 196044 01:44:48 INFO - Running post-run listener: _upload_blobber_files 01:44:48 INFO - Blob upload gear active. 01:44:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:44:48 INFO - Copying logs to upload dir... 01:44:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.204374 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-04 01:44:48.056735) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 01:44:48.060849) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009960 build_url: 'https://queue.taskcluster.net/v1/task/cMDAWHbZQBOwhw_wV9TSWw/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-04 01:44:48.114105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:44:48.114458) ========= 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=6ef107882637bc5fc02d78b7000001c2-1449213266.692297-1640340745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 01:44:48.164152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 01:44:48.164493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 01:44:48.164804) ========= ========= Total master_lag: 0.30 =========