builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1449191928.41 results: success (0) buildid: 20151203160817 builduid: 872e37ab4ed748af89391c3a2ffe381a revision: 528fc18a86d3f6e6bec37190522a46853a846665 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.414931) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.415405) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.415705) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006274 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.438765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.439054) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.452834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.453140) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.502209) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.502595) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.502998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.503291) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 17:18:48-- 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% 61.0M=0s 2015-12-03 17:18:48 (61.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107589 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.697732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.698092) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016231 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:48.832294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 17:18:48.832667) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 528fc18a86d3f6e6bec37190522a46853a846665 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 528fc18a86d3f6e6bec37190522a46853a846665 --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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 17:18:48,946 truncating revision to first 12 chars 2015-12-03 17:18:48,946 Setting DEBUG logging. 2015-12-03 17:18:48,947 attempt 1/10 2015-12-03 17:18:48,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/528fc18a86d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 17:18:49,857 unpacking tar archive at: mozilla-central-528fc18a86d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 17:18:50.024516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:50.024840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:50.034001) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:50.034278) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 17:18:50.034687) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-03 17:18:50.034965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:18:50 INFO - MultiFileLogger online at 20151203 17:18:50 in /builds/slave/test 17:18:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:18:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:50 INFO - {'append_to_log': False, 17:18:50 INFO - 'base_work_dir': '/builds/slave/test', 17:18:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:18:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:50 INFO - 'branch': 'Firefox-Non-PGO', 17:18:50 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:50 INFO - 'config_files': ('talos/linux_config.py',), 17:18:50 INFO - 'default_actions': ('clobber', 17:18:50 INFO - 'read-buildbot-config', 17:18:50 INFO - 'download-and-extract', 17:18:50 INFO - 'populate-webroot', 17:18:50 INFO - 'create-virtualenv', 17:18:50 INFO - 'install', 17:18:50 INFO - 'run-tests'), 17:18:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:50 INFO - 'download_minidump_stackwalk': True, 17:18:50 INFO - 'download_symbols': 'ondemand', 17:18:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:50 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:50 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:50 INFO - 'installer_path': 'installer.exe', 17:18:50 INFO - 'log_level': 'info', 17:18:50 INFO - 'log_name': 'talos', 17:18:50 INFO - 'log_to_console': True, 17:18:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:18:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:18:50 INFO - 'opt_config_files': (), 17:18:50 INFO - 'pip_index': False, 17:18:50 INFO - 'sps_profile': False, 17:18:50 INFO - 'sps_profile_interval': 0, 17:18:50 INFO - 'suite': 'dromaeojs', 17:18:50 INFO - 'system_bits': '64', 17:18:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:50 INFO - 'title': 'talos-linux64-ix-012', 17:18:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:50 INFO - 'use_talos_json': True, 17:18:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:50 INFO - 'work_dir': 'build'} 17:18:50 INFO - ##### 17:18:50 INFO - ##### Running clobber step. 17:18:50 INFO - ##### 17:18:50 INFO - Running pre-action listener: _resource_record_pre_action 17:18:50 INFO - Running main action method: clobber 17:18:50 INFO - rmtree: /builds/slave/test/build 17:18:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:50 INFO - Running post-action listener: _resource_record_post_action 17:18:50 INFO - ##### 17:18:50 INFO - ##### Running read-buildbot-config step. 17:18:50 INFO - ##### 17:18:50 INFO - Running pre-action listener: _resource_record_pre_action 17:18:50 INFO - Running main action method: read_buildbot_config 17:18:50 INFO - Using buildbot properties: 17:18:50 INFO - { 17:18:50 INFO - "properties": { 17:18:50 INFO - "buildnumber": 336, 17:18:50 INFO - "product": "firefox", 17:18:50 INFO - "script_repo_revision": "production", 17:18:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:18:50 INFO - "repository": "", 17:18:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:18:50 INFO - "buildid": "20151203160817", 17:18:50 INFO - "slavename": "talos-linux64-ix-012", 17:18:50 INFO - "pgo_build": "False", 17:18:50 INFO - "basedir": "/builds/slave/test", 17:18:50 INFO - "project": "", 17:18:50 INFO - "platform": "ubuntu64_hw", 17:18:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:18:50 INFO - "slavebuilddir": "test", 17:18:50 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:18:50 INFO - "branch": "mozilla-central", 17:18:50 INFO - "repo_path": "mozilla-central", 17:18:50 INFO - "stage_platform": "linux64", 17:18:50 INFO - "builduid": "872e37ab4ed748af89391c3a2ffe381a", 17:18:50 INFO - "revision": "528fc18a86d3f6e6bec37190522a46853a846665" 17:18:50 INFO - }, 17:18:50 INFO - "sourcestamp": { 17:18:50 INFO - "repository": "", 17:18:50 INFO - "hasPatch": false, 17:18:50 INFO - "project": "", 17:18:50 INFO - "branch": "mozilla-central-linux64-talos", 17:18:50 INFO - "changes": [ 17:18:50 INFO - { 17:18:50 INFO - "category": null, 17:18:50 INFO - "files": [ 17:18:50 INFO - { 17:18:50 INFO - "url": null, 17:18:50 INFO - "name": "https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:18:50 INFO - } 17:18:50 INFO - ], 17:18:50 INFO - "repository": "", 17:18:50 INFO - "rev": "528fc18a86d3f6e6bec37190522a46853a846665", 17:18:50 INFO - "who": "kwierso@gmail.com", 17:18:50 INFO - "when": 1449191897, 17:18:50 INFO - "number": 6741911, 17:18:50 INFO - "comments": "Merge fx-team to central, a=merge", 17:18:50 INFO - "project": "", 17:18:50 INFO - "at": "Thu 03 Dec 2015 17:18:17", 17:18:50 INFO - "branch": "mozilla-central-linux64-talos", 17:18:50 INFO - "revlink": "", 17:18:50 INFO - "properties": [ 17:18:50 INFO - [ 17:18:50 INFO - "buildid", 17:18:50 INFO - "20151203160817", 17:18:50 INFO - "Change" 17:18:50 INFO - ], 17:18:50 INFO - [ 17:18:50 INFO - "builduid", 17:18:50 INFO - "872e37ab4ed748af89391c3a2ffe381a", 17:18:50 INFO - "Change" 17:18:50 INFO - ], 17:18:50 INFO - [ 17:18:50 INFO - "pgo_build", 17:18:50 INFO - "False", 17:18:50 INFO - "Change" 17:18:50 INFO - ] 17:18:50 INFO - ], 17:18:50 INFO - "revision": "528fc18a86d3f6e6bec37190522a46853a846665" 17:18:50 INFO - } 17:18:50 INFO - ], 17:18:50 INFO - "revision": "528fc18a86d3f6e6bec37190522a46853a846665" 17:18:50 INFO - } 17:18:50 INFO - } 17:18:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:18:50 INFO - Running post-action listener: _resource_record_post_action 17:18:50 INFO - ##### 17:18:50 INFO - ##### Running download-and-extract step. 17:18:50 INFO - ##### 17:18:50 INFO - Running pre-action listener: _resource_record_pre_action 17:18:50 INFO - Running main action method: download_and_extract 17:18:50 INFO - mkdir: /builds/slave/test/build/tests 17:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:50 INFO - https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/test_packages.json 17:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/test_packages.json 17:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:18:56 INFO - Downloaded 1302 bytes. 17:18:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:18:56 INFO - Using the following test package requirements: 17:18:56 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:18:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'jsshell-linux-x86_64.zip'], 17:18:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:18:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:18:56 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:18:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:18:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:56 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:18:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:18: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')]} 17:18:56 INFO - https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:00 INFO - Downloaded 21790692 bytes. 17:19:00 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 17:19:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:19:00 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 17:19:01 INFO - Return code: 0 17:19:01 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 17:19:01 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')]} 17:19:01 INFO - https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:19:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:19:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:19:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:07 INFO - Downloaded 21790692 bytes. 17:19:07 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 17:19:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:19:07 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 17:19:08 INFO - Return code: 0 17:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:08 INFO - https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:19:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:10 INFO - Downloaded 11132001 bytes. 17:19:10 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 17:19:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:19:10 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 17:19:10 INFO - Return code: 0 17:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:10 INFO - https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9j8ooCWuQCGJcMcu8al3fw/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 17:19:12 INFO - Downloaded 57693398 bytes. 17:19:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:19:12 INFO - mkdir: /builds/slave/test/properties 17:19:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:19:12 INFO - Writing to file /builds/slave/test/properties/build_url 17:19:12 INFO - Contents: 17:19:12 INFO - build_url:https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:19:12 INFO - Running post-action listener: _resource_record_post_action 17:19:12 INFO - Running post-action listener: set_extra_try_arguments 17:19:12 INFO - ##### 17:19:12 INFO - ##### Running populate-webroot step. 17:19:12 INFO - ##### 17:19:12 INFO - Running pre-action listener: _resource_record_pre_action 17:19:12 INFO - Running main action method: populate_webroot 17:19:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:19:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:19:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:19:12 INFO - '../fennec_ids.txt'], 17:19:12 INFO - 'tests': ['tcheck2']}, 17:19:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:19:12 INFO - '--tppagecycles', 17:19:12 INFO - '7'], 17:19:12 INFO - 'tests': ['tsvgm']}}, 17:19:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:19:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:19:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:19:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:19:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'tests': ['damp', 'tps']}, 17:19:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['damp', 'tps']}, 17:19:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:19:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:19:12 INFO - 'other': {'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'other_l64': {'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'other_nol64': {'tests': ['a11yr', 17:19:12 INFO - 'ts_paint', 17:19:12 INFO - 'tpaint', 17:19:12 INFO - 'sessionrestore', 17:19:12 INFO - 'sessionrestore_no_auto_restore']}, 17:19:12 INFO - 'svgr': {'tests': ['tsvgx', 17:19:12 INFO - 'tsvgr_opacity', 17:19:12 INFO - 'tart', 17:19:12 INFO - 'tscrollx', 17:19:12 INFO - 'cart']}, 17:19:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['tsvgx', 17:19:12 INFO - 'tsvgr_opacity', 17:19:12 INFO - 'tart', 17:19:12 INFO - 'tscrollx', 17:19:12 INFO - 'cart']}, 17:19:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'tests': ['tp5o']}, 17:19:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'talos_options': ['--e10s'], 17:19:12 INFO - 'tests': ['tp5o']}, 17:19:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'talos_options': ['--xperf_path', 17:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:12 INFO - 'tests': ['tp5n']}, 17:19:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:12 INFO - 'talos_options': ['--e10s', 17:19:12 INFO - '--xperf_path', 17:19:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:12 INFO - 'tests': ['tp5n']}}, 17:19:12 INFO - 'talos.zip': {'path': '', 17:19:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:19:12 INFO - Running post-action listener: _resource_record_post_action 17:19:12 INFO - ##### 17:19:12 INFO - ##### Running create-virtualenv step. 17:19:12 INFO - ##### 17:19:12 INFO - Running pre-action listener: _resource_record_pre_action 17:19:12 INFO - Running main action method: create_virtualenv 17:19:12 INFO - Creating virtualenv /builds/slave/test/build/venv 17:19:12 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 17:19:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:19:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:19:12 INFO - Using real prefix '/usr' 17:19:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:19:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:19:15 INFO - Installing pip.................done. 17:19:15 INFO - Return code: 0 17:19:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:15 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 17:19:15 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 17:19:15 INFO - Using env: {'DISPLAY': ':0', 17:19:15 INFO - 'HOME': '/home/cltbld', 17:19:15 INFO - 'LANG': 'en_US.UTF-8', 17:19:15 INFO - 'LANGUAGE': 'en_US:en', 17:19:15 INFO - 'LOGNAME': 'cltbld', 17:19:15 INFO - 'MAIL': '/var/mail/cltbld', 17:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:15 INFO - 'MOZ_NO_REMOTE': '1', 17:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:15 INFO - 'NO_EM_RESTART': '1', 17:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:15 INFO - 'PWD': '/builds/slave/test', 17:19:15 INFO - 'SHELL': '/bin/bash', 17:19:15 INFO - 'SHLVL': '1', 17:19:15 INFO - 'TERM': 'linux', 17:19:15 INFO - 'TMOUT': '86400', 17:19:15 INFO - 'USER': 'cltbld', 17:19:15 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:15 INFO - '_': '/tools/buildbot/bin/python'} 17:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:15 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 17:19:15 INFO - Cleaning up... 17:19:15 INFO - Return code: 0 17:19:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:15 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 17:19:15 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 17:19:15 INFO - Using env: {'DISPLAY': ':0', 17:19:15 INFO - 'HOME': '/home/cltbld', 17:19:15 INFO - 'LANG': 'en_US.UTF-8', 17:19:15 INFO - 'LANGUAGE': 'en_US:en', 17:19:15 INFO - 'LOGNAME': 'cltbld', 17:19:15 INFO - 'MAIL': '/var/mail/cltbld', 17:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:15 INFO - 'MOZ_NO_REMOTE': '1', 17:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:15 INFO - 'NO_EM_RESTART': '1', 17:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:15 INFO - 'PWD': '/builds/slave/test', 17:19:15 INFO - 'SHELL': '/bin/bash', 17:19:15 INFO - 'SHLVL': '1', 17:19:15 INFO - 'TERM': 'linux', 17:19:15 INFO - 'TMOUT': '86400', 17:19:15 INFO - 'USER': 'cltbld', 17:19:15 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:15 INFO - '_': '/tools/buildbot/bin/python'} 17:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:15 INFO - Downloading/unpacking psutil>=0.7.1 17:19:15 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 17:19:15 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 17:19:15 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 17:19:15 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 17:19:15 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 17:19:15 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 17:19:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:19:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:17 INFO - Installing collected packages: psutil 17:19:17 INFO - Running setup.py install for psutil 17:19:17 INFO - building 'psutil._psutil_linux' extension 17:19:17 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 17:19:17 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 17:19:17 INFO - building 'psutil._psutil_posix' extension 17:19:17 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 17:19:17 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 17:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:17 INFO - Successfully installed psutil 17:19:17 INFO - Cleaning up... 17:19:18 INFO - Return code: 0 17:19:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:19:18 INFO - Using env: {'DISPLAY': ':0', 17:19:18 INFO - 'HOME': '/home/cltbld', 17:19:18 INFO - 'LANG': 'en_US.UTF-8', 17:19:18 INFO - 'LANGUAGE': 'en_US:en', 17:19:18 INFO - 'LOGNAME': 'cltbld', 17:19:18 INFO - 'MAIL': '/var/mail/cltbld', 17:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:18 INFO - 'MOZ_NO_REMOTE': '1', 17:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:18 INFO - 'NO_EM_RESTART': '1', 17:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:18 INFO - 'PWD': '/builds/slave/test', 17:19:18 INFO - 'SHELL': '/bin/bash', 17:19:18 INFO - 'SHLVL': '1', 17:19:18 INFO - 'TERM': 'linux', 17:19:18 INFO - 'TMOUT': '86400', 17:19:18 INFO - 'USER': 'cltbld', 17:19:18 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:18 INFO - '_': '/tools/buildbot/bin/python'} 17:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:19:18 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 17:19:18 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 17:19:18 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 17:19:18 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 17:19:18 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 17:19:18 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 17:19:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:19:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:19:20 INFO - Installing collected packages: mozsystemmonitor 17:19:20 INFO - Running setup.py install for mozsystemmonitor 17:19:20 INFO - Successfully installed mozsystemmonitor 17:19:20 INFO - Cleaning up... 17:19:20 INFO - Return code: 0 17:19:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:19:20 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')]} 17:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:20 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')]} 17:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:20 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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:20 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 17:19:20 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 17:19:20 INFO - Using env: {'DISPLAY': ':0', 17:19:20 INFO - 'HOME': '/home/cltbld', 17:19:20 INFO - 'LANG': 'en_US.UTF-8', 17:19:20 INFO - 'LANGUAGE': 'en_US:en', 17:19:20 INFO - 'LOGNAME': 'cltbld', 17:19:20 INFO - 'MAIL': '/var/mail/cltbld', 17:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:20 INFO - 'MOZ_NO_REMOTE': '1', 17:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:20 INFO - 'NO_EM_RESTART': '1', 17:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:20 INFO - 'PWD': '/builds/slave/test', 17:19:20 INFO - 'SHELL': '/bin/bash', 17:19:20 INFO - 'SHLVL': '1', 17:19:20 INFO - 'TERM': 'linux', 17:19:20 INFO - 'TMOUT': '86400', 17:19:20 INFO - 'USER': 'cltbld', 17:19:20 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:20 INFO - '_': '/tools/buildbot/bin/python'} 17:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:19:20 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 17:19:20 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 17:19:20 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 17:19:20 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 17:19:20 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 17:19:20 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 17:19:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:19:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:19:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:19:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:23 INFO - Downloading docopt-0.6.1.tar.gz 17:19:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:19:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:19:23 INFO - Running setup.py install for blobuploader 17:19:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:19:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:19:23 INFO - Running setup.py install for requests 17:19:23 INFO - Running setup.py install for docopt 17:19:23 INFO - Successfully installed blobuploader requests docopt 17:19:23 INFO - Cleaning up... 17:19:23 INFO - Return code: 0 17:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:23 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')]} 17:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:23 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')]} 17:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:23 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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:23 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 17:19:23 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 17:19:23 INFO - Using env: {'DISPLAY': ':0', 17:19:23 INFO - 'HOME': '/home/cltbld', 17:19:23 INFO - 'LANG': 'en_US.UTF-8', 17:19:23 INFO - 'LANGUAGE': 'en_US:en', 17:19:23 INFO - 'LOGNAME': 'cltbld', 17:19:23 INFO - 'MAIL': '/var/mail/cltbld', 17:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:23 INFO - 'MOZ_NO_REMOTE': '1', 17:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:23 INFO - 'NO_EM_RESTART': '1', 17:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:23 INFO - 'PWD': '/builds/slave/test', 17:19:23 INFO - 'SHELL': '/bin/bash', 17:19:23 INFO - 'SHLVL': '1', 17:19:23 INFO - 'TERM': 'linux', 17:19:23 INFO - 'TMOUT': '86400', 17:19:23 INFO - 'USER': 'cltbld', 17:19:23 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:23 INFO - '_': '/tools/buildbot/bin/python'} 17:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:23 INFO - Running setup.py (path:/tmp/pip-jGtnzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:24 INFO - Running setup.py (path:/tmp/pip-RiGSfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:24 INFO - Running setup.py (path:/tmp/pip-2d9xQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:24 INFO - Running setup.py (path:/tmp/pip-ysV2PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:24 INFO - Running setup.py (path:/tmp/pip-ZGORCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:24 INFO - Running setup.py (path:/tmp/pip-TNCxzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:24 INFO - Running setup.py (path:/tmp/pip-VnkFeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:24 INFO - Running setup.py (path:/tmp/pip-W3khzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:24 INFO - Running setup.py (path:/tmp/pip-Jd8ykZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:24 INFO - Running setup.py (path:/tmp/pip-zWTxP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:24 INFO - Running setup.py (path:/tmp/pip-A0PkN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:24 INFO - Running setup.py (path:/tmp/pip-sPeCrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:24 INFO - Running setup.py (path:/tmp/pip-6RyZMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:24 INFO - Running setup.py (path:/tmp/pip-xjmcPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:24 INFO - Running setup.py (path:/tmp/pip-8Cu9X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:25 INFO - Running setup.py (path:/tmp/pip-v7lwkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:25 INFO - Running setup.py (path:/tmp/pip-XO3RKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:19:25 INFO - Running setup.py install for manifestparser 17:19:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:19:25 INFO - Running setup.py install for mozcrash 17:19:25 INFO - Running setup.py install for mozdebug 17:19:25 INFO - Running setup.py install for mozdevice 17:19:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:19:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:19:25 INFO - Running setup.py install for mozfile 17:19:25 INFO - Running setup.py install for mozhttpd 17:19:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:19:25 INFO - Running setup.py install for mozinfo 17:19:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:19:25 INFO - Running setup.py install for mozInstall 17:19:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Running setup.py install for mozleak 17:19:26 INFO - Running setup.py install for mozlog 17:19:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Running setup.py install for moznetwork 17:19:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Running setup.py install for mozprocess 17:19:26 INFO - Running setup.py install for mozprofile 17:19:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Running setup.py install for mozrunner 17:19:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Running setup.py install for mozscreenshot 17:19:26 INFO - Running setup.py install for moztest 17:19:26 INFO - Running setup.py install for mozversion 17:19:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:19:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:19:26 INFO - Cleaning up... 17:19:26 INFO - Return code: 0 17:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:26 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')]} 17:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:27 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 17:19:27 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 17:19:27 INFO - Using env: {'DISPLAY': ':0', 17:19:27 INFO - 'HOME': '/home/cltbld', 17:19:27 INFO - 'LANG': 'en_US.UTF-8', 17:19:27 INFO - 'LANGUAGE': 'en_US:en', 17:19:27 INFO - 'LOGNAME': 'cltbld', 17:19:27 INFO - 'MAIL': '/var/mail/cltbld', 17:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:27 INFO - 'MOZ_NO_REMOTE': '1', 17:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:27 INFO - 'NO_EM_RESTART': '1', 17:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:27 INFO - 'PWD': '/builds/slave/test', 17:19:27 INFO - 'SHELL': '/bin/bash', 17:19:27 INFO - 'SHLVL': '1', 17:19:27 INFO - 'TERM': 'linux', 17:19:27 INFO - 'TMOUT': '86400', 17:19:27 INFO - 'USER': 'cltbld', 17:19:27 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:27 INFO - '_': '/tools/buildbot/bin/python'} 17:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:27 INFO - Running setup.py (path:/tmp/pip-_GcJeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:27 INFO - Running setup.py (path:/tmp/pip-gzKuOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:27 INFO - Running setup.py (path:/tmp/pip-GcZtv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:27 INFO - Running setup.py (path:/tmp/pip-twkEjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:27 INFO - Running setup.py (path:/tmp/pip-5sQRE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:27 INFO - Running setup.py (path:/tmp/pip-ZmdE_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:27 INFO - Running setup.py (path:/tmp/pip-3k83fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:27 INFO - Running setup.py (path:/tmp/pip-jF1L1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:27 INFO - Running setup.py (path:/tmp/pip-HgjxY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:27 INFO - Running setup.py (path:/tmp/pip-SIsQow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:27 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)) 17:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:27 INFO - Running setup.py (path:/tmp/pip-bixfKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:28 INFO - Running setup.py (path:/tmp/pip-4xhoGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:28 INFO - Running setup.py (path:/tmp/pip-WQnyY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:28 INFO - Running setup.py (path:/tmp/pip-TFmL4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:28 INFO - Running setup.py (path:/tmp/pip-dVn08y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:28 INFO - Running setup.py (path:/tmp/pip-V44ePa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:28 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)) 17:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:28 INFO - Running setup.py (path:/tmp/pip-fuJNYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:28 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)) 17:19:28 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)) 17:19:28 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)) 17:19:28 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)) 17:19:28 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)) 17:19:28 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)) 17:19:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:30 INFO - Downloading blessings-1.5.1.tar.gz 17:19:30 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 17:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:19:30 INFO - Installing collected packages: blessings 17:19:30 INFO - Running setup.py install for blessings 17:19:30 INFO - Successfully installed blessings 17:19:30 INFO - Cleaning up... 17:19:30 INFO - Return code: 0 17:19:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:19:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:19:30 INFO - Reading from file tmpfile_stdout 17:19:30 INFO - Current package versions: 17:19:30 INFO - argparse == 1.2.1 17:19:30 INFO - blessings == 1.5.1 17:19:30 INFO - blobuploader == 1.2.4 17:19:30 INFO - docopt == 0.6.1 17:19:30 INFO - manifestparser == 1.1 17:19:30 INFO - mozInstall == 1.12 17:19:30 INFO - mozcrash == 0.16 17:19:30 INFO - mozdebug == 0.1 17:19:30 INFO - mozdevice == 0.47 17:19:30 INFO - mozfile == 1.2 17:19:30 INFO - mozhttpd == 0.7 17:19:30 INFO - mozinfo == 0.9 17:19:30 INFO - mozleak == 0.1 17:19:30 INFO - mozlog == 3.1 17:19:30 INFO - moznetwork == 0.27 17:19:30 INFO - mozprocess == 0.22 17:19:30 INFO - mozprofile == 0.27 17:19:30 INFO - mozrunner == 6.11 17:19:30 INFO - mozscreenshot == 0.1 17:19:30 INFO - mozsystemmonitor == 0.0 17:19:30 INFO - moztest == 0.7 17:19:30 INFO - mozversion == 1.4 17:19:30 INFO - psutil == 3.1.1 17:19:30 INFO - requests == 1.2.3 17:19:30 INFO - wsgiref == 0.1.2 17:19:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 17:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 17:19:30 INFO - Using env: {'DISPLAY': ':0', 17:19:30 INFO - 'HOME': '/home/cltbld', 17:19:30 INFO - 'LANG': 'en_US.UTF-8', 17:19:30 INFO - 'LANGUAGE': 'en_US:en', 17:19:30 INFO - 'LOGNAME': 'cltbld', 17:19:30 INFO - 'MAIL': '/var/mail/cltbld', 17:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:30 INFO - 'MOZ_NO_REMOTE': '1', 17:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:30 INFO - 'NO_EM_RESTART': '1', 17:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:30 INFO - 'PWD': '/builds/slave/test', 17:19:30 INFO - 'SHELL': '/bin/bash', 17:19:30 INFO - 'SHLVL': '1', 17:19:30 INFO - 'TERM': 'linux', 17:19:30 INFO - 'TMOUT': '86400', 17:19:30 INFO - 'USER': 'cltbld', 17:19:30 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:30 INFO - '_': '/tools/buildbot/bin/python'} 17:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 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)) 17:19:30 INFO - Cleaning up... 17:19:30 INFO - Return code: 0 17:19:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:19:30 INFO - Using env: {'DISPLAY': ':0', 17:19:30 INFO - 'HOME': '/home/cltbld', 17:19:30 INFO - 'LANG': 'en_US.UTF-8', 17:19:30 INFO - 'LANGUAGE': 'en_US:en', 17:19:30 INFO - 'LOGNAME': 'cltbld', 17:19:30 INFO - 'MAIL': '/var/mail/cltbld', 17:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:30 INFO - 'MOZ_NO_REMOTE': '1', 17:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:30 INFO - 'NO_EM_RESTART': '1', 17:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:30 INFO - 'PWD': '/builds/slave/test', 17:19:30 INFO - 'SHELL': '/bin/bash', 17:19:30 INFO - 'SHLVL': '1', 17:19:30 INFO - 'TERM': 'linux', 17:19:30 INFO - 'TMOUT': '86400', 17:19:30 INFO - 'USER': 'cltbld', 17:19:30 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:30 INFO - '_': '/tools/buildbot/bin/python'} 17:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:31 INFO - Downloading/unpacking jsonschema 17:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:19:32 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 17:19:32 INFO - Downloading/unpacking functools32 (from jsonschema) 17:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 17:19:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:19:33 INFO - warning: no files found matching '*.txt' 17:19:33 INFO - no previously-included directories found matching 'build' 17:19:33 INFO - no previously-included directories found matching 'dist' 17:19:33 INFO - no previously-included directories found matching '.git*' 17:19:33 INFO - Installing collected packages: jsonschema, functools32 17:19:33 INFO - Running setup.py install for functools32 17:19:33 INFO - warning: no files found matching '*.txt' 17:19:33 INFO - no previously-included directories found matching 'build' 17:19:33 INFO - no previously-included directories found matching 'dist' 17:19:33 INFO - no previously-included directories found matching '.git*' 17:19:33 INFO - Successfully installed jsonschema functools32 17:19:33 INFO - Cleaning up... 17:19:33 INFO - Return code: 0 17:19:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff2ea88df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, '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': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', '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 17:19:33 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 17:19:33 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 17:19:33 INFO - Using env: {'DISPLAY': ':0', 17:19:33 INFO - 'HOME': '/home/cltbld', 17:19:33 INFO - 'LANG': 'en_US.UTF-8', 17:19:33 INFO - 'LANGUAGE': 'en_US:en', 17:19:33 INFO - 'LOGNAME': 'cltbld', 17:19:33 INFO - 'MAIL': '/var/mail/cltbld', 17:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:33 INFO - 'MOZ_NO_REMOTE': '1', 17:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:33 INFO - 'NO_EM_RESTART': '1', 17:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:33 INFO - 'PWD': '/builds/slave/test', 17:19:33 INFO - 'SHELL': '/bin/bash', 17:19:33 INFO - 'SHLVL': '1', 17:19:33 INFO - 'TERM': 'linux', 17:19:33 INFO - 'TMOUT': '86400', 17:19:33 INFO - 'USER': 'cltbld', 17:19:33 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:33 INFO - '_': '/tools/buildbot/bin/python'} 17:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:33 INFO - Downloading/unpacking flake8 17:19:33 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 17:19:33 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 17:19:33 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 17:19:33 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 17:19:33 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 17:19:33 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 17:19:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:19:35 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 17:19:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:19:35 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 17:19:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 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 17:19:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:19:35 INFO - no previously-included directories found matching 'docs/_build' 17:19:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:19:35 INFO - Running setup.py install for pep8 17:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:19:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:19:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:19:35 INFO - no previously-included directories found matching 'docs/_build' 17:19:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:19:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:19:35 INFO - Cleaning up... 17:19:35 INFO - Return code: 0 17:19:35 INFO - Running post-action listener: _resource_record_post_action 17:19:35 INFO - Running post-action listener: _start_resource_monitoring 17:19:36 INFO - Starting resource monitoring. 17:19:36 INFO - ##### 17:19:36 INFO - ##### Running install step. 17:19:36 INFO - ##### 17:19:36 INFO - Running pre-action listener: _resource_record_pre_action 17:19:36 INFO - Running main action method: install 17:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:19:36 INFO - Reading from file tmpfile_stdout 17:19:36 INFO - Detecting whether we're running mozinstall >=1.0... 17:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:19:36 INFO - Reading from file tmpfile_stdout 17:19:36 INFO - Output received: 17:19:36 INFO - Usage: mozinstall [options] installer 17:19:36 INFO - Options: 17:19:36 INFO - -h, --help show this help message and exit 17:19:36 INFO - -d DEST, --destination=DEST 17:19:36 INFO - Directory to install application into. [default: 17:19:36 INFO - "/builds/slave/test"] 17:19:36 INFO - --app=APP Application being installed. [default: firefox] 17:19:36 INFO - mkdir: /builds/slave/test/build/application 17:19:36 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'] 17:19:36 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 17:19:50 INFO - Reading from file tmpfile_stdout 17:19:50 INFO - Output received: 17:19:50 INFO - /builds/slave/test/build/application/firefox/firefox 17:19:50 INFO - Running post-action listener: _resource_record_post_action 17:19:50 INFO - ##### 17:19:50 INFO - ##### Running run-tests step. 17:19:50 INFO - ##### 17:19:50 INFO - Running pre-action listener: _resource_record_pre_action 17:19:50 INFO - Running main action method: run_tests 17:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:50 INFO - Python 2.7.3 17:19:50 INFO - Return code: 0 17:19:50 INFO - grabbing minidump binary from tooltool 17:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:50 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 0x1c750b0>, '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 0x1c75fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c76440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:50 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 17:19:50 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 17:19:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:50 INFO - Return code: 0 17:19:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:19:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:19:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:19:51 INFO - Return code: 0 17:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test/build 17:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 17:19:51 INFO - Using env: {'DISPLAY': ':0', 17:19:51 INFO - 'HOME': '/home/cltbld', 17:19:51 INFO - 'LANG': 'en_US.UTF-8', 17:19:51 INFO - 'LANGUAGE': 'en_US:en', 17:19:51 INFO - 'LOGNAME': 'cltbld', 17:19:51 INFO - 'MAIL': '/var/mail/cltbld', 17:19:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:51 INFO - 'MOZ_NO_REMOTE': '1', 17:19:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:51 INFO - 'NO_EM_RESTART': '1', 17:19:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:51 INFO - 'PWD': '/builds/slave/test', 17:19:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:51 INFO - 'SHELL': '/bin/bash', 17:19:51 INFO - 'SHLVL': '1', 17:19:51 INFO - 'TERM': 'linux', 17:19:51 INFO - 'TMOUT': '86400', 17:19:51 INFO - 'USER': 'cltbld', 17:19:51 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449191853.226092-855023929', 17:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:51 INFO - '_': '/tools/buildbot/bin/python'} 17:19:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 17:19:52 INFO - mozversion INFO | application_buildid: 20151203160817 17:19:52 INFO - mozversion INFO | application_changeset: 528fc18a86d3f6e6bec37190522a46853a846665 17:19:52 INFO - mozversion INFO | application_display_name: Nightly 17:19:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:52 INFO - mozversion INFO | application_name: Firefox 17:19:52 INFO - mozversion INFO | application_remotingname: firefox 17:19:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 17:19:52 INFO - mozversion INFO | application_vendor: Mozilla 17:19:52 INFO - mozversion INFO | application_version: 45.0a1 17:19:52 INFO - mozversion INFO | platform_buildid: 20151203160817 17:19:52 INFO - mozversion INFO | platform_changeset: 528fc18a86d3f6e6bec37190522a46853a846665 17:19:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 17:19:52 INFO - mozversion INFO | platform_version: 45.0a1 17:19:52 INFO - 2015-12-03 17:19:52,024 DEBUG : using testdate: 1449191992 17:19:52 INFO - 2015-12-03 17:19:52,024 DEBUG : actual date: 1449191992 17:19:52 INFO - 2015-12-03 17:19:52,034 INFO : starting webserver on 'localhost:45434' 17:19:52 INFO - 2015-12-03 17:19:52,035 INFO : Starting test suite talos-linux64-ix-012 17:19:52 INFO - 2015-12-03 17:19:52,035 INFO : Starting test dromaeo_css 17:19:52 INFO - 2015-12-03 17:19:52,035 DEBUG : operating with platform_type : linux_ 17:19:52 INFO - 2015-12-03 17:19:52,035 INFO : Initialising browser for dromaeo_css test... 17:19:52 INFO - 2015-12-03 17:19:52,048 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnCu53/profile http://localhost:45434/getInfo.html 17:19:56 INFO - 2015-12-03 17:19:56,024 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:19:56 INFO - 2015-12-03 17:19:56,024 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:19:56 INFO - 2015-12-03 17:19:56,024 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:19:56 INFO - 2015-12-03 17:19:56,024 DEBUG : BROWSER_OUTPUT: __metrics 17:19:56 INFO - 2015-12-03 17:19:56,128 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] 17:19:56 INFO - 2015-12-03 17:19:56,192 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] 17:19:57 INFO - 2015-12-03 17:19:57,166 INFO : Browser initialized. 17:19:57 INFO - 2015-12-03 17:19:57,167 INFO : Running cycle 1/1 for dromaeo_css test... 17:19:57 INFO - 2015-12-03 17:19:57,167 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnCu53/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:20:09 INFO - 2015-12-03 17:20:09,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 17:20:09 INFO - 2015-12-03 17:20:09,141 DEBUG : BROWSER_OUTPUT: 17:21:00 INFO - 2015-12-03 17:21:00,379 DEBUG : BROWSER_OUTPUT: 1449192060374 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] 17:23:12 INFO - 2015-12-03 17:23:12,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45434/tests/dromaeo/cssquery-ext.html) 17:23:13 INFO - 2015-12-03 17:23:13,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 244514816 17:23:13 INFO - 2015-12-03 17:23:13,384 DEBUG : BROWSER_OUTPUT: 17:26:15 INFO - 2015-12-03 17:26:15,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-ext.html (next: http://localhost:45434/tests/dromaeo/cssquery-jquery.html) 17:26:16 INFO - 2015-12-03 17:26:16,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 215785472 17:26:16 INFO - 2015-12-03 17:26:16,509 DEBUG : BROWSER_OUTPUT: 17:29:18 INFO - 2015-12-03 17:29:18,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45434/tests/dromaeo/cssquery-mootools.html) 17:29:19 INFO - 2015-12-03 17:29:19,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 229167104 17:29:19 INFO - 2015-12-03 17:29:19,084 DEBUG : BROWSER_OUTPUT: 17:32:21 INFO - 2015-12-03 17:32:21,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45434/tests/dromaeo/cssquery-prototype.html) 17:32:21 INFO - 2015-12-03 17:32:21,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 204529664 17:32:21 INFO - 2015-12-03 17:32:21,705 DEBUG : BROWSER_OUTPUT: 17:35:24 INFO - 2015-12-03 17:35:24,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45434/tests/dromaeo/cssquery-yui.html) 17:35:25 INFO - 2015-12-03 17:35:25,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 208158720 17:35:25 INFO - 2015-12-03 17:35:25,010 DEBUG : BROWSER_OUTPUT: 17:38:27 INFO - 2015-12-03 17:38:27,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/dromaeo/cssquery-yui.html (next: http://localhost:45434/tests/dromaeo/cssquery-dojo.html) 17:38:27 INFO - 2015-12-03 17:38:27,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 247230464 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:38:27 INFO - 2015-12-03 17:38:27,997 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2618.842869427834;2686.6775986881576;2687.825291356062;2698.3523954250973;2708.322919270183;4464.330350447426;4571.2228921083415;4665.4168228971375;4689.249720044793;4729.858104256873;4525.9773701131535;4602.907941841169;4621.953780462194;4669.252919532875;4715.104130215265;4321.5678432156765;4373.387725718386;4390.626796722282;4413.801378937956;4421.911561768763;4444.688871778961;4471.754053527071;4489.5285994970545;4498.8200471981245;4517.164324599943;4221.746695198282;4246.363045543162;4351.760653164107;4369.519352871182;4373.300271956472;4353.804078816461;4362.149380870732;4362.912741745179;4376;4405.185040767468;4348.434703488558;4358.738475691469;4361.781910904474;4385.693001489897;4391.4730232372;4472.351509031172;4600.263957766775;4630.513796051399;4637.791299391535;4750.477447480775;5079.187330027215;5109.3613298337705;5120.3855537335385;5122.897542049138;5163.406208286057;5146.614003949719;5151.6136289778415;5152.5105115014385;5192.117340052162;5199.428062913076;4551.158035763395;4649.349091127245;4669.6497762667595;4673.719576825401;4774.880627984328;5187.170052791535;5199.532042116228;5202.167653175474;5202.76587553561;5210.6873587584105;4980.2778597103215;4981.850544483671;4989.201727723546;4999.10016197088;5026.246063090565;4859.319695242669;4928.802847886116;4980.053789780002;4982.377202849644;4990.001999600095;4987.875303117451;5010.073136469765;5017.573506251936;5024.397072351341;5043.041822053798;5017;5033.924491132636;5034.043531728959;5044.924326135111;5080.822171224063;4063.6342729153926;4181.1010632713505;4217.514985776675;4224.788760562021;4294.506131794884;3639.399499082622;3673.081729567608;3712.3132220539287;3745.737798354089;3747.306748251582;4335.328024156261;4359.215341238608;4359.782010899442;4365.497967733688;4405.669574781904;4800.615950723934;4914.8034078637165;5095.057414378278;5140.203268493389;5202.81790137351;4257.489101307801;4272.060146767768;4335.219660461147;4362.650987920959;4377.365282034151;4504.414426124583;4549.340345649928;4555.521670224579;4559.338895860148;4596.747178905125;4538.931916021328;4836.419629644465;4838.8790280241865;4842.782074806642;4876.707397556158;4956.281339205867;4964.627652926118;4985.326980857682;5058.494150585059;5119.948800512097;4815.855524334275;4825.686330388514;4845.127876982177;4851.611871050378;4887.633427492881;4802.759862006956;5046.47012063728;5048.646594738333;5054.848354549369;5092.490750924878;4978.253262010728;4979.775910083982;4987.501249874984;5053.140966035709;5070.239464080418;4933.777979990838;4952.47998960104;4954.430240522386;4955.900881982268;5000;4673.042026384515;4942.728149951788;4948.925766113439;4961.7271050092595;4962;4652.860414187579;4758.428988521261;4773.212419950669;4895.877603059952;4903.26451032348;4989.650724449399;5018.623603229846;5019.970905964342;5020.573251273682;5023.120953832991;4897.608191344612;4909.729964851967;4913.336699545515;4914.287428322802;4968.8757781055765 17:38:27 INFO - 2015-12-03 17:38:27,998 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.5570010441489;553.4631407534691;554.8917960997602;561.3600495435204;563.6111083352487;26752.19743407696;27106;27247.86376068122;27386;34656.30687386257;39278.803605982;40130;40130.19739605206;40163.19673606526;40193.196136077335;7768.1843406442495;7926.603669816515;7928.365730741556;7929.207079292082;7931.8413631727335;7028.226895041567;7138.286171382872;7834.72578459754;10055.597776088947;10285.897141028607;9929.801403971916;10017.849732254022;10029.348092374008;10030.197584193247;10035.74910627233;7217.675204615805;9961.800763984716;10016.949915250378;10022.198224142052;10024.849627255597;7091.680874360614;10058.89941100587;10357.637482688146;10363.32638378503;10365.844512332322;37257.81371093154;37721.622783772356;37772.43341349882;37778.62221377779;37819.24361512755;2740.739629735192;2879.294572829649;2920.1823489422995;2967.095036014015;2986.8207907525402;28659.713402865913;28926.421471570662;28931;28980.27549311284;29646.55530167049;3496.6852983231634;3499.3701133795907;3522.9174472336704;3585.748997570171;3648.9817550912076;213820;214059;215786;216008;216238;50084.49915500799;55307;55396.44603553913;55409.16886246709;55766;47102;63107.684461577395;65690.34309656938;65690.67154664196;65717.67141164263;12912.548060817826;13271.73456530864;13279.867201327863;13293.66765830862;13299.601011969657;9249.815003699889;9292.256619470427;9293.814123717488;9303.209227215762;9343.813123737487;18166.364177253734;18212.269834365714;18247.72628410575;18256.817431825777;18286.17712202954;7223.494355395072;7550.244975502405;7582.393408527305;7613;7675.808104797425;827.983440331202;874.6501399440148;892.7991201979503;930.2186163622589;948.5115165689675;26002.21993340203;27495.725042749717;28263.43473130526;29363.55954660682;29730.40539189204;882.5410786391041;895.6999405199201;943.4575119306427;982.8820541535061;1039.4802598700649;13499.22021833888;13526.25605591702;13674.042817002713;13753.243571603458;13795.172289662452;266222;270144;271077;271099;271240;44060.559394405645;44227.557724422346;44391.77804110959;44469.77765111154;44502.77748611236;1225.4485481533345;1241.0443958152173;1250.637315178588;1252.993735031319;1253.4986005597652;24791.380215494755;25822.87088564545;26140.60789088203;26374.340641483348;26390.73609263883;39962.80018599889;40067.198656026136;40217.19565608613;40254.1949161021;40393.59606403898;249239;251981;252166;252948;253049;24732.38169045716;25056.49887002286;27813.304667383476;28309.716902830707;28498.857505712338;34405.139871503416;34736.82631586826;34893;35154.64845351514;35263.64736352706;29776.702232977394;30146.69853301439;30450.238744031576;30620.84689576538;30781.846090770297;28109.859450703432;29661.703382966756;30078.84960575183;30171.396572068876;34201;32280.838595806872;32655.510167347984;33030.669693302756;33031.66968330286;33062.5040624386;28111;29620.555691665075;29645.70354296516;30408.84795576008;30569.847150764104;23053.88473057624;23359.88320058389;23711.762882370957;23783.762162378156;23853.880730596236 17:38:28 INFO - 2015-12-03 17:38:27,999 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.20319841974526;337.7534399888081;338.60383351478765;338.9474631432129;339.5874013074114;12458.688532786662;12793.616191514246;12826.61520154397;15025;15067.924660376697;12210.572629957953;14219.075760075613;15047.774283385757;15528.378864845392;15585.84414155858;3928.939186419665;4839.395075615548;4904.705717656934;4914.336564563774;4977.1538838397555;4926.827561035365;4943.8516844494725;4944.60443164546;4944.752762361885;4947.925781113287;4708.505606911276;4812.951870481303;4895.534924182215;4899.020195960822;4918.5573298403315;4838.564529192372;4852.56326930578;4856.39295088114;4859.708417494961;4860.125177468054;4203.138356636882;4310.525842157392;4312.956870431287;4314.784260786948;4332.220200363933;19552.217911283533;19707.211711531523;19754.70367944482;19819.900900495548;19841.70237446425;1905.4474202481265;1939.486036200394;1940.2142132436386;1964.9607007859906;2077.491014701408;12491.500339986389;12669.239845609201;12764.680882977907;13016.15394999322;13164.60506184816;1770.2564922732354;1773.4147731248656;1787.705028670268;1815.7639506864023;1821.289697018164;54370;55772.44227557713;55922.16116758211;55973.44026559723;56001.43998560003;8611.095834937367;8845.778855528662;9046.366754327133;9167.12912273333;9377.812443751087;9909.900900990899;10581.153507719364;10819.459027048617;10916.617918372818;10933.507992140372;6538.836529086716;6691.197056353269;6723.562968407038;6792.45660347171;6875.5530890491955;6365.108884756138;6370.84072898172;6460.806175814733;6526.738930442729;6575.835604109936;5621.662700237999;5700.486956173964;5716.228309178207;5735.598508104393;5739.512141467939;1640.196303811124;1640.3848556791204;1643.8520533152073;1649.8680105591525;1656.4616499637666;859.4241857955185;884.9867251991225;895.5164211325941;899.4603238057114;905.3029167541089;15308;16642.50072497827;16713.331466741194;17099.829001710073;17360.13199340028;721.4336745654635;827.9793005174919;835.6448509383488;859.9355048371397;862.9741107766777;7716.266954639413;8574.185452382013;8653.437526560754;8822.77943051416;8854.822903541894;314539;316600;320054;321383;461691;51132.23301650478;62077.68961155165;66736;72355.27644723485;72435.6378218116;1040.8594839696696;1047.8113939490813;1056.2236755984345;1077.0844781935448;1082.6319051522362;13845.16928984264;13888.791668124784;13960.720785584435;14293.070435491076;15046.699066018837;29882.402351953275;30067.248318792204;30425;30500.84749576238;30754.692453075182;36574.268514629024;40911.18177636371;41052.38421423621;45736.31395529003;47594.5240547604;8270;8455.534945578052;8466.153384661484;8521.957390213009;8558.058613552379;12857.614271571867;15367.846321536641;16697.415590454275;16742;16902;13702.725945480835;13719.382627781973;13882.305884705926;13886.819620332384;13926.791098133739;13675.521356752466;13708.314584270547;13776.380062896993;13799.2410417428;14300.427982880568;13852.792208117087;14128.222947737973;14144.929275353968;14352.210628415538;14369.64075898111;8502.319814414956;8533.35999800005;8640.395172337876;8642.740717778477;8658.225063861768;13458.29279431355;13592.93203533976;13933.512327068504;13955.092918960236;14323.427062917783 17:38:28 INFO - 2015-12-03 17:38:28,001 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1405.037549278744;1420.9431622735092;1424.2807382271951;1638.6886491566604;1705.1048199695158;6095.847603809907;6405.3594640535985;7162.999999999994;7320.633968301577;7323.743668971587;7203.6038017908995;7247.528910620806;7335.193128755833;7337.119545654529;7342.596157211351;1768.4164225805453;1805.9097045147755;2111.1555377848867;2146.2809958663865;2146.602878467481;2054.9280775172874;2095.779943105975;2100.821430178429;2102.663573828188;2103.842211834111;2076.3874656976227;2092.393205970267;2093.27781915239;2095.1200495791727;2138.8823614701187;2083.9374818755464;2102.432343267317;2108.3780284816016;2133.6479480885714;2134.50906291553;1980.4256765537978;1997.6204521140937;1999.1303782854359;2002.7496562929634;2004.9699254511195;7222.783316500513;7319.59742214178;7324.560526368435;7345.3021962913435;7348.338649521569;4252.447181866369;4304.397384366192;4331.740095594275;4332.371806088099;4338.457692788402;2836.262571731365;2843.3033906692785;2855.314724466134;2877.208767588909;2902.419516096768;901.5492253873064;944.1219665710886;959.5825815770162;960.2906825849998;972.5672075926145;9805.558749856202;9849.261305402124;9850.261230407676;9852.211823054138;9864;3954.5452272988973;4073.9592604074173;4092.9972156821173;4110.8561200358445;4121.773302468333;8041.718539851194;8090.919090809017;8099.595020248964;8106;8108.5945702714625;4243.978780106141;4270.42349282849;4273.316269396882;4273.636740876998;4279.379489973936;3929.0766669832565;3929.8231579578987;3932.311845427096;3932.8230229639735;3946.8223929923224;2842.332051967786;2887.581300711385;3193.058047875882;3269.2480729432364;3289.8684052638105;976.5947131940165;1012.448215722433;1012.7518757904361;1017.6285655735603;1018.1193267823279;957.5403806173076;962.9759256018656;1199.424276347358;1222.1689251309194;1222.4010234984794;6820.658967051628;6890.621015844176;6907.378335949788;6909.619970901648;6912.619805910623;573.2919843992665;582.6940856050608;591.9526437884958;592.2508027345411;721.9458540609476;5278.419373868871;5345.81289654868;5355.062863998863;5363.141897296414;5364.007658583175;7865.960670196612;8014.479058861155;8027.799305017421;8102.7569172924905;8121.634526446206;8707.825843483095;8739.300855931637;8838.558072096497;8847.646094156162;8859.734207973772;6510.511711621647;6520.18497687789;6640.966795165993;6706.66466676674;6710.261871194165;6954.652267386711;6966.024756534191;6977.616231107338;7010.088688470466;7024.051753013277;7883.645235964281;7895.447318687637;7911.485753426009;8002.679892804223;8066.516009039477;7983.600819959095;8073.35413166957;8280.461769984931;8296.502209867427;8305;6320.462760665395;6354.586951848115;6476.417122459001;6489.545731798728;6497.317781632861;6023.397660233942;6137;6976.895346569704;7030.964845175741;7039.507234493741;6254.21822272216;6598.3401659833635;6600.1089852869245;6684.06423100776;6760.797176084725;6211.9689401552705;6287.2140982377205;6428.678566071584;6473;6522.315156908457;6582.76960306387;6584.76953306632;6589.308122647053;6593.142891424276;6643.269240383457;6120.846978825565;6169.938300616936;6174.320824709189;6179;6193.411625895533;6259.217597800275;6289.9056514153235;6295.685215739103;6340.397662222082;6344.777932772331 17:38:28 INFO - 2015-12-03 17:38:28,002 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.41957392870864;301.92451887028244;305.9678733732957;305.98470076496176;308.857925354337;5337.119375303075;5398.190271459273;5401.783928642854;5418.810341638044;5423.0238557059765;5064.56951159152;5154.587632989361;5231.555317797982;5338.519533242007;5340.49265319795;4129.112240868213;4138.97930510347;4143.56492568279;4150.730202536841;4163.708540402173;3925.607439256066;4139.503259608851;4147.626713595776;4149.149424368013;4152.626263636272;3972.9602703973023;4012.799360031987;4110.013596736791;4122.917541649165;4129.442525259082;4074.8370065197355;4099.139180772012;4109.465769449982;4109.506859176888;4124.546299906993;3596.1908570571672;3616.945745813815;3622.8188590570367;3623.691986181178;3624.8912532624063;5146.562542183919;5154.4072431670465;5168.9224661630105;5179.249008893689;5188.8183913563225;4602.1946159422305;4717.551832575934;4719.292106184065;4729.172394830891;4773.069251495925;5637.210790489335;5639.2668953036255;5643.238162848004;5650.886982260332;5663.207150998864;3879.739084797452;3880.049387899983;3880.1463677990796;3881.2237552489332;3883.941740873889;5888.440598143169;5959.761609535657;5962.701864906738;5973.313068997078;5973.850653733692;3849.9230015400094;3973.6622387097423;3997.420374045747;4000.9199816003515;4001.339778936443;4008.118213992917;4044.737092089005;4046.089629833264;4047.251258517184;4053.43251944728;4669.439667239885;4676.55572720591;4677.22825733757;4677.976610116928;4680.508546602626;5665.3768085510565;5667.518260947865;5676.2337084493065;5678.744456499468;5682.54539636828;1370.8286464191976;1403.6140061483175;1426.9143851368951;1432.8495507971722;1438.4461982136743;919.6091661044029;931.8322701913721;931.8788557487619;938.3525367496405;954.5561313989028;4854.417469903564;4893.290472881412;4895.657303988686;4899.216125419915;4913.410390753133;5828.3006039274715;5836.591438599342;5838.94161058384;5842.094475356326;5844.649321040752;4783;4840.903181936412;4854.660173787801;4863.927041094386;4985.675931064469;3168.3188114555483;3181.44324743169;3188.0276515662945;3189.1389324882152;3214.100051985448;5563.221149039137;5577.079781836032;5579.972100139474;5598.1322894951345;5602.52378547828;5929.792457263975;6079.331273559905;6091;6094.085887116968;6098.847528811726;5577.832665020056;5579.38626751057;5605.159226116034;5611.410801865745;5624.690642014729;5960.314563825215;5961.612495187799;5963.105534169909;5967.6419414835245;5974.044152935509;5808.07070868659;5809.157672137601;5810.070388737781;5820.82537523875;5822.563307752021;5495.880075449126;5555.50000499957;5584.888302233851;5593.944060559343;5603.243562119224;3949.1311911379453;3966.5240171179644;3973.1457736585617;3974.145558704892;3974.940375894422;5921.230240068763;5921.674307912934;5926.525877929842;5926.614770039933;5927.940720592911;5575.330960284792;5659.858503537444;5687.573431992534;5688.634727665413;5692.373838877803;5660.773569057356;5682.8579285516535;5686.289213848269;5697.487226149667;5705.743241554057;5530.944690553043;5557.083081291542;5565.6104072714525;5569.136783798518;5578.693171875586;5726.141078838207;5726.9713651431475;5732.627379220337;5735.197072409949;5736.110902810071;5449.727513624223;5559.193916881949;5582.413846546055;5594.916076258778;5595.832125036255 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: |5;yui.html;777.5684495105218;777.6539439949221;784.1609477858693;788.8146285622879;789.3330136035048;12246.448909799059;12512.812307815368;12516.061295402847;12549.247045177295;12550.623481295564;11759.7648047039;11796.941015294911;11877.584284550043;11896.405179741;11915;800.6437135474716;814.3281792521194;814.6415577146066;814.9755507334789;815.355868863597;807.6728924785472;814.3241109878786;815.4169768615438;815.5310696349593;815.7144999250274;850.1073872433919;856.7386946981168;857.3569822633025;858.7080392666492;858.9699360522383;853.9573021348908;854.4744981836158;854.7948492361851;854.974350769478;855.0380821575727;626.56766830887;626.6803929995735;627.8807026664919;628.2021832273033;628.4815027602201;10933.781324373547;11069.944650276697;11082.667519974413;11089.83365249522;11153.888461115366;9252.121048500381;9816.214702823829;9838.262130340181;9919.156871665917;9921.50392480373;8709.695160669346;8749.212570868589;8905;8906.688265910661;9709.61161553537;3285.1130194847497;3290.3748287825474;3309.7848639838335;3332.8333583320737;3421.9905127987304;34000;34837;35223.64776352255;35268.47097293543;41633.583664163576;8565.100664430145;8568.571571421404;9103.772405689911;9443.055694430503;9554.808903821884;15805.762913556306;15989.200539972955;16498.58753531171;16500.6699866002;16513.83486165123;6147.477464415485;6178.752849886044;6215.440610345091;6282.151909492251;6289.591176573508;3406.148462884279;3463.5151078848476;3480.1821571930577;3518.296340731864;3534.840932158059;2746.958795618067;2771.7089705580624;2773.55623100303;2777.8194417362806;2780.944381112407;485.80082166311644;493.20359503825017;495.274422970343;498.8179314550163;502.87930896584555;479.2403593806651;501.7516329416962;597.6503745308956;611.535233222745;640.1869625575494;7356.337929586363;7421.8144546386775;7520.172780994196;7604.429667774939;7793.10379306387;570.3070769015583;574.1617238831269;580.7212537981792;602.7679343452802;603.6227357901312;3681.9263614728093;3790.75360101598;3791.6777073949024;3818.8090595470117;3956.9208615828097;49108.508914910395;49622.50377496251;49655;49802.750986244835;57208;43647.78176109099;47751.283730744064;47881;48528;48643;37075.81462092672;42562.36156457655;42831.57168428276;43187.30596757508;43524;8149.9185008151535;8316.792080197802;8391.874121888299;8440.788980275296;8536.359773017173;31860.362792743552;31865.203369915936;32019.199520012186;32088.358232834744;33167.50248746319;36055.098622533595;36436.635633644386;36701.44947825838;39317;39414.2117157661;10003.399796012263;10199;10597.4701264938;10631.149985091191;10766.138708903112;11047.889521104686;11054.557817687202;11223;11288.20982531215;11334.60328888485;9816.16562592159;10232.846507302247;10949;11354.716132096764;11535.423228838692;10734;10908.61819836302;10947.099018759876;10952.288101273392;11328.207025508136;10008.499575021366;10073.445960472245;10181.643642472478;10664.626738064131;10692.930706929244;9009.27925765924;9197.540122993958;9204.401713888843;9279.814403712024;9325.533723313943;8506.914930850613;8589.871151932852;8706.695265665672;9383.077589684613;9654.855177172489 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,887 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: __startTimestamp1449193107995__endTimestamp 17:38:28 INFO - 2015-12-03 17:38:28,003 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4668.36 Median:4815.86 stddev:491.97 (10.2%) stddev-sans-first:466.46 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: Values: 2618.8 2686.7 2687.8 2698.4 2708.3 4464.3 4571.2 4665.4 4689.2 4729.9 4526.0 4602.9 4622.0 4669.3 4715.1 4321.6 4373.4 4390.6 4413.8 4421.9 4444.7 4471.8 4489.5 4498.8 4517.2 4221.7 4246.4 4351.8 4369.5 4373.3 4353.8 4362.1 4362.9 4376.0 4405.2 4348.4 4358.7 4361.8 4385.7 4391.5 4472.4 4600.3 4630.5 4637.8 4750.5 5079.2 5109.4 5120.4 5122.9 5163.4 5146.6 5151.6 5152.5 5192.1 5199.4 4551.2 4649.3 4669.6 4673.7 4774.9 5187.2 5199.5 5202.2 5202.8 5210.7 4980.3 4981.9 4989.2 4999.1 5026.2 4859.3 4928.8 4980.1 4982.4 4990.0 4987.9 5010.1 5017.6 5024.4 5043.0 5017.0 5033.9 5034.0 5044.9 5080.8 4063.6 4181.1 4217.5 4224.8 4294.5 3639.4 3673.1 3712.3 3745.7 3747.3 4335.3 4359.2 4359.8 4365.5 4405.7 4800.6 4914.8 5095.1 5140.2 5202.8 4257.5 4272.1 4335.2 4362.7 4377.4 4504.4 4549.3 4555.5 4559.3 4596.7 4538.9 4836.4 4838.9 4842.8 4876.7 4956.3 4964.6 4985.3 5058.5 5119.9 4815.9 4825.7 4845.1 4851.6 4887.6 4802.8 5046.5 5048.6 5054.8 5092.5 4978.3 4979.8 4987.5 5053.1 5070.2 4933.8 4952.5 4954.4 4955.9 5000.0 4673.0 4942.7 4948.9 4961.7 4962.0 4652.9 4758.4 4773.2 4895.9 4903.3 4989.7 5018.6 5020.0 5020.6 5023.1 4897.6 4909.7 4913.3 4914.3 4968.9 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40357.06 Median:30159.05 stddev:64321.71 (213.3%) stddev-sans-first:64432.69 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: Values: 543.6 553.5 554.9 561.4 563.6 26752.2 27106.0 27247.9 27386.0 34656.3 39278.8 40130.0 40130.2 40163.2 40193.2 7768.2 7926.6 7928.4 7929.2 7931.8 7028.2 7138.3 7834.7 10055.6 10285.9 9929.8 10017.8 10029.3 10030.2 10035.7 7217.7 9961.8 10016.9 10022.2 10024.8 7091.7 10058.9 10357.6 10363.3 10365.8 37257.8 37721.6 37772.4 37778.6 37819.2 2740.7 2879.3 2920.2 2967.1 2986.8 28659.7 28926.4 28931.0 28980.3 29646.6 3496.7 3499.4 3522.9 3585.7 3649.0 213820.0 214059.0 215786.0 216008.0 216238.0 50084.5 55307.0 55396.4 55409.2 55766.0 47102.0 63107.7 65690.3 65690.7 65717.7 12912.5 13271.7 13279.9 13293.7 13299.6 9249.8 9292.3 9293.8 9303.2 9343.8 18166.4 18212.3 18247.7 18256.8 18286.2 7223.5 7550.2 7582.4 7613.0 7675.8 828.0 874.7 892.8 930.2 948.5 26002.2 27495.7 28263.4 29363.6 29730.4 882.5 895.7 943.5 982.9 1039.5 13499.2 13526.3 13674.0 13753.2 13795.2 266222.0 270144.0 271077.0 271099.0 271240.0 44060.6 44227.6 44391.8 44469.8 44502.8 1225.4 1241.0 1250.6 1253.0 1253.5 24791.4 25822.9 26140.6 26374.3 26390.7 39962.8 40067.2 40217.2 40254.2 40393.6 249239.0 251981.0 252166.0 252948.0 253049.0 24732.4 25056.5 27813.3 28309.7 28498.9 34405.1 34736.8 34893.0 35154.6 35263.6 29776.7 30146.7 30450.2 30620.8 30781.8 28109.9 29661.7 30078.8 30171.4 34201.0 32280.8 32655.5 33030.7 33031.7 33062.5 28111.0 29620.6 29645.7 30408.8 30569.8 23053.9 23359.9 23711.8 23783.8 23853.9 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22203.55 Median:338.78 stddev:57673.86 (17024.2%) stddev-sans-first:57812.27 17:38:28 INFO - 2015-12-03 17:38:28,004 DEBUG : BROWSER_OUTPUT: Values: 336.2 337.8 338.6 338.9 339.6 12458.7 12793.6 12826.6 15025.0 15067.9 12210.6 14219.1 15047.8 15528.4 15585.8 3928.9 4839.4 4904.7 4914.3 4977.2 4926.8 4943.9 4944.6 4944.8 4947.9 4708.5 4813.0 4895.5 4899.0 4918.6 4838.6 4852.6 4856.4 4859.7 4860.1 4203.1 4310.5 4313.0 4314.8 4332.2 19552.2 19707.2 19754.7 19819.9 19841.7 1905.4 1939.5 1940.2 1965.0 2077.5 12491.5 12669.2 12764.7 13016.2 13164.6 1770.3 1773.4 1787.7 1815.8 1821.3 54370.0 55772.4 55922.2 55973.4 56001.4 8611.1 8845.8 9046.4 9167.1 9377.8 9909.9 10581.2 10819.5 10916.6 10933.5 6538.8 6691.2 6723.6 6792.5 6875.6 6365.1 6370.8 6460.8 6526.7 6575.8 5621.7 5700.5 5716.2 5735.6 5739.5 1640.2 1640.4 1643.9 1649.9 1656.5 859.4 885.0 895.5 899.5 905.3 15308.0 16642.5 16713.3 17099.8 17360.1 721.4 828.0 835.6 859.9 863.0 7716.3 8574.2 8653.4 8822.8 8854.8 314539.0 316600.0 320054.0 321383.0 461691.0 51132.2 62077.7 66736.0 72355.3 72435.6 1040.9 1047.8 1056.2 1077.1 1082.6 13845.2 13888.8 13960.7 14293.1 15046.7 29882.4 30067.2 30425.0 30500.8 30754.7 36574.3 40911.2 41052.4 45736.3 47594.5 8270.0 8455.5 8466.2 8522.0 8558.1 12857.6 15367.8 16697.4 16742.0 16902.0 13702.7 13719.4 13882.3 13886.8 13926.8 13675.5 13708.3 13776.4 13799.2 14300.4 13852.8 14128.2 14144.9 14352.2 14369.6 8502.3 8533.4 8640.4 8642.7 8658.2 13458.3 13592.9 13933.5 13955.1 14323.4 17:38:28 INFO - 2015-12-03 17:38:28,005 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,005 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5037.34 Median:6330.43 stddev:2634.60 (41.6%) stddev-sans-first:2627.84 17:38:28 INFO - 2015-12-03 17:38:28,006 DEBUG : BROWSER_OUTPUT: Values: 1405.0 1420.9 1424.3 1638.7 1705.1 6095.8 6405.4 7163.0 7320.6 7323.7 7203.6 7247.5 7335.2 7337.1 7342.6 1768.4 1805.9 2111.2 2146.3 2146.6 2054.9 2095.8 2100.8 2102.7 2103.8 2076.4 2092.4 2093.3 2095.1 2138.9 2083.9 2102.4 2108.4 2133.6 2134.5 1980.4 1997.6 1999.1 2002.7 2005.0 7222.8 7319.6 7324.6 7345.3 7348.3 4252.4 4304.4 4331.7 4332.4 4338.5 2836.3 2843.3 2855.3 2877.2 2902.4 901.5 944.1 959.6 960.3 972.6 9805.6 9849.3 9850.3 9852.2 9864.0 3954.5 4074.0 4093.0 4110.9 4121.8 8041.7 8090.9 8099.6 8106.0 8108.6 4244.0 4270.4 4273.3 4273.6 4279.4 3929.1 3929.8 3932.3 3932.8 3946.8 2842.3 2887.6 3193.1 3269.2 3289.9 976.6 1012.4 1012.8 1017.6 1018.1 957.5 963.0 1199.4 1222.2 1222.4 6820.7 6890.6 6907.4 6909.6 6912.6 573.3 582.7 592.0 592.3 721.9 5278.4 5345.8 5355.1 5363.1 5364.0 7866.0 8014.5 8027.8 8102.8 8121.6 8707.8 8739.3 8838.6 8847.6 8859.7 6510.5 6520.2 6641.0 6706.7 6710.3 6954.7 6966.0 6977.6 7010.1 7024.1 7883.6 7895.4 7911.5 8002.7 8066.5 7983.6 8073.4 8280.5 8296.5 8305.0 6320.5 6354.6 6476.4 6489.5 6497.3 6023.4 6137.0 6976.9 7031.0 7039.5 6254.2 6598.3 6600.1 6684.1 6760.8 6212.0 6287.2 6428.7 6473.0 6522.3 6582.8 6584.8 6589.3 6593.1 6643.3 6120.8 6169.9 6174.3 6179.0 6193.4 6259.2 6289.9 6295.7 6340.4 6344.8 17:38:28 INFO - 2015-12-03 17:38:28,006 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,006 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4680.11 Median:5369.34 stddev:1399.35 (26.1%) stddev-sans-first:1364.08 17:38:28 INFO - 2015-12-03 17:38:28,007 DEBUG : BROWSER_OUTPUT: Values: 298.4 301.9 306.0 306.0 308.9 5337.1 5398.2 5401.8 5418.8 5423.0 5064.6 5154.6 5231.6 5338.5 5340.5 4129.1 4139.0 4143.6 4150.7 4163.7 3925.6 4139.5 4147.6 4149.1 4152.6 3973.0 4012.8 4110.0 4122.9 4129.4 4074.8 4099.1 4109.5 4109.5 4124.5 3596.2 3616.9 3622.8 3623.7 3624.9 5146.6 5154.4 5168.9 5179.2 5188.8 4602.2 4717.6 4719.3 4729.2 4773.1 5637.2 5639.3 5643.2 5650.9 5663.2 3879.7 3880.0 3880.1 3881.2 3883.9 5888.4 5959.8 5962.7 5973.3 5973.9 3849.9 3973.7 3997.4 4000.9 4001.3 4008.1 4044.7 4046.1 4047.3 4053.4 4669.4 4676.6 4677.2 4678.0 4680.5 5665.4 5667.5 5676.2 5678.7 5682.5 1370.8 1403.6 1426.9 1432.8 1438.4 919.6 931.8 931.9 938.4 954.6 4854.4 4893.3 4895.7 4899.2 4913.4 5828.3 5836.6 5838.9 5842.1 5844.6 4783.0 4840.9 4854.7 4863.9 4985.7 3168.3 3181.4 3188.0 3189.1 3214.1 5563.2 5577.1 5580.0 5598.1 5602.5 5929.8 6079.3 6091.0 6094.1 6098.8 5577.8 5579.4 5605.2 5611.4 5624.7 5960.3 5961.6 5963.1 5967.6 5974.0 5808.1 5809.2 5810.1 5820.8 5822.6 5495.9 5555.5 5584.9 5593.9 5603.2 3949.1 3966.5 3973.1 3974.1 3974.9 5921.2 5921.7 5926.5 5926.6 5927.9 5575.3 5659.9 5687.6 5688.6 5692.4 5660.8 5682.9 5686.3 5697.5 5705.7 5530.9 5557.1 5565.6 5569.1 5578.7 5726.1 5727.0 5732.6 5735.2 5736.1 5449.7 5559.2 5582.4 5594.9 5595.8 17:38:28 INFO - 2015-12-03 17:38:28,007 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,008 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12205.99 Median:48875.75 stddev:13903.68 (28.4%) stddev-sans-first:13916.20 17:38:28 INFO - 2015-12-03 17:38:28,008 DEBUG : BROWSER_OUTPUT: Values: 777.6 777.7 784.2 788.8 789.3 12246.4 12512.8 12516.1 12549.2 12550.6 11759.8 11796.9 11877.6 11896.4 11915.0 800.6 814.3 814.6 815.0 815.4 807.7 814.3 815.4 815.5 815.7 850.1 856.7 857.4 858.7 859.0 854.0 854.5 854.8 855.0 855.0 626.6 626.7 627.9 628.2 628.5 10933.8 11069.9 11082.7 11089.8 11153.9 9252.1 9816.2 9838.3 9919.2 9921.5 8709.7 8749.2 8905.0 8906.7 9709.6 3285.1 3290.4 3309.8 3332.8 3422.0 34000.0 34837.0 35223.6 35268.5 41633.6 8565.1 8568.6 9103.8 9443.1 9554.8 15805.8 15989.2 16498.6 16500.7 16513.8 6147.5 6178.8 6215.4 6282.2 6289.6 3406.1 3463.5 3480.2 3518.3 3534.8 2747.0 2771.7 2773.6 2777.8 2780.9 485.8 493.2 495.3 498.8 502.9 479.2 501.8 597.7 611.5 640.2 7356.3 7421.8 7520.2 7604.4 7793.1 570.3 574.2 580.7 602.8 603.6 3681.9 3790.8 3791.7 3818.8 3956.9 49108.5 49622.5 49655.0 49802.8 57208.0 43647.8 47751.3 47881.0 48528.0 48643.0 37075.8 42562.4 42831.6 43187.3 43524.0 8149.9 8316.8 8391.9 8440.8 8536.4 31860.4 31865.2 32019.2 32088.4 33167.5 36055.1 36436.6 36701.4 39317.0 39414.2 10003.4 10199.0 10597.5 10631.1 10766.1 11047.9 11054.6 11223.0 11288.2 11334.6 9816.2 10232.8 10949.0 11354.7 11535.4 10734.0 10908.6 10947.1 10952.3 11328.2 10008.5 10073.4 10181.6 10664.6 10692.9 9009.3 9197.5 9204.4 9279.8 9325.5 8506.9 8589.9 8706.7 9383.1 9654.9 17:38:28 INFO - 2015-12-03 17:38:28,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:38:28 INFO - 2015-12-03 17:38:28,008 DEBUG : BROWSER_OUTPUT: 17:38:28 INFO - 2015-12-03 17:38:28,693 INFO : Browser exited with error code: 0 17:38:28 INFO - 2015-12-03 17:38:28,712 INFO : Completed test dromaeo_css (00:18:36) 17:38:28 INFO - 2015-12-03 17:38:28,712 INFO : Starting test kraken 17:38:28 INFO - 2015-12-03 17:38:28,712 DEBUG : operating with platform_type : linux_ 17:38:28 INFO - 2015-12-03 17:38:28,712 INFO : Initialising browser for kraken test... 17:38:28 INFO - 2015-12-03 17:38:28,718 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnFxTDP/profile http://localhost:45434/getInfo.html 17:38:32 INFO - 2015-12-03 17:38:32,816 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:38:32 INFO - 2015-12-03 17:38:32,816 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:38:32 INFO - 2015-12-03 17:38:32,816 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:38:32 INFO - 2015-12-03 17:38:32,816 DEBUG : BROWSER_OUTPUT: __metrics 17:38:32 INFO - 2015-12-03 17:38:32,904 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] 17:38:32 INFO - 2015-12-03 17:38:32,968 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] 17:38:33 INFO - 2015-12-03 17:38:33,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:38:33 INFO - 2015-12-03 17:38:33,887 INFO : Browser initialized. 17:38:33 INFO - 2015-12-03 17:38:33,887 INFO : Running cycle 1/1 for kraken test... 17:38:33 INFO - 2015-12-03 17:38:33,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnFxTDP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:38:45 INFO - 2015-12-03 17:38:45,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 140750848 17:38:45 INFO - 2015-12-03 17:38:45,946 DEBUG : BROWSER_OUTPUT: 17:38:48 INFO - 2015-12-03 17:38:48,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45434/tests/kraken/driver.html?testName=audio-beat-detection) 17:38:49 INFO - 2015-12-03 17:38:49,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 179249152 17:38:49 INFO - 2015-12-03 17:38:49,135 DEBUG : BROWSER_OUTPUT: 17:38:51 INFO - 2015-12-03 17:38:51,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45434/tests/kraken/driver.html?testName=audio-dft) 17:38:52 INFO - 2015-12-03 17:38:52,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 168775680 17:38:52 INFO - 2015-12-03 17:38:52,412 DEBUG : BROWSER_OUTPUT: 17:38:55 INFO - 2015-12-03 17:38:55,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45434/tests/kraken/driver.html?testName=audio-fft) 17:38:56 INFO - 2015-12-03 17:38:56,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 151949312 17:38:56 INFO - 2015-12-03 17:38:56,026 DEBUG : BROWSER_OUTPUT: 17:38:58 INFO - 2015-12-03 17:38:58,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45434/tests/kraken/driver.html?testName=audio-oscillator) 17:38:58 INFO - 2015-12-03 17:38:58,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 153997312 17:38:58 INFO - 2015-12-03 17:38:58,693 DEBUG : BROWSER_OUTPUT: 17:39:00 INFO - 2015-12-03 17:39:00,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:01 INFO - 2015-12-03 17:39:01,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 154677248 17:39:01 INFO - 2015-12-03 17:39:01,483 DEBUG : BROWSER_OUTPUT: 17:39:04 INFO - 2015-12-03 17:39:04,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45434/tests/kraken/driver.html?testName=imaging-darkroom) 17:39:05 INFO - 2015-12-03 17:39:05,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 155594752 17:39:05 INFO - 2015-12-03 17:39:05,038 DEBUG : BROWSER_OUTPUT: 17:39:08 INFO - 2015-12-03 17:39:08,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45434/tests/kraken/driver.html?testName=imaging-desaturate) 17:39:08 INFO - 2015-12-03 17:39:08,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 154984448 17:39:08 INFO - 2015-12-03 17:39:08,985 DEBUG : BROWSER_OUTPUT: 17:39:11 INFO - 2015-12-03 17:39:11,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45434/tests/kraken/driver.html?testName=json-parse-financial) 17:39:12 INFO - 2015-12-03 17:39:12,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 156254208 17:39:12 INFO - 2015-12-03 17:39:12,376 DEBUG : BROWSER_OUTPUT: 17:39:14 INFO - 2015-12-03 17:39:14,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:39:14 INFO - 2015-12-03 17:39:14,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 169697280 17:39:14 INFO - 2015-12-03 17:39:14,708 DEBUG : BROWSER_OUTPUT: 17:39:16 INFO - 2015-12-03 17:39:16,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:39:17 INFO - 2015-12-03 17:39:17,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 168038400 17:39:17 INFO - 2015-12-03 17:39:17,181 DEBUG : BROWSER_OUTPUT: 17:39:19 INFO - 2015-12-03 17:39:19,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:39:19 INFO - 2015-12-03 17:39:19,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 180203520 17:39:19 INFO - 2015-12-03 17:39:19,886 DEBUG : BROWSER_OUTPUT: 17:39:22 INFO - 2015-12-03 17:39:22,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:39:22 INFO - 2015-12-03 17:39:22,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 186863616 17:39:22 INFO - 2015-12-03 17:39:22,988 DEBUG : BROWSER_OUTPUT: 17:39:25 INFO - 2015-12-03 17:39:25,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:39:26 INFO - 2015-12-03 17:39:26,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 184819712 17:39:26 INFO - 2015-12-03 17:39:26,171 DEBUG : BROWSER_OUTPUT: 17:39:27 INFO - 2015-12-03 17:39:27,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45434/tests/kraken/driver.html?testName=ai-astar) 17:39:28 INFO - 2015-12-03 17:39:28,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 243474432 17:39:28 INFO - 2015-12-03 17:39:28,176 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,179 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:39:28 INFO - 2015-12-03 17:39:28,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:39:28 INFO - 2015-12-03 17:39:28,179 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:39:28 INFO - 2015-12-03 17:39:28,179 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:39:28 INFO - 2015-12-03 17:39:28,179 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;105;110;112;111;101;111;113;103 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;152;167;129;158;154;133;168;130 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;158;160;162;161;160;161;160 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;80;111;73;72;73;108;90;73 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;95;94;94;127;94;95;127 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;109;109 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;145;147;146;146;146 17:39:28 INFO - 2015-12-03 17:39:28,180 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;95;95;94 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;81;69;69;69;69;70;78;68;68 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;69;69;68;69;71 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;92;93;84;84;83;85;83;84 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;121;124;119;132;116;129;121;131;127 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;146;145;145;146;136;147;149;147;135 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;68;71;69;67;68;68;70 17:39:28 INFO - 2015-12-03 17:39:28,181 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:39:28 INFO - 2015-12-03 17:39:28,182 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:39:28 INFO - 2015-12-03 17:39:28,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 17:39:28 INFO - 2015-12-03 17:39:28,182 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:39:28 INFO - 2015-12-03 17:39:28,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1449193168177__endTimestamp 17:39:28 INFO - 2015-12-03 17:39:28,182 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:4.32 (3.9%) stddev-sans-first:4.44 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 105.0 110.0 112.0 111.0 101.0 111.0 113.0 103.0 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.50 stddev:15.65 (10.2%) stddev-sans-first:16.46 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 152.0 167.0 129.0 158.0 154.0 133.0 168.0 130.0 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 158.0 160.0 162.0 161.0 160.0 161.0 160.0 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:73.00 stddev:15.30 (21.0%) stddev-sans-first:15.84 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 80.0 111.0 73.0 72.0 73.0 108.0 90.0 73.0 17:39:28 INFO - 2015-12-03 17:39:28,190 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:94.00 stddev:16.24 (17.3%) stddev-sans-first:16.86 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 95.0 94.0 94.0 127.0 94.0 95.0 127.0 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 145.0 147.0 146.0 146.0 146.0 17:39:28 INFO - 2015-12-03 17:39:28,191 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 94.0 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:69.50 stddev:4.53 (6.5%) stddev-sans-first:4.79 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: Values: 70.0 81.0 69.0 69.0 69.0 69.0 70.0 78.0 68.0 68.0 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:0.97 (1.4%) stddev-sans-first:1.00 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 69.0 71.0 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:3.97 (4.7%) stddev-sans-first:4.03 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 92.0 93.0 84.0 84.0 83.0 85.0 83.0 84.0 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:125.50 stddev:5.67 (4.5%) stddev-sans-first:5.61 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: Values: 118.0 121.0 124.0 119.0 132.0 116.0 129.0 121.0 131.0 127.0 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,192 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.50 stddev:4.79 (3.3%) stddev-sans-first:4.97 17:39:28 INFO - 2015-12-03 17:39:28,193 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 145.0 146.0 136.0 147.0 149.0 147.0 135.0 17:39:28 INFO - 2015-12-03 17:39:28,193 DEBUG : BROWSER_OUTPUT: 17:39:28 INFO - 2015-12-03 17:39:28,193 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 17:39:28 INFO - 2015-12-03 17:39:28,193 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 71.0 69.0 67.0 68.0 68.0 70.0 17:39:28 INFO - 2015-12-03 17:39:28,193 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:39:28 INFO - 2015-12-03 17:39:28,193 DEBUG : BROWSER_OUTPUT: 17:39:29 INFO - 2015-12-03 17:39:29,149 INFO : Browser exited with error code: 0 17:39:29 INFO - 2015-12-03 17:39:29,199 INFO : Completed test kraken (00:01:00) 17:39:29 INFO - 2015-12-03 17:39:29,199 INFO : Starting test v8_7 17:39:29 INFO - 2015-12-03 17:39:29,199 DEBUG : operating with platform_type : linux_ 17:39:29 INFO - 2015-12-03 17:39:29,199 INFO : Initialising browser for v8_7 test... 17:39:29 INFO - 2015-12-03 17:39:29,205 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTkhXcU/profile http://localhost:45434/getInfo.html 17:39:33 INFO - 2015-12-03 17:39:33,475 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:39:33 INFO - 2015-12-03 17:39:33,475 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:39:33 INFO - 2015-12-03 17:39:33,476 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:39:33 INFO - 2015-12-03 17:39:33,476 DEBUG : BROWSER_OUTPUT: __metrics 17:39:33 INFO - 2015-12-03 17:39:33,578 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] 17:39:33 INFO - 2015-12-03 17:39:33,638 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] 17:39:34 INFO - 2015-12-03 17:39:34,474 INFO : Browser initialized. 17:39:34 INFO - 2015-12-03 17:39:34,475 INFO : Running cycle 1/1 for v8_7 test... 17:39:34 INFO - 2015-12-03 17:39:34,475 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTkhXcU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:39:46 INFO - 2015-12-03 17:39:46,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 143233024 17:39:46 INFO - 2015-12-03 17:39:46,478 DEBUG : BROWSER_OUTPUT: 17:40:07 INFO - 2015-12-03 17:40:07,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45434/tests/v8_7/run.html (next: http://localhost:45434/tests/v8_7/run.html) 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 471404544 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |0;Richards;166.86133822793258 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.28912071535024 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 17:40:08 INFO - 2015-12-03 17:40:08,209 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: |6;Boyer;11929.411764705883 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: |8;Splay;644.7453255963894 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1449193208202__endTimestamp 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: Values: 166.9 17:40:08 INFO - 2015-12-03 17:40:08,210 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: Values: 186.3 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: Values: 279.3 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: Values: 5133.3 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,211 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 1982.2 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 781.9 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11929.41 Median:11929.41 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 11929.4 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 26342.1 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:644.75 Median:644.75 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 644.7 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:40:08 INFO - 2015-12-03 17:40:08,212 DEBUG : BROWSER_OUTPUT: Values: 4830.9 17:40:08 INFO - 2015-12-03 17:40:08,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:40:08 INFO - 2015-12-03 17:40:08,213 DEBUG : BROWSER_OUTPUT: 17:40:09 INFO - 2015-12-03 17:40:09,069 INFO : Browser exited with error code: 0 17:40:09 INFO - 2015-12-03 17:40:09,086 INFO : Completed test v8_7 (00:00:39) 17:40:09 INFO - 2015-12-03 17:40:09,192 INFO : Completed test suite (00:20:17) 17:40:09 INFO - 2015-12-03 17:40:09,192 DEBUG : Working with test: dromaeo_css 17:40:09 INFO - 2015-12-03 17:40:09,192 DEBUG : Generating results file: dromaeo_css 17:40:09 INFO - 2015-12-03 17:40:09,193 DEBUG : Working with test: kraken 17:40:09 INFO - 2015-12-03 17:40:09,194 DEBUG : Generating results file: kraken 17:40:09 INFO - 2015-12-03 17:40:09,194 INFO : javascript benchmark 17:40:09 INFO - 2015-12-03 17:40:09,194 DEBUG : Working with test: v8_7 17:40:09 INFO - 2015-12-03 17:40:09,194 DEBUG : Generating results file: v8_7 17:40:09 INFO - 2015-12-03 17:40:09,194 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:40:09 INFO - 2015-12-03 17:40:09,345 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 17:40:09 INFO - 2015-12-03 17:40:09,345 DEBUG : process_Request line: dromaeo_css 6306.03 graph.html#tests=[[72,94,35]] 17:40:09 INFO - 2015-12-03 17:40:09,346 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:40:09 INFO - 2015-12-03 17:40:09,471 DEBUG : process_Request line: kraken 1516.30 graph.html#tests=[[232,94,35]] 17:40:09 INFO - 2015-12-03 17:40:09,471 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:40:09 INFO - 2015-12-03 17:40:09,590 DEBUG : process_Request line: v8_7 19787.94 graph.html#tests=[[230,94,35]] 17:40:09 INFO - 2015-12-03 17:40:09,592 INFO : javascript benchmark 17:40:09 INFO - 2015-12-03 17:40:09,595 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.842869427834, 2686.6775986881576, 2687.825291356062, 2698.3523954250973, 2708.322919270183, 4464.330350447426, 4571.2228921083415, 4665.4168228971375, 4689.249720044793, 4729.858104256873, 4525.9773701131535, 4602.907941841169, 4621.953780462194, 4669.252919532875, 4715.104130215265, 4321.5678432156765, 4373.387725718386, 4390.626796722282, 4413.801378937956, 4421.911561768763, 4444.688871778961, 4471.754053527071, 4489.5285994970545, 4498.8200471981245, 4517.164324599943, 4221.746695198282, 4246.363045543162, 4351.760653164107, 4369.519352871182, 4373.300271956472, 4353.804078816461, 4362.149380870732, 4362.912741745179, 4376.0, 4405.185040767468, 4348.434703488558, 4358.738475691469, 4361.781910904474, 4385.693001489897, 4391.4730232372, 4472.351509031172, 4600.263957766775, 4630.513796051399, 4637.791299391535, 4750.477447480775, 5079.187330027215, 5109.3613298337705, 5120.3855537335385, 5122.897542049138, 5163.406208286057, 5146.614003949719, 5151.6136289778415, 5152.5105115014385, 5192.117340052162, 5199.428062913076, 4551.158035763395, 4649.349091127245, 4669.6497762667595, 4673.719576825401, 4774.880627984328, 5187.170052791535, 5199.532042116228, 5202.167653175474, 5202.76587553561, 5210.6873587584105, 4980.2778597103215, 4981.850544483671, 4989.201727723546, 4999.10016197088, 5026.246063090565, 4859.319695242669, 4928.802847886116, 4980.053789780002, 4982.377202849644, 4990.001999600095, 4987.875303117451, 5010.073136469765, 5017.573506251936, 5024.397072351341, 5043.041822053798, 5017.0, 5033.924491132636, 5034.043531728959, 5044.924326135111, 5080.822171224063, 4063.6342729153926, 4181.1010632713505, 4217.514985776675, 4224.788760562021, 4294.506131794884, 3639.399499082622, 3673.081729567608, 3712.3132220539287, 3745.737798354089, 3747.306748251582, 4335.328024156261, 4359.215341238608, 4359.782010899442, 4365.497967733688, 4405.669574781904, 4800.615950723934, 4914.8034078637165, 5095.057414378278, 5140.203268493389, 5202.81790137351, 4257.489101307801, 4272.060146767768, 4335.219660461147, 4362.650987920959, 4377.365282034151, 4504.414426124583, 4549.340345649928, 4555.521670224579, 4559.338895860148, 4596.747178905125, 4538.931916021328, 4836.419629644465, 4838.8790280241865, 4842.782074806642, 4876.707397556158, 4956.281339205867, 4964.627652926118, 4985.326980857682, 5058.494150585059, 5119.948800512097, 4815.855524334275, 4825.686330388514, 4845.127876982177, 4851.611871050378, 4887.633427492881, 4802.759862006956, 5046.47012063728, 5048.646594738333, 5054.848354549369, 5092.490750924878, 4978.253262010728, 4979.775910083982, 4987.501249874984, 5053.140966035709, 5070.239464080418, 4933.777979990838, 4952.47998960104, 4954.430240522386, 4955.900881982268, 5000.0, 4673.042026384515, 4942.728149951788, 4948.925766113439, 4961.7271050092595, 4962.0, 4652.860414187579, 4758.428988521261, 4773.212419950669, 4895.877603059952, 4903.26451032348, 4989.650724449399, 5018.623603229846, 5019.970905964342, 5020.573251273682, 5023.120953832991, 4897.608191344612, 4909.729964851967, 4913.336699545515, 4914.287428322802, 4968.8757781055765], "unit": "ms", "name": "dojo.html", "value": 4637.396805691333}, {"lowerIsBetter": false, "replicates": [543.5570010441489, 553.4631407534691, 554.8917960997602, 561.3600495435204, 563.6111083352487, 26752.19743407696, 27106.0, 27247.86376068122, 27386.0, 34656.30687386257, 39278.803605982, 40130.0, 40130.19739605206, 40163.19673606526, 40193.196136077335, 7768.1843406442495, 7926.603669816515, 7928.365730741556, 7929.207079292082, 7931.8413631727335, 7028.226895041567, 7138.286171382872, 7834.72578459754, 10055.597776088947, 10285.897141028607, 9929.801403971916, 10017.849732254022, 10029.348092374008, 10030.197584193247, 10035.74910627233, 7217.675204615805, 9961.800763984716, 10016.949915250378, 10022.198224142052, 10024.849627255597, 7091.680874360614, 10058.89941100587, 10357.637482688146, 10363.32638378503, 10365.844512332322, 37257.81371093154, 37721.622783772356, 37772.43341349882, 37778.62221377779, 37819.24361512755, 2740.739629735192, 2879.294572829649, 2920.1823489422995, 2967.095036014015, 2986.8207907525402, 28659.713402865913, 28926.421471570662, 28931.0, 28980.27549311284, 29646.55530167049, 3496.6852983231634, 3499.3701133795907, 3522.9174472336704, 3585.748997570171, 3648.9817550912076, 213820.0, 214059.0, 215786.0, 216008.0, 216238.0, 50084.49915500799, 55307.0, 55396.44603553913, 55409.16886246709, 55766.0, 47102.0, 63107.684461577395, 65690.34309656938, 65690.67154664196, 65717.67141164263, 12912.548060817826, 13271.73456530864, 13279.867201327863, 13293.66765830862, 13299.601011969657, 9249.815003699889, 9292.256619470427, 9293.814123717488, 9303.209227215762, 9343.813123737487, 18166.364177253734, 18212.269834365714, 18247.72628410575, 18256.817431825777, 18286.17712202954, 7223.494355395072, 7550.244975502405, 7582.393408527305, 7613.0, 7675.808104797425, 827.983440331202, 874.6501399440148, 892.7991201979503, 930.2186163622589, 948.5115165689675, 26002.21993340203, 27495.725042749717, 28263.43473130526, 29363.55954660682, 29730.40539189204, 882.5410786391041, 895.6999405199201, 943.4575119306427, 982.8820541535061, 1039.4802598700649, 13499.22021833888, 13526.25605591702, 13674.042817002713, 13753.243571603458, 13795.172289662452, 266222.0, 270144.0, 271077.0, 271099.0, 271240.0, 44060.559394405645, 44227.557724422346, 44391.77804110959, 44469.77765111154, 44502.77748611236, 1225.4485481533345, 1241.0443958152173, 1250.637315178588, 1252.993735031319, 1253.4986005597652, 24791.380215494755, 25822.87088564545, 26140.60789088203, 26374.340641483348, 26390.73609263883, 39962.80018599889, 40067.198656026136, 40217.19565608613, 40254.1949161021, 40393.59606403898, 249239.0, 251981.0, 252166.0, 252948.0, 253049.0, 24732.38169045716, 25056.49887002286, 27813.304667383476, 28309.716902830707, 28498.857505712338, 34405.139871503416, 34736.82631586826, 34893.0, 35154.64845351514, 35263.64736352706, 29776.702232977394, 30146.69853301439, 30450.238744031576, 30620.84689576538, 30781.846090770297, 28109.859450703432, 29661.703382966756, 30078.84960575183, 30171.396572068876, 34201.0, 32280.838595806872, 32655.510167347984, 33030.669693302756, 33031.66968330286, 33062.5040624386, 28111.0, 29620.555691665075, 29645.70354296516, 30408.84795576008, 30569.847150764104, 23053.88473057624, 23359.88320058389, 23711.762882370957, 23783.762162378156, 23853.880730596236], "unit": "ms", "name": "ext.html", "value": 16820.001093903265}, {"lowerIsBetter": false, "replicates": [336.20319841974526, 337.7534399888081, 338.60383351478765, 338.9474631432129, 339.5874013074114, 12458.688532786662, 12793.616191514246, 12826.61520154397, 15025.0, 15067.924660376697, 12210.572629957953, 14219.075760075613, 15047.774283385757, 15528.378864845392, 15585.84414155858, 3928.939186419665, 4839.395075615548, 4904.705717656934, 4914.336564563774, 4977.1538838397555, 4926.827561035365, 4943.8516844494725, 4944.60443164546, 4944.752762361885, 4947.925781113287, 4708.505606911276, 4812.951870481303, 4895.534924182215, 4899.020195960822, 4918.5573298403315, 4838.564529192372, 4852.56326930578, 4856.39295088114, 4859.708417494961, 4860.125177468054, 4203.138356636882, 4310.525842157392, 4312.956870431287, 4314.784260786948, 4332.220200363933, 19552.217911283533, 19707.211711531523, 19754.70367944482, 19819.900900495548, 19841.70237446425, 1905.4474202481265, 1939.486036200394, 1940.2142132436386, 1964.9607007859906, 2077.491014701408, 12491.500339986389, 12669.239845609201, 12764.680882977907, 13016.15394999322, 13164.60506184816, 1770.2564922732354, 1773.4147731248656, 1787.705028670268, 1815.7639506864023, 1821.289697018164, 54370.0, 55772.44227557713, 55922.16116758211, 55973.44026559723, 56001.43998560003, 8611.095834937367, 8845.778855528662, 9046.366754327133, 9167.12912273333, 9377.812443751087, 9909.900900990899, 10581.153507719364, 10819.459027048617, 10916.617918372818, 10933.507992140372, 6538.836529086716, 6691.197056353269, 6723.562968407038, 6792.45660347171, 6875.5530890491955, 6365.108884756138, 6370.84072898172, 6460.806175814733, 6526.738930442729, 6575.835604109936, 5621.662700237999, 5700.486956173964, 5716.228309178207, 5735.598508104393, 5739.512141467939, 1640.196303811124, 1640.3848556791204, 1643.8520533152073, 1649.8680105591525, 1656.4616499637666, 859.4241857955185, 884.9867251991225, 895.5164211325941, 899.4603238057114, 905.3029167541089, 15308.0, 16642.50072497827, 16713.331466741194, 17099.829001710073, 17360.13199340028, 721.4336745654635, 827.9793005174919, 835.6448509383488, 859.9355048371397, 862.9741107766777, 7716.266954639413, 8574.185452382013, 8653.437526560754, 8822.77943051416, 8854.822903541894, 314539.0, 316600.0, 320054.0, 321383.0, 461691.0, 51132.23301650478, 62077.68961155165, 66736.0, 72355.27644723485, 72435.6378218116, 1040.8594839696696, 1047.8113939490813, 1056.2236755984345, 1077.0844781935448, 1082.6319051522362, 13845.16928984264, 13888.791668124784, 13960.720785584435, 14293.070435491076, 15046.699066018837, 29882.402351953275, 30067.248318792204, 30425.0, 30500.84749576238, 30754.692453075182, 36574.268514629024, 40911.18177636371, 41052.38421423621, 45736.31395529003, 47594.5240547604, 8270.0, 8455.534945578052, 8466.153384661484, 8521.957390213009, 8558.058613552379, 12857.614271571867, 15367.846321536641, 16697.415590454275, 16742.0, 16902.0, 13702.725945480835, 13719.382627781973, 13882.305884705926, 13886.819620332384, 13926.791098133739, 13675.521356752466, 13708.314584270547, 13776.380062896993, 13799.2410417428, 14300.427982880568, 13852.792208117087, 14128.222947737973, 14144.929275353968, 14352.210628415538, 14369.64075898111, 8502.319814414956, 8533.35999800005, 8640.395172337876, 8642.740717778477, 8658.225063861768, 13458.29279431355, 13592.93203533976, 13933.512327068504, 13955.092918960236, 14323.427062917783], "unit": "ms", "name": "jquery.html", "value": 8136.009578546026}, {"lowerIsBetter": false, "replicates": [1405.037549278744, 1420.9431622735092, 1424.2807382271951, 1638.6886491566604, 1705.1048199695158, 6095.847603809907, 6405.3594640535985, 7162.999999999994, 7320.633968301577, 7323.743668971587, 7203.6038017908995, 7247.528910620806, 7335.193128755833, 7337.119545654529, 7342.596157211351, 1768.4164225805453, 1805.9097045147755, 2111.1555377848867, 2146.2809958663865, 2146.602878467481, 2054.9280775172874, 2095.779943105975, 2100.821430178429, 2102.663573828188, 2103.842211834111, 2076.3874656976227, 2092.393205970267, 2093.27781915239, 2095.1200495791727, 2138.8823614701187, 2083.9374818755464, 2102.432343267317, 2108.3780284816016, 2133.6479480885714, 2134.50906291553, 1980.4256765537978, 1997.6204521140937, 1999.1303782854359, 2002.7496562929634, 2004.9699254511195, 7222.783316500513, 7319.59742214178, 7324.560526368435, 7345.3021962913435, 7348.338649521569, 4252.447181866369, 4304.397384366192, 4331.740095594275, 4332.371806088099, 4338.457692788402, 2836.262571731365, 2843.3033906692785, 2855.314724466134, 2877.208767588909, 2902.419516096768, 901.5492253873064, 944.1219665710886, 959.5825815770162, 960.2906825849998, 972.5672075926145, 9805.558749856202, 9849.261305402124, 9850.261230407676, 9852.211823054138, 9864.0, 3954.5452272988973, 4073.9592604074173, 4092.9972156821173, 4110.8561200358445, 4121.773302468333, 8041.718539851194, 8090.919090809017, 8099.595020248964, 8106.0, 8108.5945702714625, 4243.978780106141, 4270.42349282849, 4273.316269396882, 4273.636740876998, 4279.379489973936, 3929.0766669832565, 3929.8231579578987, 3932.311845427096, 3932.8230229639735, 3946.8223929923224, 2842.332051967786, 2887.581300711385, 3193.058047875882, 3269.2480729432364, 3289.8684052638105, 976.5947131940165, 1012.448215722433, 1012.7518757904361, 1017.6285655735603, 1018.1193267823279, 957.5403806173076, 962.9759256018656, 1199.424276347358, 1222.1689251309194, 1222.4010234984794, 6820.658967051628, 6890.621015844176, 6907.378335949788, 6909.619970901648, 6912.619805910623, 573.2919843992665, 582.6940856050608, 591.9526437884958, 592.2508027345411, 721.9458540609476, 5278.419373868871, 5345.81289654868, 5355.062863998863, 5363.141897296414, 5364.007658583175, 7865.960670196612, 8014.479058861155, 8027.799305017421, 8102.7569172924905, 8121.634526446206, 8707.825843483095, 8739.300855931637, 8838.558072096497, 8847.646094156162, 8859.734207973772, 6510.511711621647, 6520.18497687789, 6640.966795165993, 6706.66466676674, 6710.261871194165, 6954.652267386711, 6966.024756534191, 6977.616231107338, 7010.088688470466, 7024.051753013277, 7883.645235964281, 7895.447318687637, 7911.485753426009, 8002.679892804223, 8066.516009039477, 7983.600819959095, 8073.35413166957, 8280.461769984931, 8296.502209867427, 8305.0, 6320.462760665395, 6354.586951848115, 6476.417122459001, 6489.545731798728, 6497.317781632861, 6023.397660233942, 6137.0, 6976.895346569704, 7030.964845175741, 7039.507234493741, 6254.21822272216, 6598.3401659833635, 6600.1089852869245, 6684.06423100776, 6760.797176084725, 6211.9689401552705, 6287.2140982377205, 6428.678566071584, 6473.0, 6522.315156908457, 6582.76960306387, 6584.76953306632, 6589.308122647053, 6593.142891424276, 6643.269240383457, 6120.846978825565, 6169.938300616936, 6174.320824709189, 6179.0, 6193.411625895533, 6259.217597800275, 6289.9056514153235, 6295.685215739103, 6340.397662222082, 6344.777932772331], "unit": "ms", "name": "mootools.html", "value": 4084.7690744996817}, {"lowerIsBetter": false, "replicates": [298.41957392870864, 301.92451887028244, 305.9678733732957, 305.98470076496176, 308.857925354337, 5337.119375303075, 5398.190271459273, 5401.783928642854, 5418.810341638044, 5423.0238557059765, 5064.56951159152, 5154.587632989361, 5231.555317797982, 5338.519533242007, 5340.49265319795, 4129.112240868213, 4138.97930510347, 4143.56492568279, 4150.730202536841, 4163.708540402173, 3925.607439256066, 4139.503259608851, 4147.626713595776, 4149.149424368013, 4152.626263636272, 3972.9602703973023, 4012.799360031987, 4110.013596736791, 4122.917541649165, 4129.442525259082, 4074.8370065197355, 4099.139180772012, 4109.465769449982, 4109.506859176888, 4124.546299906993, 3596.1908570571672, 3616.945745813815, 3622.8188590570367, 3623.691986181178, 3624.8912532624063, 5146.562542183919, 5154.4072431670465, 5168.9224661630105, 5179.249008893689, 5188.8183913563225, 4602.1946159422305, 4717.551832575934, 4719.292106184065, 4729.172394830891, 4773.069251495925, 5637.210790489335, 5639.2668953036255, 5643.238162848004, 5650.886982260332, 5663.207150998864, 3879.739084797452, 3880.049387899983, 3880.1463677990796, 3881.2237552489332, 3883.941740873889, 5888.440598143169, 5959.761609535657, 5962.701864906738, 5973.313068997078, 5973.850653733692, 3849.9230015400094, 3973.6622387097423, 3997.420374045747, 4000.9199816003515, 4001.339778936443, 4008.118213992917, 4044.737092089005, 4046.089629833264, 4047.251258517184, 4053.43251944728, 4669.439667239885, 4676.55572720591, 4677.22825733757, 4677.976610116928, 4680.508546602626, 5665.3768085510565, 5667.518260947865, 5676.2337084493065, 5678.744456499468, 5682.54539636828, 1370.8286464191976, 1403.6140061483175, 1426.9143851368951, 1432.8495507971722, 1438.4461982136743, 919.6091661044029, 931.8322701913721, 931.8788557487619, 938.3525367496405, 954.5561313989028, 4854.417469903564, 4893.290472881412, 4895.657303988686, 4899.216125419915, 4913.410390753133, 5828.3006039274715, 5836.591438599342, 5838.94161058384, 5842.094475356326, 5844.649321040752, 4783.0, 4840.903181936412, 4854.660173787801, 4863.927041094386, 4985.675931064469, 3168.3188114555483, 3181.44324743169, 3188.0276515662945, 3189.1389324882152, 3214.100051985448, 5563.221149039137, 5577.079781836032, 5579.972100139474, 5598.1322894951345, 5602.52378547828, 5929.792457263975, 6079.331273559905, 6091.0, 6094.085887116968, 6098.847528811726, 5577.832665020056, 5579.38626751057, 5605.159226116034, 5611.410801865745, 5624.690642014729, 5960.314563825215, 5961.612495187799, 5963.105534169909, 5967.6419414835245, 5974.044152935509, 5808.07070868659, 5809.157672137601, 5810.070388737781, 5820.82537523875, 5822.563307752021, 5495.880075449126, 5555.50000499957, 5584.888302233851, 5593.944060559343, 5603.243562119224, 3949.1311911379453, 3966.5240171179644, 3973.1457736585617, 3974.145558704892, 3974.940375894422, 5921.230240068763, 5921.674307912934, 5926.525877929842, 5926.614770039933, 5927.940720592911, 5575.330960284792, 5659.858503537444, 5687.573431992534, 5688.634727665413, 5692.373838877803, 5660.773569057356, 5682.8579285516535, 5686.289213848269, 5697.487226149667, 5705.743241554057, 5530.944690553043, 5557.083081291542, 5565.6104072714525, 5569.136783798518, 5578.693171875586, 5726.141078838207, 5726.9713651431475, 5732.627379220337, 5735.197072409949, 5736.110902810071, 5449.727513624223, 5559.193916881949, 5582.413846546055, 5594.916076258778, 5595.832125036255], "unit": "ms", "name": "prototype.html", "value": 4226.32484392492}, {"lowerIsBetter": false, "replicates": [777.5684495105218, 777.6539439949221, 784.1609477858693, 788.8146285622879, 789.3330136035048, 12246.448909799059, 12512.812307815368, 12516.061295402847, 12549.247045177295, 12550.623481295564, 11759.7648047039, 11796.941015294911, 11877.584284550043, 11896.405179741, 11915.0, 800.6437135474716, 814.3281792521194, 814.6415577146066, 814.9755507334789, 815.355868863597, 807.6728924785472, 814.3241109878786, 815.4169768615438, 815.5310696349593, 815.7144999250274, 850.1073872433919, 856.7386946981168, 857.3569822633025, 858.7080392666492, 858.9699360522383, 853.9573021348908, 854.4744981836158, 854.7948492361851, 854.974350769478, 855.0380821575727, 626.56766830887, 626.6803929995735, 627.8807026664919, 628.2021832273033, 628.4815027602201, 10933.781324373547, 11069.944650276697, 11082.667519974413, 11089.83365249522, 11153.888461115366, 9252.121048500381, 9816.214702823829, 9838.262130340181, 9919.156871665917, 9921.50392480373, 8709.695160669346, 8749.212570868589, 8905.0, 8906.688265910661, 9709.61161553537, 3285.1130194847497, 3290.3748287825474, 3309.7848639838335, 3332.8333583320737, 3421.9905127987304, 34000.0, 34837.0, 35223.64776352255, 35268.47097293543, 41633.583664163576, 8565.100664430145, 8568.571571421404, 9103.772405689911, 9443.055694430503, 9554.808903821884, 15805.762913556306, 15989.200539972955, 16498.58753531171, 16500.6699866002, 16513.83486165123, 6147.477464415485, 6178.752849886044, 6215.440610345091, 6282.151909492251, 6289.591176573508, 3406.148462884279, 3463.5151078848476, 3480.1821571930577, 3518.296340731864, 3534.840932158059, 2746.958795618067, 2771.7089705580624, 2773.55623100303, 2777.8194417362806, 2780.944381112407, 485.80082166311644, 493.20359503825017, 495.274422970343, 498.8179314550163, 502.87930896584555, 479.2403593806651, 501.7516329416962, 597.6503745308956, 611.535233222745, 640.1869625575494, 7356.337929586363, 7421.8144546386775, 7520.172780994196, 7604.429667774939, 7793.10379306387, 570.3070769015583, 574.1617238831269, 580.7212537981792, 602.7679343452802, 603.6227357901312, 3681.9263614728093, 3790.75360101598, 3791.6777073949024, 3818.8090595470117, 3956.9208615828097, 49108.508914910395, 49622.50377496251, 49655.0, 49802.750986244835, 57208.0, 43647.78176109099, 47751.283730744064, 47881.0, 48528.0, 48643.0, 37075.81462092672, 42562.36156457655, 42831.57168428276, 43187.30596757508, 43524.0, 8149.9185008151535, 8316.792080197802, 8391.874121888299, 8440.788980275296, 8536.359773017173, 31860.362792743552, 31865.203369915936, 32019.199520012186, 32088.358232834744, 33167.50248746319, 36055.098622533595, 36436.635633644386, 36701.44947825838, 39317.0, 39414.2117157661, 10003.399796012263, 10199.0, 10597.4701264938, 10631.149985091191, 10766.138708903112, 11047.889521104686, 11054.557817687202, 11223.0, 11288.20982531215, 11334.60328888485, 9816.16562592159, 10232.846507302247, 10949.0, 11354.716132096764, 11535.423228838692, 10734.0, 10908.61819836302, 10947.099018759876, 10952.288101273392, 11328.207025508136, 10008.499575021366, 10073.445960472245, 10181.643642472478, 10664.626738064131, 10692.930706929244, 9009.27925765924, 9197.540122993958, 9204.401713888843, 9279.814403712024, 9325.533723313943, 8506.914930850613, 8589.871151932852, 8706.695265665672, 9383.077589684613, 9654.855177172489], "unit": "ms", "name": "yui.html", "value": 5739.182405608842}], "name": "dromaeo_css", "value": 6306.030766529724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 105.0, 110.0, 112.0, 111.0, 101.0, 111.0, 113.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 152.0, 167.0, 129.0, 158.0, 154.0, 133.0, 168.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 158.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 80.0, 111.0, 73.0, 72.0, 73.0, 108.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 95.0, 94.0, 94.0, 127.0, 94.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 104.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 81.0, 69.0, 69.0, 69.0, 69.0, 70.0, 78.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 92.0, 93.0, 84.0, 84.0, 83.0, 85.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 124.0, 119.0, 132.0, 116.0, 129.0, 121.0, 131.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 145.0, 146.0, 136.0, 147.0, 149.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 71.0, 69.0, 67.0, 68.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1516.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [11929.411764705883], "unit": "score", "name": "Boyer", "value": 55.867214003944795}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [644.7453255963894], "unit": "score", "name": "Splay", "value": 126.39254099999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19787.935388193488}]} 17:40:09 INFO - RETURN: dromaeo_css: 6306.03 17:40:09 INFO - RETURN: kraken: 1516.30 17:40:09 INFO - RETURN: v8_7: 19787.94 17:40:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19787.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6306.03"}}} 17:40:09 INFO - Return code: 0 17:40:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:40:09 INFO - # TBPL SUCCESS # 17:40:09 INFO - Running post-action listener: _resource_record_post_action 17:40:09 INFO - Running post-run listener: _resource_record_post_run 17:40:10 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 413696; Write bytes: 279621632; Read time: 112; Write time: 146736 17:40:10 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5464064; Read time: 0; Write time: 472 17:40:10 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 413696; Write bytes: 274157568; Read time: 112; Write time: 146264 17:40:10 INFO - Running post-run listener: _upload_blobber_files 17:40:10 INFO - Blob upload gear active. 17:40:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:40:10 INFO - Copying logs to upload dir... 17:40:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.733328 ========= master_lag: 1.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-03 17:40:12.325225) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:40:12.333777) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009921 build_url: 'https://queue.taskcluster.net/v1/task/9j8ooCWuQCGJcMcu8al3fw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 17:40:12.362204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:40:12.362569) ========= 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=928fd09416829678a2f67a56000001ac-1449191853.226092-855023929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 17:40:12.875287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:40:12.875669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 17:40:12.876059) ========= ========= Total master_lag: 2.36 =========