builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1450128955.38 results: success (0) buildid: 20151214121624 builduid: 21b2b619eee1449f9900fe31dc6f86db revision: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.384117) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.384604) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.384911) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006241 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.407867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.408190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.421603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.421982) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.471286) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.471599) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.471969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.472337) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 13:35:56-- 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% 222M=0s 2015-12-14 13:35:56 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.642472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.642786) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.692318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:55.692715) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 --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 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 --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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 13:35:56,415 truncating revision to first 12 chars 2015-12-14 13:35:56,415 Setting DEBUG logging. 2015-12-14 13:35:56,415 attempt 1/10 2015-12-14 13:35:56,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06ab805e14b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 13:35:56,723 unpacking tar archive at: mozilla-central-06ab805e14b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:56.292120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:56.292474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:56.302185) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:56.302566) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 13:35:56.303028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-14 13:35:56.303321) ========= /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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:35:57 INFO - MultiFileLogger online at 20151214 13:35:57 in /builds/slave/test 13:35:57 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 13:35:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:57 INFO - {'append_to_log': False, 13:35:57 INFO - 'base_work_dir': '/builds/slave/test', 13:35:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:35:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:57 INFO - 'branch': 'Firefox-Non-PGO', 13:35:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:57 INFO - 'config_files': ('talos/linux_config.py',), 13:35:57 INFO - 'default_actions': ('clobber', 13:35:57 INFO - 'read-buildbot-config', 13:35:57 INFO - 'download-and-extract', 13:35:57 INFO - 'populate-webroot', 13:35:57 INFO - 'create-virtualenv', 13:35:57 INFO - 'install', 13:35:57 INFO - 'run-tests'), 13:35:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:57 INFO - 'download_minidump_stackwalk': True, 13:35:57 INFO - 'download_symbols': 'ondemand', 13:35:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:57 INFO - 'installer_path': 'installer.exe', 13:35:57 INFO - 'log_level': 'info', 13:35:57 INFO - 'log_name': 'talos', 13:35:57 INFO - 'log_to_console': True, 13:35:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:35:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:35:57 INFO - 'opt_config_files': (), 13:35:57 INFO - 'pip_index': False, 13:35:57 INFO - 'sps_profile': False, 13:35:57 INFO - 'sps_profile_interval': 0, 13:35:57 INFO - 'suite': 'dromaeojs', 13:35:57 INFO - 'system_bits': '64', 13:35:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:57 INFO - 'title': 'talos-linux64-ix-061', 13:35:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:57 INFO - 'use_talos_json': True, 13:35:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:57 INFO - 'work_dir': 'build'} 13:35:57 INFO - ##### 13:35:57 INFO - ##### Running clobber step. 13:35:57 INFO - ##### 13:35:57 INFO - Running pre-action listener: _resource_record_pre_action 13:35:57 INFO - Running main action method: clobber 13:35:57 INFO - rmtree: /builds/slave/test/build 13:35:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:57 INFO - Running post-action listener: _resource_record_post_action 13:35:57 INFO - ##### 13:35:57 INFO - ##### Running read-buildbot-config step. 13:35:57 INFO - ##### 13:35:57 INFO - Running pre-action listener: _resource_record_pre_action 13:35:57 INFO - Running main action method: read_buildbot_config 13:35:57 INFO - Using buildbot properties: 13:35:57 INFO - { 13:35:57 INFO - "properties": { 13:35:57 INFO - "buildnumber": 240, 13:35:57 INFO - "product": "firefox", 13:35:57 INFO - "script_repo_revision": "production", 13:35:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:35:57 INFO - "repository": "", 13:35:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:35:57 INFO - "buildid": "20151214121624", 13:35:57 INFO - "slavename": "talos-linux64-ix-061", 13:35:57 INFO - "pgo_build": "False", 13:35:57 INFO - "basedir": "/builds/slave/test", 13:35:57 INFO - "project": "", 13:35:57 INFO - "platform": "ubuntu64_hw", 13:35:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:35:57 INFO - "slavebuilddir": "test", 13:35:57 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:35:57 INFO - "branch": "mozilla-central", 13:35:57 INFO - "repo_path": "mozilla-central", 13:35:57 INFO - "stage_platform": "linux64", 13:35:57 INFO - "builduid": "21b2b619eee1449f9900fe31dc6f86db", 13:35:57 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:35:57 INFO - }, 13:35:57 INFO - "sourcestamp": { 13:35:57 INFO - "repository": "", 13:35:57 INFO - "hasPatch": false, 13:35:57 INFO - "project": "", 13:35:57 INFO - "branch": "mozilla-central-linux64-talos", 13:35:57 INFO - "changes": [ 13:35:57 INFO - { 13:35:57 INFO - "category": null, 13:35:57 INFO - "files": [ 13:35:57 INFO - { 13:35:57 INFO - "url": null, 13:35:57 INFO - "name": "https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 13:35:57 INFO - } 13:35:57 INFO - ], 13:35:57 INFO - "repository": "", 13:35:57 INFO - "rev": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7", 13:35:57 INFO - "who": "raliiev@mozilla.com", 13:35:57 INFO - "when": 1450128613, 13:35:57 INFO - "number": 7358540, 13:35:57 INFO - "comments": "Update configs. IGNORE BROKEN CHANGESETS CLOSED TREE NO BUG a=release ba=release", 13:35:57 INFO - "project": "", 13:35:57 INFO - "at": "Mon 14 Dec 2015 13:30:13", 13:35:57 INFO - "branch": "mozilla-central-linux64-talos", 13:35:57 INFO - "revlink": "", 13:35:57 INFO - "properties": [ 13:35:57 INFO - [ 13:35:57 INFO - "buildid", 13:35:57 INFO - "20151214121624", 13:35:57 INFO - "Change" 13:35:57 INFO - ], 13:35:57 INFO - [ 13:35:57 INFO - "builduid", 13:35:57 INFO - "21b2b619eee1449f9900fe31dc6f86db", 13:35:57 INFO - "Change" 13:35:57 INFO - ], 13:35:57 INFO - [ 13:35:57 INFO - "pgo_build", 13:35:57 INFO - "False", 13:35:57 INFO - "Change" 13:35:57 INFO - ] 13:35:57 INFO - ], 13:35:57 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:35:57 INFO - } 13:35:57 INFO - ], 13:35:57 INFO - "revision": "06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7" 13:35:57 INFO - } 13:35:57 INFO - } 13:35:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:35:57 INFO - Running post-action listener: _resource_record_post_action 13:35:57 INFO - ##### 13:35:57 INFO - ##### Running download-and-extract step. 13:35:57 INFO - ##### 13:35:57 INFO - Running pre-action listener: _resource_record_pre_action 13:35:57 INFO - Running main action method: download_and_extract 13:35:57 INFO - mkdir: /builds/slave/test/build/tests 13:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:57 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:35:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json 13:35:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json 13:35:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:35:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:35:58 INFO - Downloaded 1302 bytes. 13:35:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:35:58 INFO - Using the following test package requirements: 13:35:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:35:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:35:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'jsshell-linux-x86_64.zip'], 13:35:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:35:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:35:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:35:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:35:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:35:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:35:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:35:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:35:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:35:58 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')]} 13:35:58 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:35:59 INFO - Downloaded 21869726 bytes. 13:35:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:35:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:35:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:36:00 INFO - Return code: 0 13:36:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:36:00 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')]} 13:36:00 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:36:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:36:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:36:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:36:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:36:01 INFO - Downloaded 21869726 bytes. 13:36:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:36:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:36:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:36:02 INFO - Return code: 0 13:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:02 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:36:06 INFO - Downloaded 11132038 bytes. 13:36:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:36:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:36:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:36:06 INFO - Return code: 0 13:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:06 INFO - https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:36:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:36:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:36:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:36:07 INFO - Downloaded 57740753 bytes. 13:36:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:36:07 INFO - mkdir: /builds/slave/test/properties 13:36:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:36:07 INFO - Writing to file /builds/slave/test/properties/build_url 13:36:07 INFO - Contents: 13:36:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:36:07 INFO - Running post-action listener: _resource_record_post_action 13:36:07 INFO - Running post-action listener: set_extra_try_arguments 13:36:07 INFO - ##### 13:36:07 INFO - ##### Running populate-webroot step. 13:36:07 INFO - ##### 13:36:07 INFO - Running pre-action listener: _resource_record_pre_action 13:36:07 INFO - Running main action method: populate_webroot 13:36:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:36:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:36:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:36:07 INFO - '--tppagecycles', 13:36:07 INFO - '7'], 13:36:07 INFO - 'tests': ['tsvgm']}}, 13:36:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:36:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:36:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:36:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:36:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'tests': ['damp', 'tps']}, 13:36:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['damp', 'tps']}, 13:36:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:36:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:36:07 INFO - 'other': {'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'other_l64': {'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'other_nol64': {'tests': ['a11yr', 13:36:07 INFO - 'ts_paint', 13:36:07 INFO - 'tpaint', 13:36:07 INFO - 'sessionrestore', 13:36:07 INFO - 'sessionrestore_no_auto_restore']}, 13:36:07 INFO - 'svgr': {'tests': ['tsvgx', 13:36:07 INFO - 'tsvgr_opacity', 13:36:07 INFO - 'tart', 13:36:07 INFO - 'tscrollx', 13:36:07 INFO - 'cart']}, 13:36:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['tsvgx', 13:36:07 INFO - 'tsvgr_opacity', 13:36:07 INFO - 'tart', 13:36:07 INFO - 'tscrollx', 13:36:07 INFO - 'cart']}, 13:36:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'tests': ['tp5o']}, 13:36:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'talos_options': ['--e10s'], 13:36:07 INFO - 'tests': ['tp5o']}, 13:36:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'talos_options': ['--xperf_path', 13:36:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:07 INFO - 'tests': ['tp5n']}, 13:36:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:07 INFO - 'talos_options': ['--e10s', 13:36:07 INFO - '--xperf_path', 13:36:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:07 INFO - 'tests': ['tp5n']}}, 13:36:07 INFO - 'talos.zip': {'path': '', 13:36:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:36:07 INFO - Running post-action listener: _resource_record_post_action 13:36:07 INFO - ##### 13:36:07 INFO - ##### Running create-virtualenv step. 13:36:07 INFO - ##### 13:36:07 INFO - Running pre-action listener: _resource_record_pre_action 13:36:07 INFO - Running main action method: create_virtualenv 13:36:07 INFO - Creating virtualenv /builds/slave/test/build/venv 13:36:07 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 13:36:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:36:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:36:07 INFO - Using real prefix '/usr' 13:36:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:36:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:36:10 INFO - Installing pip.................done. 13:36:10 INFO - Return code: 0 13:36:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:10 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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:10 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 13:36:10 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 13:36:10 INFO - Using env: {'DISPLAY': ':0', 13:36:10 INFO - 'HOME': '/home/cltbld', 13:36:10 INFO - 'LANG': 'en_US.UTF-8', 13:36:10 INFO - 'LANGUAGE': 'en_US:en', 13:36:10 INFO - 'LOGNAME': 'cltbld', 13:36:10 INFO - 'MAIL': '/var/mail/cltbld', 13:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:10 INFO - 'MOZ_NO_REMOTE': '1', 13:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:10 INFO - 'NO_EM_RESTART': '1', 13:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:10 INFO - 'PWD': '/builds/slave/test', 13:36:10 INFO - 'SHELL': '/bin/bash', 13:36:10 INFO - 'SHLVL': '1', 13:36:10 INFO - 'TERM': 'linux', 13:36:10 INFO - 'TMOUT': '86400', 13:36:10 INFO - 'USER': 'cltbld', 13:36:10 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:10 INFO - '_': '/tools/buildbot/bin/python'} 13:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:10 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 13:36:10 INFO - Cleaning up... 13:36:10 INFO - Return code: 0 13:36:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:10 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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:10 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 13:36:10 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 13:36:10 INFO - Using env: {'DISPLAY': ':0', 13:36:10 INFO - 'HOME': '/home/cltbld', 13:36:10 INFO - 'LANG': 'en_US.UTF-8', 13:36:10 INFO - 'LANGUAGE': 'en_US:en', 13:36:10 INFO - 'LOGNAME': 'cltbld', 13:36:10 INFO - 'MAIL': '/var/mail/cltbld', 13:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:10 INFO - 'MOZ_NO_REMOTE': '1', 13:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:10 INFO - 'NO_EM_RESTART': '1', 13:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:10 INFO - 'PWD': '/builds/slave/test', 13:36:10 INFO - 'SHELL': '/bin/bash', 13:36:10 INFO - 'SHLVL': '1', 13:36:10 INFO - 'TERM': 'linux', 13:36:10 INFO - 'TMOUT': '86400', 13:36:10 INFO - 'USER': 'cltbld', 13:36:10 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:10 INFO - '_': '/tools/buildbot/bin/python'} 13:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:10 INFO - Downloading/unpacking psutil>=0.7.1 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:36:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:36:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:12 INFO - Installing collected packages: psutil 13:36:12 INFO - Running setup.py install for psutil 13:36:12 INFO - building 'psutil._psutil_linux' extension 13:36:12 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 13:36:12 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 13:36:12 INFO - building 'psutil._psutil_posix' extension 13:36:12 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 13:36:12 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 13:36:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:12 INFO - Successfully installed psutil 13:36:12 INFO - Cleaning up... 13:36:13 INFO - Return code: 0 13:36:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:36:13 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')]} 13:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:13 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')]} 13:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:13 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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:13 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 13:36:13 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 13:36:13 INFO - Using env: {'DISPLAY': ':0', 13:36:13 INFO - 'HOME': '/home/cltbld', 13:36:13 INFO - 'LANG': 'en_US.UTF-8', 13:36:13 INFO - 'LANGUAGE': 'en_US:en', 13:36:13 INFO - 'LOGNAME': 'cltbld', 13:36:13 INFO - 'MAIL': '/var/mail/cltbld', 13:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:13 INFO - 'MOZ_NO_REMOTE': '1', 13:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:13 INFO - 'NO_EM_RESTART': '1', 13:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:13 INFO - 'PWD': '/builds/slave/test', 13:36:13 INFO - 'SHELL': '/bin/bash', 13:36:13 INFO - 'SHLVL': '1', 13:36:13 INFO - 'TERM': 'linux', 13:36:13 INFO - 'TMOUT': '86400', 13:36:13 INFO - 'USER': 'cltbld', 13:36:13 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:13 INFO - '_': '/tools/buildbot/bin/python'} 13:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:13 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 13:36:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:36:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:36:14 INFO - Installing collected packages: mozsystemmonitor 13:36:14 INFO - Running setup.py install for mozsystemmonitor 13:36:15 INFO - Successfully installed mozsystemmonitor 13:36:15 INFO - Cleaning up... 13:36:15 INFO - Return code: 0 13:36:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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', '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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:36: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 blobuploader==1.2.4 13:36:15 INFO - Using env: {'DISPLAY': ':0', 13:36:15 INFO - 'HOME': '/home/cltbld', 13:36:15 INFO - 'LANG': 'en_US.UTF-8', 13:36:15 INFO - 'LANGUAGE': 'en_US:en', 13:36:15 INFO - 'LOGNAME': 'cltbld', 13:36:15 INFO - 'MAIL': '/var/mail/cltbld', 13:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:15 INFO - 'MOZ_NO_REMOTE': '1', 13:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:15 INFO - 'NO_EM_RESTART': '1', 13:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:15 INFO - 'PWD': '/builds/slave/test', 13:36:15 INFO - 'SHELL': '/bin/bash', 13:36:15 INFO - 'SHLVL': '1', 13:36:15 INFO - 'TERM': 'linux', 13:36:15 INFO - 'TMOUT': '86400', 13:36:15 INFO - 'USER': 'cltbld', 13:36:15 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:15 INFO - '_': '/tools/buildbot/bin/python'} 13:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:16 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 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 13:36:17 INFO - Downloading docopt-0.6.1.tar.gz 13:36:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:17 INFO - Running setup.py install for blobuploader 13:36:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:17 INFO - Running setup.py install for requests 13:36:18 INFO - Running setup.py install for docopt 13:36:18 INFO - Successfully installed blobuploader requests docopt 13:36:18 INFO - Cleaning up... 13:36:18 INFO - Return code: 0 13:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:18 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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:18 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 13:36:18 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 13:36:18 INFO - Using env: {'DISPLAY': ':0', 13:36:18 INFO - 'HOME': '/home/cltbld', 13:36:18 INFO - 'LANG': 'en_US.UTF-8', 13:36:18 INFO - 'LANGUAGE': 'en_US:en', 13:36:18 INFO - 'LOGNAME': 'cltbld', 13:36:18 INFO - 'MAIL': '/var/mail/cltbld', 13:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:18 INFO - 'MOZ_NO_REMOTE': '1', 13:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:18 INFO - 'NO_EM_RESTART': '1', 13:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:18 INFO - 'PWD': '/builds/slave/test', 13:36:18 INFO - 'SHELL': '/bin/bash', 13:36:18 INFO - 'SHLVL': '1', 13:36:18 INFO - 'TERM': 'linux', 13:36:18 INFO - 'TMOUT': '86400', 13:36:18 INFO - 'USER': 'cltbld', 13:36:18 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:18 INFO - '_': '/tools/buildbot/bin/python'} 13:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:18 INFO - Running setup.py (path:/tmp/pip-m74jv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:18 INFO - Running setup.py (path:/tmp/pip-o76OId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:18 INFO - Running setup.py (path:/tmp/pip-xaOyen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:18 INFO - Running setup.py (path:/tmp/pip-_YhLqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:18 INFO - Running setup.py (path:/tmp/pip-iyZDr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:18 INFO - Running setup.py (path:/tmp/pip-XOmR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:18 INFO - Running setup.py (path:/tmp/pip-KY2Ran-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:19 INFO - Running setup.py (path:/tmp/pip-4wnaYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:19 INFO - Running setup.py (path:/tmp/pip-NUtKCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:19 INFO - Running setup.py (path:/tmp/pip-CKt3aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:19 INFO - Running setup.py (path:/tmp/pip-C_nUsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:19 INFO - Running setup.py (path:/tmp/pip-SzA5is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:19 INFO - Running setup.py (path:/tmp/pip-yLfDtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:19 INFO - Running setup.py (path:/tmp/pip-1Vd3ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:19 INFO - Running setup.py (path:/tmp/pip-6dtqzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:19 INFO - Running setup.py (path:/tmp/pip-T9Zqmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:19 INFO - Running setup.py (path:/tmp/pip-46_3en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:19 INFO - Running setup.py install for manifestparser 13:36:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:19 INFO - Running setup.py install for mozcrash 13:36:19 INFO - Running setup.py install for mozdebug 13:36:20 INFO - Running setup.py install for mozdevice 13:36:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for mozfile 13:36:20 INFO - Running setup.py install for mozhttpd 13:36:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for mozinfo 13:36:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for mozInstall 13:36:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for mozleak 13:36:20 INFO - Running setup.py install for mozlog 13:36:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for moznetwork 13:36:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Running setup.py install for mozprocess 13:36:20 INFO - Running setup.py install for mozprofile 13:36:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:21 INFO - Running setup.py install for mozrunner 13:36:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:21 INFO - Running setup.py install for mozscreenshot 13:36:21 INFO - Running setup.py install for moztest 13:36:21 INFO - Running setup.py install for mozversion 13:36:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:21 INFO - Cleaning up... 13:36:21 INFO - Return code: 0 13:36:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:21 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 13:36:21 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 13:36:21 INFO - Using env: {'DISPLAY': ':0', 13:36:21 INFO - 'HOME': '/home/cltbld', 13:36:21 INFO - 'LANG': 'en_US.UTF-8', 13:36:21 INFO - 'LANGUAGE': 'en_US:en', 13:36:21 INFO - 'LOGNAME': 'cltbld', 13:36:21 INFO - 'MAIL': '/var/mail/cltbld', 13:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:21 INFO - 'MOZ_NO_REMOTE': '1', 13:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:21 INFO - 'NO_EM_RESTART': '1', 13:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:21 INFO - 'PWD': '/builds/slave/test', 13:36:21 INFO - 'SHELL': '/bin/bash', 13:36:21 INFO - 'SHLVL': '1', 13:36:21 INFO - 'TERM': 'linux', 13:36:21 INFO - 'TMOUT': '86400', 13:36:21 INFO - 'USER': 'cltbld', 13:36:21 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:21 INFO - '_': '/tools/buildbot/bin/python'} 13:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:21 INFO - Running setup.py (path:/tmp/pip-eCDBYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:21 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)) 13:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:21 INFO - Running setup.py (path:/tmp/pip-oUwrb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:21 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)) 13:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:21 INFO - Running setup.py (path:/tmp/pip-PQYMWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:21 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)) 13:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:21 INFO - Running setup.py (path:/tmp/pip-KPwNif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:22 INFO - Running setup.py (path:/tmp/pip-S324lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:22 INFO - Running setup.py (path:/tmp/pip-MlQPwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:22 INFO - Running setup.py (path:/tmp/pip-alzR3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:22 INFO - Running setup.py (path:/tmp/pip-bLqh7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:22 INFO - Running setup.py (path:/tmp/pip-1e4Eoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:22 INFO - Running setup.py (path:/tmp/pip-sG1UH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:22 INFO - Running setup.py (path:/tmp/pip-CXOfub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:22 INFO - Running setup.py (path:/tmp/pip-7IZgW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:22 INFO - Running setup.py (path:/tmp/pip-B0NeYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:22 INFO - Running setup.py (path:/tmp/pip-JQKzET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:22 INFO - Running setup.py (path:/tmp/pip-w1Fu1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:22 INFO - Running setup.py (path:/tmp/pip-ZY0E3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:22 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)) 13:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:22 INFO - Running setup.py (path:/tmp/pip-TuQsr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:22 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)) 13:36:22 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)) 13:36:22 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)) 13:36:22 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)) 13:36:22 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)) 13:36:22 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)) 13:36:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:24 INFO - Downloading blessings-1.5.1.tar.gz 13:36:24 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 13:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:24 INFO - Installing collected packages: blessings 13:36:24 INFO - Running setup.py install for blessings 13:36:24 INFO - Successfully installed blessings 13:36:24 INFO - Cleaning up... 13:36:24 INFO - Return code: 0 13:36:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:25 INFO - Reading from file tmpfile_stdout 13:36:25 INFO - Current package versions: 13:36:25 INFO - argparse == 1.2.1 13:36:25 INFO - blessings == 1.5.1 13:36:25 INFO - blobuploader == 1.2.4 13:36:25 INFO - docopt == 0.6.1 13:36:25 INFO - manifestparser == 1.1 13:36:25 INFO - mozInstall == 1.12 13:36:25 INFO - mozcrash == 0.16 13:36:25 INFO - mozdebug == 0.1 13:36:25 INFO - mozdevice == 0.47 13:36:25 INFO - mozfile == 1.2 13:36:25 INFO - mozhttpd == 0.7 13:36:25 INFO - mozinfo == 0.9 13:36:25 INFO - mozleak == 0.1 13:36:25 INFO - mozlog == 3.1 13:36:25 INFO - moznetwork == 0.27 13:36:25 INFO - mozprocess == 0.22 13:36:25 INFO - mozprofile == 0.27 13:36:25 INFO - mozrunner == 6.11 13:36:25 INFO - mozscreenshot == 0.1 13:36:25 INFO - mozsystemmonitor == 0.0 13:36:25 INFO - moztest == 0.7 13:36:25 INFO - mozversion == 1.4 13:36:25 INFO - psutil == 3.1.1 13:36:25 INFO - requests == 1.2.3 13:36:25 INFO - wsgiref == 0.1.2 13:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:25 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 13:36:25 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 13:36:25 INFO - Using env: {'DISPLAY': ':0', 13:36:25 INFO - 'HOME': '/home/cltbld', 13:36:25 INFO - 'LANG': 'en_US.UTF-8', 13:36:25 INFO - 'LANGUAGE': 'en_US:en', 13:36:25 INFO - 'LOGNAME': 'cltbld', 13:36:25 INFO - 'MAIL': '/var/mail/cltbld', 13:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:25 INFO - 'MOZ_NO_REMOTE': '1', 13:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:25 INFO - 'NO_EM_RESTART': '1', 13:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:25 INFO - 'PWD': '/builds/slave/test', 13:36:25 INFO - 'SHELL': '/bin/bash', 13:36:25 INFO - 'SHLVL': '1', 13:36:25 INFO - 'TERM': 'linux', 13:36:25 INFO - 'TMOUT': '86400', 13:36:25 INFO - 'USER': 'cltbld', 13:36:25 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:25 INFO - '_': '/tools/buildbot/bin/python'} 13:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 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)) 13:36:25 INFO - Cleaning up... 13:36:25 INFO - Return code: 0 13:36:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:36:25 INFO - Using env: {'DISPLAY': ':0', 13:36:25 INFO - 'HOME': '/home/cltbld', 13:36:25 INFO - 'LANG': 'en_US.UTF-8', 13:36:25 INFO - 'LANGUAGE': 'en_US:en', 13:36:25 INFO - 'LOGNAME': 'cltbld', 13:36:25 INFO - 'MAIL': '/var/mail/cltbld', 13:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:25 INFO - 'MOZ_NO_REMOTE': '1', 13:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:25 INFO - 'NO_EM_RESTART': '1', 13:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:25 INFO - 'PWD': '/builds/slave/test', 13:36:25 INFO - 'SHELL': '/bin/bash', 13:36:25 INFO - 'SHLVL': '1', 13:36:25 INFO - 'TERM': 'linux', 13:36:25 INFO - 'TMOUT': '86400', 13:36:25 INFO - 'USER': 'cltbld', 13:36:25 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:25 INFO - '_': '/tools/buildbot/bin/python'} 13:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:25 INFO - Downloading/unpacking jsonschema 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:36:27 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 13:36:27 INFO - Downloading/unpacking functools32 (from jsonschema) 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 INFO - Downloading functools32-3.2.3-2.tar.gz 13:36:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:36:27 INFO - warning: no files found matching '*.txt' 13:36:27 INFO - no previously-included directories found matching 'build' 13:36:27 INFO - no previously-included directories found matching 'dist' 13:36:27 INFO - no previously-included directories found matching '.git*' 13:36:27 INFO - Installing collected packages: jsonschema, functools32 13:36:27 INFO - Running setup.py install for functools32 13:36:27 INFO - warning: no files found matching '*.txt' 13:36:27 INFO - no previously-included directories found matching 'build' 13:36:27 INFO - no previously-included directories found matching 'dist' 13:36:27 INFO - no previously-included directories found matching '.git*' 13:36:27 INFO - Successfully installed jsonschema functools32 13:36:27 INFO - Cleaning up... 13:36:27 INFO - Return code: 0 13:36:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e26e74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, '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': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', '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 13:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:36:27 INFO - Using env: {'DISPLAY': ':0', 13:36:27 INFO - 'HOME': '/home/cltbld', 13:36:27 INFO - 'LANG': 'en_US.UTF-8', 13:36:27 INFO - 'LANGUAGE': 'en_US:en', 13:36:27 INFO - 'LOGNAME': 'cltbld', 13:36:27 INFO - 'MAIL': '/var/mail/cltbld', 13:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:27 INFO - 'MOZ_NO_REMOTE': '1', 13:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:27 INFO - 'NO_EM_RESTART': '1', 13:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:27 INFO - 'PWD': '/builds/slave/test', 13:36:27 INFO - 'SHELL': '/bin/bash', 13:36:27 INFO - 'SHLVL': '1', 13:36:27 INFO - 'TERM': 'linux', 13:36:27 INFO - 'TMOUT': '86400', 13:36:27 INFO - 'USER': 'cltbld', 13:36:27 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:27 INFO - '_': '/tools/buildbot/bin/python'} 13:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:27 INFO - Downloading/unpacking flake8 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:27 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 13:36:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:36:29 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 13:36:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:36:29 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 13:36:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:29 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 13:36:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:30 INFO - no previously-included directories found matching 'docs/_build' 13:36:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:36:30 INFO - Running setup.py install for pep8 13:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:30 INFO - no previously-included directories found matching 'docs/_build' 13:36:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:36:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:36:30 INFO - Cleaning up... 13:36:30 INFO - Return code: 0 13:36:30 INFO - Running post-action listener: _resource_record_post_action 13:36:30 INFO - Running post-action listener: _start_resource_monitoring 13:36:30 INFO - Starting resource monitoring. 13:36:30 INFO - ##### 13:36:30 INFO - ##### Running install step. 13:36:30 INFO - ##### 13:36:30 INFO - Running pre-action listener: _resource_record_pre_action 13:36:30 INFO - Running main action method: install 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:30 INFO - Reading from file tmpfile_stdout 13:36:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:30 INFO - Reading from file tmpfile_stdout 13:36:30 INFO - Output received: 13:36:30 INFO - Usage: mozinstall [options] installer 13:36:30 INFO - Options: 13:36:30 INFO - -h, --help show this help message and exit 13:36:30 INFO - -d DEST, --destination=DEST 13:36:30 INFO - Directory to install application into. [default: 13:36:30 INFO - "/builds/slave/test"] 13:36:30 INFO - --app=APP Application being installed. [default: firefox] 13:36:30 INFO - mkdir: /builds/slave/test/build/application 13:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:36:45 INFO - Reading from file tmpfile_stdout 13:36:45 INFO - Output received: 13:36:45 INFO - /builds/slave/test/build/application/firefox/firefox 13:36:45 INFO - Running post-action listener: _resource_record_post_action 13:36:45 INFO - ##### 13:36:45 INFO - ##### Running run-tests step. 13:36:45 INFO - ##### 13:36:45 INFO - Running pre-action listener: _resource_record_pre_action 13:36:45 INFO - Running main action method: run_tests 13:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:45 INFO - Python 2.7.3 13:36:45 INFO - Return code: 0 13:36:45 INFO - grabbing minidump binary from tooltool 13:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:45 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 0x218e0b0>, '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 0x218efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:45 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 13:36:45 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 13:36:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:45 INFO - Return code: 0 13:36:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:36:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:36:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:36:46 INFO - Return code: 0 13:36:46 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/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 13:36:46 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/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 13:36:46 INFO - Using env: {'DISPLAY': ':0', 13:36:46 INFO - 'HOME': '/home/cltbld', 13:36:46 INFO - 'LANG': 'en_US.UTF-8', 13:36:46 INFO - 'LANGUAGE': 'en_US:en', 13:36:46 INFO - 'LOGNAME': 'cltbld', 13:36:46 INFO - 'MAIL': '/var/mail/cltbld', 13:36:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:46 INFO - 'MOZ_NO_REMOTE': '1', 13:36:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:46 INFO - 'NO_EM_RESTART': '1', 13:36:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:46 INFO - 'PWD': '/builds/slave/test', 13:36:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:46 INFO - 'SHELL': '/bin/bash', 13:36:46 INFO - 'SHLVL': '1', 13:36:46 INFO - 'TERM': 'linux', 13:36:46 INFO - 'TMOUT': '86400', 13:36:46 INFO - 'USER': 'cltbld', 13:36:46 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639', 13:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:46 INFO - '_': '/tools/buildbot/bin/python'} 13:36:46 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/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 13:36:46 INFO - mozversion INFO | application_buildid: 20151214121624 13:36:46 INFO - mozversion INFO | application_changeset: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 13:36:46 INFO - mozversion INFO | application_display_name: Nightly 13:36:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:46 INFO - mozversion INFO | application_name: Firefox 13:36:46 INFO - mozversion INFO | application_remotingname: firefox 13:36:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 13:36:46 INFO - mozversion INFO | application_vendor: Mozilla 13:36:46 INFO - mozversion INFO | application_version: 46.0a1 13:36:46 INFO - mozversion INFO | platform_buildid: 20151214121624 13:36:46 INFO - mozversion INFO | platform_changeset: 06ab805e14b5e6d8a8a99c7846c8fde163a9e5d7 13:36:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 13:36:46 INFO - mozversion INFO | platform_version: 46.0a1 13:36:46 INFO - 2015-12-14 13:36:46,939 DEBUG : using testdate: 1450129006 13:36:46 INFO - 2015-12-14 13:36:46,939 DEBUG : actual date: 1450129006 13:36:46 INFO - 2015-12-14 13:36:46,987 INFO : starting webserver on 'localhost:37189' 13:36:46 INFO - 2015-12-14 13:36:46,988 INFO : Starting test suite talos-linux64-ix-061 13:36:46 INFO - 2015-12-14 13:36:46,988 INFO : Starting test dromaeo_css 13:36:46 INFO - 2015-12-14 13:36:46,989 DEBUG : operating with platform_type : linux_ 13:36:46 INFO - 2015-12-14 13:36:46,989 INFO : Initialising browser for dromaeo_css test... 13:36:47 INFO - 2015-12-14 13:36:47,006 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFHPtz/profile http://localhost:37189/getInfo.html 13:36:51 INFO - 2015-12-14 13:36:51,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:36:51 INFO - 2015-12-14 13:36:51,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:36:51 INFO - 2015-12-14 13:36:51,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:36:51 INFO - 2015-12-14 13:36:51,127 DEBUG : BROWSER_OUTPUT: __metrics 13:36:51 INFO - 2015-12-14 13:36:51,229 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] 13:36:51 INFO - 2015-12-14 13:36:51,285 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] 13:36:52 INFO - 2015-12-14 13:36:52,376 INFO : Browser initialized. 13:36:52 INFO - 2015-12-14 13:36:52,376 INFO : Running cycle 1/1 for dromaeo_css test... 13:36:52 INFO - 2015-12-14 13:36:52,377 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFHPtz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:37:04 INFO - 2015-12-14 13:37:04,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 142868480 13:37:04 INFO - 2015-12-14 13:37:04,396 DEBUG : BROWSER_OUTPUT: 13:37:55 INFO - 2015-12-14 13:37:55,774 DEBUG : BROWSER_OUTPUT: 1450129075771 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] 13:40:07 INFO - 2015-12-14 13:40:07,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37189/tests/dromaeo/cssquery-ext.html) 13:40:08 INFO - 2015-12-14 13:40:08,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 238047232 13:40:08 INFO - 2015-12-14 13:40:08,955 DEBUG : BROWSER_OUTPUT: 13:43:11 INFO - 2015-12-14 13:43:11,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-ext.html (next: http://localhost:37189/tests/dromaeo/cssquery-jquery.html) 13:43:12 INFO - 2015-12-14 13:43:12,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 218415104 13:43:12 INFO - 2015-12-14 13:43:12,043 DEBUG : BROWSER_OUTPUT: 13:46:14 INFO - 2015-12-14 13:46:14,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37189/tests/dromaeo/cssquery-mootools.html) 13:46:14 INFO - 2015-12-14 13:46:14,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 210350080 13:46:14 INFO - 2015-12-14 13:46:14,701 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-12-14 13:49:16,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37189/tests/dromaeo/cssquery-prototype.html) 13:49:17 INFO - 2015-12-14 13:49:17,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 204550144 13:49:17 INFO - 2015-12-14 13:49:17,231 DEBUG : BROWSER_OUTPUT: 13:52:20 INFO - 2015-12-14 13:52:20,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37189/tests/dromaeo/cssquery-yui.html) 13:52:20 INFO - 2015-12-14 13:52:20,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 207060992 13:52:20 INFO - 2015-12-14 13:52:20,647 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/dromaeo/cssquery-yui.html (next: http://localhost:37189/tests/dromaeo/cssquery-dojo.html) 13:55:23 INFO - 2015-12-14 13:55:23,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 244121600 13:55:23 INFO - 2015-12-14 13:55:23,387 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2632.2892818938885;2743.341598016477;2748.120601407549;2762.3922736997865;2763.4887545804017;4523.525029871866;4639.234526303165;4771.689840160388;4774.283857421388;4790.137775200467;4637.026224492861;4691.225947718623;4755.453122890868;4768.451628062774;4776.044791041788;4280.208161490119;4334.60988511034;4390.582894625006;4441.133978874121;4575.039241759235;4496.348029535716;4560.950981274309;4571.702839315451;4572.199865023607;4612.100640375112;4213.367994800774;4262.147570485915;4336.457942757155;4337.0458499130455;4397.516273209944;4402.339649052636;4430.224710675651;4433.490148632916;4436.068425630621;4471.038726673781;4403.405540252057;4415.183191109655;4424.269995450747;4449.599536041739;4456.799444024994;4495.820167193308;4551.249043907751;4603;4606.953930460686;4677.6491763117565;5131.897362052738;5141.974290128563;5148.2020286855595;5148.974255128738;5156.097682905476;5163.819266325698;5181.171012637998;5183.3261675981885;5214.296070030536;5234.18870075139;4607.884802879921;4634.21218392874;4719.834805781781;4728.598069164091;4819.614430845524;5264.105102132647;5275.103232450492;5280.894382112337;5284.101702710548;5287.07476191665;5064.949350506521;5066.873328166752;5067.5185857343495;5070.188769796815;5106.795728170831;4876.634252431082;4984.626153038536;4989.226669866177;4996.550310472002;5002.699838009658;5116.488351164928;5119.564836988823;5129;5139.922901156486;5150.742462876841;5084.610631639801;5089.4147173074825;5101.413337466165;5106.744662766847;5148.330717006766;4067.186562687474;4168.103857670615;4228.8308467660945;4314.590113939171;4347.586979236968;3660.7071434285726;3698.8705395311035;3722.8510859565313;3728.161163738137;3755.7746535207975;4381.605655491021;4394;4410.2282100632265;4450.46594408673;4458.420405347284;4829.154897892855;5083.339165908408;5095.235714642833;5102.591792656579;5111.667741596784;4336.739795612273;4394.802233899482;4406.449193850769;4409.955900440955;4433.6009759121835;4512.187806194851;4527.977360113178;4531.8413855515555;4535.727856328631;4575.107853968444;4824.49342819006;4840.854774356775;4844.878878028077;4846.975765121152;4881.8535443936025;4830.106430310404;4946.505349465025;4954.529319714621;4986.700797952134;5127.333446652061;4855.393075865517;4859.392575928009;4861.1979023460735;4863.10032643962;4903.705777653352;5057.216131499624;5058.291839142449;5062.873428164326;5065.037642847848;5066.518680725325;4784.210605250234;4946.431160416598;4955.45489996093;5022.824201152942;5158.742062896915;4972.925406118983;5012.8496145115705;5019.949800501949;5021.297018417352;5021.6735912165595;5007.47421520735;5010.273510341053;5010.498950105106;5013.498650134958;5036.521530454601;4633.907321853611;4747.976260118678;4749.097671442415;4753.83361582343;4956.752162391794;4890.413150421972;4937.259411088366;4994.750262486934;5062.797488100435;5069.847904562869;4802.471728109975;4815.855524334275;4819.831305904277;4821.46963833985;4854.611631069435 13:55:23 INFO - 2015-12-14 13:55:23,388 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.0254797734021;556.4713522153954;564.5201578658139;575.1688809670028;577.6822747488881;27211.5918261226;32819;33510.49734253982;33576.83211583945;33621.159471013205;40107.79946100265;40879.18241635166;40941.795291023576;41028.384574231335;41087;7063.187733410647;7167.677454514559;7871.370290376771;8037.27664510194;8039.196080391943;9959.05388988045;10131.240156988255;10250.384976901372;10251.231157663206;10259.640912568062;10072.848907266396;10176.287659863812;10195.694129176136;10195.694129176136;10195.745106372326;7311.488195826294;7505.924940750577;7518.135414427356;9896.554655040505;9985.90014099857;9803.558839852223;9945.651902183461;9959.55182016811;9959.701208963743;9962.352447090916;37260.44109338362;37629;37766.62233377686;37792.24415511674;37825.24349513022;3035.8026728262594;3130.5930229070304;3134.467140586106;3549.4675798630155;3684.889453316405;28496.287592810346;28882.711172888212;28894.71105288941;29039.85480072586;29152.030858861748;3302.5963965314645;3320.7177389921885;3322.551455553518;3392.016315268569;3430.9313813723834;208058;208890.95554522282;208985;209090;209357;50282.245766313536;52095.73952130215;54390.45609543933;54930.176047359324;55069.44930550643;53643.731781340844;53882;54122.45877541253;54265.72867135639;54446.45553544414;12495.000399967981;12632.873671263169;12644.114911956258;12666.683332916566;12709.93645031769;9610.279229057849;9710.854337184806;9715.562799674031;9720.31957762964;9721.270904682036;18816.15327310247;18963.715544266848;18973.43079707611;18976.335828245945;19027.809721902882;7453.180150183475;7754.689812407553;7772.421888658626;7776.766696999099;7828.882566761503;822.2722890242179;919.5264438814016;963.0946909904667;969.1568335547977;990.5047476261869;26585;26618.6007209892;26728;27086.45827083447;27094.5935810963;943.8301105801022;979.647326962293;984.4437892590663;1053.9736506587396;1087.994560027195;14052.22712750788;14061.611232524074;14077.507287244896;14185.645358866112;14310.785338219936;257017;258603;261231;261522;261623;32057.198570035936;45208.77395613001;45457.54542454533;45488.09023819505;45518.08963820771;1092.5848177692426;1208.4139192491634;1209.38925842449;1214.2410993129295;1215.1797536662718;24163.395915102265;25177.622335665346;26387.60418593684;26467.60298595561;26821.463570728865;30765.538516921817;31688.524672129475;31704.682953170173;36568;37050;235781;239670;243067;243406;243756;26548;26634.600480992412;26827;26881.193564193105;26969.303069692873;35924.28151437009;36285;36357.27285454329;37063.81468092642;37201.4419783698;31125;32157;33763.15592110217;35688.464673029404;37180.25639487249;32447.218561162375;33194.834025830685;33246.667533324355;33356.833215833765;33391.49912751359;32793.34413311768;33244.34579158871;33765.83117084399;33891.15272118217;34026.659733403336;25804.741952580232;27646.861765691043;27838.443231134857;27856.721432785413;27859.16422507328;22659.320220393416;23020.539589208456;23257.767422326237;23263.41841453977;23331.300060998197 13:55:23 INFO - 2015-12-14 13:55:23,389 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.60420100080916;335.82704906972907;336.26861576072065;336.6868812004836;338.6139800627285;12481.188722733015;12813;15329.69340613187;15484.60638542531;16629.417970371054;12993.1554448961;13215.405306761195;13249.801252981213;13262.336883155827;13579.932100339485;4855.417349918006;4882.121218180726;4991.051700176955;4994.775235114428;5052.115879721053;3702.592714801383;3834.5973672764376;5583.609147359686;5702;5740.827775166752;5658.207850900877;5670.829875103754;5684.118961560965;5694.117411801178;5710.943475457033;4801.207800712878;4970.726610036447;4972.105021096201;4973.179425394806;4973.502649735015;4646.652470783469;4776.164171270048;4789;4791.233402655558;4827.155247831651;11384.146189035773;11522.711932201762;11557;12751.744965100646;18478.630427391512;1829.2042961311738;1859.8698091133626;1887.5564242403025;1900.0119937632492;1913.9855876385539;9162.770930726785;9214.585343659552;10132.746681332952;11761.529538818522;13275.933620331836;1721.277063633277;1746.3102074680558;1787.9195436205403;1794.3091909614761;1804.6932021556368;52927.20609190865;54878.45121548773;56013.43986560123;56163;56475;9308.534573271309;9365.344425890122;9419.576119074658;9512.714618561455;9565.760855978517;11629.418529073682;11704.47329870158;11727.88272117285;11731.76536469266;11743.588974385855;6671.933280667228;6735.090762746966;6776.898346524806;6781.830454238683;6782.559133656297;6460.773872914426;6483.222013358427;6522.869542609121;6528.249251336062;6583.83540411484;4039.5960403959957;4156.314208155621;4252.702310838274;4260.8721738347895;4340.60934515895;1635.5338728462332;1691.3488307001646;1696.372342233357;1697.8556822670212;1705.3349193814422;797.8204903896577;867.1068799136899;913.55235934393;932.5849996751381;937.6858752317913;13237.867621323663;15316.387344506318;15373.231338433257;15398.615034624225;15982.200889955688;845.471580262336;857.322715055112;886.2599729226168;898.2095755734912;922.4142669404843;8809.33929955256;9006.279497640173;9135.132162444557;9262;9366.859497107549;518524;527034;528189;530062;541227;71335.64332178306;72302;74837;75017;75496.62251688706;1066.1257768629648;1072.1369297715414;1080.9675709728722;1084.2681190196743;1085.6851513061124;14290.928545357207;14471.421143154577;14719.55841324762;14762.261886905397;14950.92524537414;33891.32217355688;34076.31847363088;34173;35105.473417899266;35476;43646.781766090964;45663.54336456593;45683.77158114188;45765.31352029656;48993.2651010228;8766.386352955487;8788.824223515367;8965.282777377664;8980.416272942239;9379.296552758708;15267.541973740805;15674.059556426651;15761.842381576038;16043.438479653623;16049.197540123181;13162;13708;13788.310584470535;13870.65323366924;14413.567592972227;9485.059631514252;12653.557125500563;12888.39125044989;13583;13636.318184090558;12499.812502812283;13867.791983120464;14020.579382618538;14420.567382978528;14582.125072495684;8913.242374398249;8997.28021758271;9021.503817290111;9133.862992054992;9208.631654733736;12704.801378242446;13330.200187988752;13385.263810490516;13391.196528208338;13573.932130339681 13:55:23 INFO - 2015-12-14 13:55:23,390 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1220.9206401583901;1679.7816283883096;1708.658268346331;1724.0690027385212;1732.9653406931861;6310.716017779199;7251;7415.66629501673;7432.368248698867;7433.665485053172;7292.124945006607;7441.032665753444;7472.96263518683;7474.551526908389;7492.400607951365;1778.2353587957173;1821.5081927879464;2089.7074409582633;2117.6082424751394;2125.7767934366902;2047.3141497598322;2105.9473513162216;2106;2107.2413930984835;2108.061912448961;2063.298478517304;2078.667413213886;2086.1446806809213;2105.7788932162134;2109.789021097893;2085.780992995729;2096.863703859244;2117.1319758898776;2120.0777661717125;2122.628540005501;2061.793820617941;2078.9168433262653;2079.5009197792574;2081.8126368626745;2083.364573804989;7285.817854553626;7372.926270737331;7375.520591161558;7380.77857664271;7389.5935723535185;4038.7374820636564;4111.568285330027;4123.97938010308;4132.380142978547;4137.627613514768;2638.7625113739855;2695.43395886864;2708.079253053971;2718.592211168341;2743.3141714571357;838.7483754873514;878.9692360767342;884.2660591708866;885.3536918049796;899.3030401438937;9900.504974751233;9935.05616966387;9947.303688741718;9952.552135153936;9964.701058968243;3862.806859657062;3919.2161567686576;3931.0565464288366;3933.252681990413;3986.142979259473;8533.146685331541;8538;8539.658413663508;8543.273821725223;8548.358873084419;4187.099773548702;4190.245755763992;4200.033992181815;4204.579542045771;4219.092895027584;3798.563165235978;3814.9809250953567;3822.560405553397;3823.9808800956375;3827.9043023924623;2792.8603569821425;2812.4093940272364;2824.717528247159;3442.4147894857433;3527.4532447470683;946.6923249943795;1087.445402844555;1100.5707773968159;1103.7351035751522;1104.3539529375246;831.9001719793542;845.6997765793178;858.6007506509503;863.2317237658489;865.7316231967984;6626.4367528760595;6658.600483970978;6687.364700353459;6694.330566943267;6715.865682686319;1011.5549158370294;1025.6666583360438;1045.2004216774174;1051.7107795356185;1053.6364954090827;5241.580673546107;5370.892582148335;5372.167314066326;5378.139497680352;5388.245645609618;8419.494830310201;8705.303575713928;8726.171013753683;8736.432131911406;8781.69264075767;8666.913330866737;8721.912780872237;8736.213740763362;8739.650413983369;8779.12208779117;6802.557833740791;6812.523123381415;6856.6228857412325;6884.414824739853;6946.7221311148;6367.331430199948;6418.871622567429;6422.678866056772;6424.678766061585;6449.193850768654;7696.845473179068;7854.489458185429;7930.682772689259;7961.960190199244;7966.482178658369;7904;8136.511809291462;8157.428979971345;8166.83666326682;8203.548804815793;6444.45222156122;6492.156019717407;6522.5760325578685;6531.673416329259;6535.215774107138;5966.343702192668;6859.5541289816;6915.03189553473;6916;6943.027976083251;5775.133729940375;5863.17915491823;6357.872842543031;6454.967725161344;6511.576747511396;6273.3099359071375;6432.485401167989;6462.256840463407;6481.189851268591;6516.771912983023;6673.833154171185;6733.562318449285;6735.4611631070375;6737.056812046219;6737.562058466184;5854.502367298827;6051.394860513913;6100.511959043355;6203.782867599793;6261.65560894137;6068.4841788448475;6120.816375508563;6127.142200091902;6127.325994140552;6133 13:55:23 INFO - 2015-12-14 13:55:23,393 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.67008960233346;309.6531884289596;315.27644056889443;315.8247172819086;316.2773063549789;5314.78740850366;5420.186971954209;5425.864353391157;5428.022955867942;5430.837074887755;5371.140617501201;5374.435684253156;5377.274068000819;5383.084875571152;5391.676499410039;3952.584978577251;4041.1715598302276;4172.561881002496;4174.603412675799;4176.498820141587;4103.220388126261;4149.315362965107;4154.127633197032;4183.916321673565;4191.847242008442;4119.8970025749295;4125.051238215212;4126.649234815044;4128.339465685491;4135.379693046037;3904.902377440558;3990.04238982645;4023.7786921719294;4119.443875076856;4130.070734084837;3626.1841085755495;3630.4009838376637;3632.20091579852;3644.1071937375514;3644.398674218751;5091.363579552556;5103.362079740033;5120.950205207923;5128.333316668809;5137.280780690707;4738.099761045391;4764.833230836939;4767.237242041257;4770.713757174581;4775.068861571995;5512.944870551323;5623.662580245157;5640.802571910004;5643.238162848004;5646.463585959327;3975.7813320267373;3976.204759048202;3979.880603581897;3979.9403008954887;3987.302222111119;5946.108083787423;5949.613275137102;5950.494207992326;5958.821235362902;5963.344032156459;4083.2854250506043;4087.3664581989838;4088.4889388826396;4089.7526254492072;4090.365993271048;3973.9534139917964;4112.938305925413;4141.855035073758;4151.232022075926;4152.854650087293;4722.763861806896;4723.645726570521;4724.149653062413;4725.054989002213;4730;5662.546996240291;5666.773329066874;5666.943330566724;5672.716364181774;5675.914861277084;1428.171660436944;1451.2380999974887;1453.4767483705857;1456.7232225877049;1457.2859298943654;969.340848223215;969.7817990951979;981.3523074770617;986.7187851462443;1004.4224570871778;5008.373953255843;5009.774560144802;5017.8243761468175;5021.899562008739;5022.070916880316;5876.7649294028615;5896.056630939115;5899.233099697098;5905.261842269716;5906.5570082244;4998.125328067574;5023.0456213320085;5030.823921162815;5031.371078615173;5038.697678139323;2922.1817890990555;3006.7143621355935;3136.106209730216;3148.795328303653;3185.61772587291;5549.1676248562235;5554.2779438672715;5623;5626.1842032905815;5632.324121105494;6032.909506357408;6101.8474538136015;6105.297890742532;6109.938900611026;6115.082737589397;5610.046292130348;5613.298337707786;5618.157276408571;5618.522425593788;5620.1288800236025;5728.3985181557;5892.381299963614;5894.941050589439;5958.553108516965;5968.134620480093;5820.417958204146;5820.912686309624;5825.79609713658;5827.3007239131575;5829.09649004405;5602.635828671123;5610.13042978339;5611.410801865909;5612.074007788669;5612.7754889803955;3903.316919539126;4023.7786921719585;4052.63526282636;4053.4122552229173;4059.5737447568763;5797.594168408171;5799.623024503394;5838;5896.410358964069;5901.380355062656;5688.687122208153;5689;5689.601727879174;5689.857753556029;5692.971535142464;5681.659100453986;5684.891446167958;5686.118651609007;5686.943130568807;5689.402612725769;5408.486193811582;5570.164475328733;5575.581831362583;5576.721163941867;5579.721013949205;5711.942880571141;5720.056190728649;5721.25623668937;5731.914021289767;5733.0540460823495;5350.7324633767375;5456.781728730806;5520;5558.44415558441;5565.916511252415 13:55:23 INFO - 2015-12-14 13:55:23,393 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.4038845815681;715.3857618361568;768.3776141325525;768.5427170833352;775.523053322207;11155.832662510058;14135.787963180548;14564.927175364135;14659.486917957873;14665.999999999987;12769.553065642704;12796.552120675778;12866.421011054501;12888.74222515549;12911.354432278373;428.3852671416512;432.96536277097755;799.2127754162132;817.8037271054934;818.3535007344191;798.2735710503443;815.9061707903608;816.8978877640295;817.3502065857657;818.0020375142317;848.7241646464893;864.5590748718137;867.4621734524603;867.6052396159764;868.0148031983681;453.39698201392235;461.19751632160137;836.6235194162651;853.8591132463137;855.8373908957278;630.9684515774193;631.7441436218339;632.1150389454754;632.3897438971369;633.2875515045574;11909.82135267963;12527.874721252761;12535.686607834787;12540.937295313464;12547.184433011917;10582.682519524427;10910.563577456971;11119.666410007712;11176.329420234812;11277.887221127765;8863.645454181826;9025.368224224307;9090.727278181665;9115;9575.712728618153;3184.570083038783;3228.370467758788;3256.5766450361302;3266.7059964603063;3277.393682168806;39700;39937;40273.395899061245;40689.38965915514;40847.59152408497;9109.362344635812;9112.49881256524;9163.81672366549;9164.816703665889;9165.495897725556;16204.594885127966;16227.756583651255;16237.756433653505;16238.837611623969;16265.349386024427;6264;6457.063725759738;6462.32145624712;6632.1709786276715;6662.900056499157;3513.9121521962156;3556.91107722309;3568.6431356864623;3578.320119177348;3600.42393217084;2689.825161364505;2740.082072505693;2740.8629568521496;2742.780577553791;2742.9725702742717;504.2914704839706;535.2105644174811;536.3054843976981;540.8972295263887;551.3714365623193;550.931133608299;606.9635821850703;608.14251904814;625.8372823065945;628.0328294426623;7538.773836784905;7996.28544182775;8221.54781487012;8371.58142092893;8940.597673104727;431.77979230592626;472.2538389344827;505.72943475241306;538.4561592791231;558.3662543013709;3610.1696609779897;3731.962680373216;3746.868859589901;3841.5774264830848;3972.145988612462;46396.30405543919;47197.29204061873;47374;47377.76311118422;47515.28727069097;42162.15675686469;43621.781891090344;43797.90505237394;44562.33156502655;44841.77579112084;37681.24637507235;39651;39687.40468892969;40506.79746601248;41582.1683566327;7938.404619653434;8104.756857294291;8185.836283274421;8436.915630843612;8464.301192035866;30001;30030.849845750632;30875;31234;31313;39447.408288875115;39523.604763953146;39684.801575991936;40442;40649.1870162601;9842.704718858446;9936.552855121392;10151.746206344606;10328.948355258175;10349.379037257788;11061.391623460788;11242.887571124511;11504.654860354203;11753.236039657737;11840.171188016757;10836.349819010884;11097.833532497181;11155;11181.944090279496;11343.149263805082;9594.280428967995;9733.951330243304;9756.80486390254;9812.460314682476;9943.25425593069;8504.787380315542;10192.490375481344;10199.439030853078;10303.278770486293;10798.514066867167;8998.280137588847;9132.22376098039;9159.908400916172;9190.264778817813;9485.964491362698;8935.28517718568;8966.730998070068;9090.863637045317;9262.120098590623;9427.198688111588 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,936 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: __startTimestamp1450130123380__endTimestamp 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,394 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4701.51 Median:4819.83 stddev:490.64 (10.2%) stddev-sans-first:464.52 13:55:23 INFO - 2015-12-14 13:55:23,395 DEBUG : BROWSER_OUTPUT: Values: 2632.3 2743.3 2748.1 2762.4 2763.5 4523.5 4639.2 4771.7 4774.3 4790.1 4637.0 4691.2 4755.5 4768.5 4776.0 4280.2 4334.6 4390.6 4441.1 4575.0 4496.3 4561.0 4571.7 4572.2 4612.1 4213.4 4262.1 4336.5 4337.0 4397.5 4402.3 4430.2 4433.5 4436.1 4471.0 4403.4 4415.2 4424.3 4449.6 4456.8 4495.8 4551.2 4603.0 4607.0 4677.6 5131.9 5142.0 5148.2 5149.0 5156.1 5163.8 5181.2 5183.3 5214.3 5234.2 4607.9 4634.2 4719.8 4728.6 4819.6 5264.1 5275.1 5280.9 5284.1 5287.1 5064.9 5066.9 5067.5 5070.2 5106.8 4876.6 4984.6 4989.2 4996.6 5002.7 5116.5 5119.6 5129.0 5139.9 5150.7 5084.6 5089.4 5101.4 5106.7 5148.3 4067.2 4168.1 4228.8 4314.6 4347.6 3660.7 3698.9 3722.9 3728.2 3755.8 4381.6 4394.0 4410.2 4450.5 4458.4 4829.2 5083.3 5095.2 5102.6 5111.7 4336.7 4394.8 4406.4 4410.0 4433.6 4512.2 4528.0 4531.8 4535.7 4575.1 4824.5 4840.9 4844.9 4847.0 4881.9 4830.1 4946.5 4954.5 4986.7 5127.3 4855.4 4859.4 4861.2 4863.1 4903.7 5057.2 5058.3 5062.9 5065.0 5066.5 4784.2 4946.4 4955.5 5022.8 5158.7 4972.9 5012.8 5019.9 5021.3 5021.7 5007.5 5010.3 5010.5 5013.5 5036.5 4633.9 4748.0 4749.1 4753.8 4956.8 4890.4 4937.3 4994.8 5062.8 5069.8 4802.5 4815.9 4819.8 4821.5 4854.6 13:55:23 INFO - 2015-12-14 13:55:23,396 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,396 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39450.01 Median:18257.78 stddev:61754.06 (338.2%) stddev-sans-first:61858.22 13:55:23 INFO - 2015-12-14 13:55:23,396 DEBUG : BROWSER_OUTPUT: Values: 549.0 556.5 564.5 575.2 577.7 27211.6 32819.0 33510.5 33576.8 33621.2 40107.8 40879.2 40941.8 41028.4 41087.0 7063.2 7167.7 7871.4 8037.3 8039.2 9959.1 10131.2 10250.4 10251.2 10259.6 10072.8 10176.3 10195.7 10195.7 10195.7 7311.5 7505.9 7518.1 9896.6 9985.9 9803.6 9945.7 9959.6 9959.7 9962.4 37260.4 37629.0 37766.6 37792.2 37825.2 3035.8 3130.6 3134.5 3549.5 3684.9 28496.3 28882.7 28894.7 29039.9 29152.0 3302.6 3320.7 3322.6 3392.0 3430.9 208058.0 208891.0 208985.0 209090.0 209357.0 50282.2 52095.7 54390.5 54930.2 55069.4 53643.7 53882.0 54122.5 54265.7 54446.5 12495.0 12632.9 12644.1 12666.7 12709.9 9610.3 9710.9 9715.6 9720.3 9721.3 18816.2 18963.7 18973.4 18976.3 19027.8 7453.2 7754.7 7772.4 7776.8 7828.9 822.3 919.5 963.1 969.2 990.5 26585.0 26618.6 26728.0 27086.5 27094.6 943.8 979.6 984.4 1054.0 1088.0 14052.2 14061.6 14077.5 14185.6 14310.8 257017.0 258603.0 261231.0 261522.0 261623.0 32057.2 45208.8 45457.5 45488.1 45518.1 1092.6 1208.4 1209.4 1214.2 1215.2 24163.4 25177.6 26387.6 26467.6 26821.5 30765.5 31688.5 31704.7 36568.0 37050.0 235781.0 239670.0 243067.0 243406.0 243756.0 26548.0 26634.6 26827.0 26881.2 26969.3 35924.3 36285.0 36357.3 37063.8 37201.4 31125.0 32157.0 33763.2 35688.5 37180.3 32447.2 33194.8 33246.7 33356.8 33391.5 32793.3 33244.3 33765.8 33891.2 34026.7 25804.7 27646.9 27838.4 27856.7 27859.2 22659.3 23020.5 23257.8 23263.4 23331.3 13:55:23 INFO - 2015-12-14 13:55:23,396 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,396 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27462.22 Median:4204.51 stddev:86421.90 (2055.5%) stddev-sans-first:86640.33 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: Values: 332.6 335.8 336.3 336.7 338.6 12481.2 12813.0 15329.7 15484.6 16629.4 12993.2 13215.4 13249.8 13262.3 13579.9 4855.4 4882.1 4991.1 4994.8 5052.1 3702.6 3834.6 5583.6 5702.0 5740.8 5658.2 5670.8 5684.1 5694.1 5710.9 4801.2 4970.7 4972.1 4973.2 4973.5 4646.7 4776.2 4789.0 4791.2 4827.2 11384.1 11522.7 11557.0 12751.7 18478.6 1829.2 1859.9 1887.6 1900.0 1914.0 9162.8 9214.6 10132.7 11761.5 13275.9 1721.3 1746.3 1787.9 1794.3 1804.7 52927.2 54878.5 56013.4 56163.0 56475.0 9308.5 9365.3 9419.6 9512.7 9565.8 11629.4 11704.5 11727.9 11731.8 11743.6 6671.9 6735.1 6776.9 6781.8 6782.6 6460.8 6483.2 6522.9 6528.2 6583.8 4039.6 4156.3 4252.7 4260.9 4340.6 1635.5 1691.3 1696.4 1697.9 1705.3 797.8 867.1 913.6 932.6 937.7 13237.9 15316.4 15373.2 15398.6 15982.2 845.5 857.3 886.3 898.2 922.4 8809.3 9006.3 9135.1 9262.0 9366.9 518524.0 527034.0 528189.0 530062.0 541227.0 71335.6 72302.0 74837.0 75017.0 75496.6 1066.1 1072.1 1081.0 1084.3 1085.7 14290.9 14471.4 14719.6 14762.3 14950.9 33891.3 34076.3 34173.0 35105.5 35476.0 43646.8 45663.5 45683.8 45765.3 48993.3 8766.4 8788.8 8965.3 8980.4 9379.3 15267.5 15674.1 15761.8 16043.4 16049.2 13162.0 13708.0 13788.3 13870.7 14413.6 9485.1 12653.6 12888.4 13583.0 13636.3 12499.8 13867.8 14020.6 14420.6 14582.1 8913.2 8997.3 9021.5 9133.9 9208.6 12704.8 13330.2 13385.3 13391.2 13573.9 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5043.63 Median:6393.10 stddev:2665.54 (41.7%) stddev-sans-first:2657.53 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: Values: 1220.9 1679.8 1708.7 1724.1 1733.0 6310.7 7251.0 7415.7 7432.4 7433.7 7292.1 7441.0 7473.0 7474.6 7492.4 1778.2 1821.5 2089.7 2117.6 2125.8 2047.3 2105.9 2106.0 2107.2 2108.1 2063.3 2078.7 2086.1 2105.8 2109.8 2085.8 2096.9 2117.1 2120.1 2122.6 2061.8 2078.9 2079.5 2081.8 2083.4 7285.8 7372.9 7375.5 7380.8 7389.6 4038.7 4111.6 4124.0 4132.4 4137.6 2638.8 2695.4 2708.1 2718.6 2743.3 838.7 879.0 884.3 885.4 899.3 9900.5 9935.1 9947.3 9952.6 9964.7 3862.8 3919.2 3931.1 3933.3 3986.1 8533.1 8538.0 8539.7 8543.3 8548.4 4187.1 4190.2 4200.0 4204.6 4219.1 3798.6 3815.0 3822.6 3824.0 3827.9 2792.9 2812.4 2824.7 3442.4 3527.5 946.7 1087.4 1100.6 1103.7 1104.4 831.9 845.7 858.6 863.2 865.7 6626.4 6658.6 6687.4 6694.3 6715.9 1011.6 1025.7 1045.2 1051.7 1053.6 5241.6 5370.9 5372.2 5378.1 5388.2 8419.5 8705.3 8726.2 8736.4 8781.7 8666.9 8721.9 8736.2 8739.7 8779.1 6802.6 6812.5 6856.6 6884.4 6946.7 6367.3 6418.9 6422.7 6424.7 6449.2 7696.8 7854.5 7930.7 7962.0 7966.5 7904.0 8136.5 8157.4 8166.8 8203.5 6444.5 6492.2 6522.6 6531.7 6535.2 5966.3 6859.6 6915.0 6916.0 6943.0 5775.1 5863.2 6357.9 6455.0 6511.6 6273.3 6432.5 6462.3 6481.2 6516.8 6673.8 6733.6 6735.5 6737.1 6737.6 5854.5 6051.4 6100.5 6203.8 6261.7 6068.5 6120.8 6127.1 6127.3 6133.0 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,397 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4701.15 Median:5380.18 stddev:1392.84 (25.9%) stddev-sans-first:1357.06 13:55:23 INFO - 2015-12-14 13:55:23,398 DEBUG : BROWSER_OUTPUT: Values: 302.7 309.7 315.3 315.8 316.3 5314.8 5420.2 5425.9 5428.0 5430.8 5371.1 5374.4 5377.3 5383.1 5391.7 3952.6 4041.2 4172.6 4174.6 4176.5 4103.2 4149.3 4154.1 4183.9 4191.8 4119.9 4125.1 4126.6 4128.3 4135.4 3904.9 3990.0 4023.8 4119.4 4130.1 3626.2 3630.4 3632.2 3644.1 3644.4 5091.4 5103.4 5121.0 5128.3 5137.3 4738.1 4764.8 4767.2 4770.7 4775.1 5512.9 5623.7 5640.8 5643.2 5646.5 3975.8 3976.2 3979.9 3979.9 3987.3 5946.1 5949.6 5950.5 5958.8 5963.3 4083.3 4087.4 4088.5 4089.8 4090.4 3974.0 4112.9 4141.9 4151.2 4152.9 4722.8 4723.6 4724.1 4725.1 4730.0 5662.5 5666.8 5666.9 5672.7 5675.9 1428.2 1451.2 1453.5 1456.7 1457.3 969.3 969.8 981.4 986.7 1004.4 5008.4 5009.8 5017.8 5021.9 5022.1 5876.8 5896.1 5899.2 5905.3 5906.6 4998.1 5023.0 5030.8 5031.4 5038.7 2922.2 3006.7 3136.1 3148.8 3185.6 5549.2 5554.3 5623.0 5626.2 5632.3 6032.9 6101.8 6105.3 6109.9 6115.1 5610.0 5613.3 5618.2 5618.5 5620.1 5728.4 5892.4 5894.9 5958.6 5968.1 5820.4 5820.9 5825.8 5827.3 5829.1 5602.6 5610.1 5611.4 5612.1 5612.8 3903.3 4023.8 4052.6 4053.4 4059.6 5797.6 5799.6 5838.0 5896.4 5901.4 5688.7 5689.0 5689.6 5689.9 5693.0 5681.7 5684.9 5686.1 5686.9 5689.4 5408.5 5570.2 5575.6 5576.7 5579.7 5711.9 5720.1 5721.3 5731.9 5733.1 5350.7 5456.8 5520.0 5558.4 5565.9 13:55:23 INFO - 2015-12-14 13:55:23,398 DEBUG : BROWSER_OUTPUT: 13:55:23 INFO - 2015-12-14 13:55:23,399 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12207.17 Median:457.30 stddev:13518.75 (2956.2%) stddev-sans-first:13528.95 13:55:23 INFO - 2015-12-14 13:55:23,399 DEBUG : BROWSER_OUTPUT: Values: 677.4 715.4 768.4 768.5 775.5 11155.8 14135.8 14564.9 14659.5 14666.0 12769.6 12796.6 12866.4 12888.7 12911.4 428.4 433.0 799.2 817.8 818.4 798.3 815.9 816.9 817.4 818.0 848.7 864.6 867.5 867.6 868.0 453.4 461.2 836.6 853.9 855.8 631.0 631.7 632.1 632.4 633.3 11909.8 12527.9 12535.7 12540.9 12547.2 10582.7 10910.6 11119.7 11176.3 11277.9 8863.6 9025.4 9090.7 9115.0 9575.7 3184.6 3228.4 3256.6 3266.7 3277.4 39700.0 39937.0 40273.4 40689.4 40847.6 9109.4 9112.5 9163.8 9164.8 9165.5 16204.6 16227.8 16237.8 16238.8 16265.3 6264.0 6457.1 6462.3 6632.2 6662.9 3513.9 3556.9 3568.6 3578.3 3600.4 2689.8 2740.1 2740.9 2742.8 2743.0 504.3 535.2 536.3 540.9 551.4 550.9 607.0 608.1 625.8 628.0 7538.8 7996.3 8221.5 8371.6 8940.6 431.8 472.3 505.7 538.5 558.4 3610.2 3732.0 3746.9 3841.6 3972.1 46396.3 47197.3 47374.0 47377.8 47515.3 42162.2 43621.8 43797.9 44562.3 44841.8 37681.2 39651.0 39687.4 40506.8 41582.2 7938.4 8104.8 8185.8 8436.9 8464.3 30001.0 30030.8 30875.0 31234.0 31313.0 39447.4 39523.6 39684.8 40442.0 40649.2 9842.7 9936.6 10151.7 10328.9 10349.4 11061.4 11242.9 11504.7 11753.2 11840.2 10836.3 11097.8 11155.0 11181.9 11343.1 9594.3 9734.0 9756.8 9812.5 9943.3 8504.8 10192.5 10199.4 10303.3 10798.5 8998.3 9132.2 9159.9 9190.3 9486.0 8935.3 8966.7 9090.9 9262.1 9427.2 13:55:23 INFO - 2015-12-14 13:55:23,399 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:55:23 INFO - 2015-12-14 13:55:23,399 DEBUG : BROWSER_OUTPUT: 13:55:24 INFO - 2015-12-14 13:55:24,133 INFO : Browser exited with error code: 0 13:55:24 INFO - 2015-12-14 13:55:24,154 INFO : Completed test dromaeo_css (00:18:37) 13:55:24 INFO - 2015-12-14 13:55:24,155 INFO : Starting test kraken 13:55:24 INFO - 2015-12-14 13:55:24,155 DEBUG : operating with platform_type : linux_ 13:55:24 INFO - 2015-12-14 13:55:24,155 INFO : Initialising browser for kraken test... 13:55:24 INFO - 2015-12-14 13:55:24,161 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuGdLts/profile http://localhost:37189/getInfo.html 13:55:28 INFO - 2015-12-14 13:55:28,377 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:55:28 INFO - 2015-12-14 13:55:28,377 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:55:28 INFO - 2015-12-14 13:55:28,377 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:55:28 INFO - 2015-12-14 13:55:28,378 DEBUG : BROWSER_OUTPUT: __metrics 13:55:28 INFO - 2015-12-14 13:55:28,434 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] 13:55:28 INFO - 2015-12-14 13:55:28,510 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] 13:55:28 ERROR - 2015-12-14 13:55:28,517 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 13:55:29 INFO - 2015-12-14 13:55:29,430 INFO : Browser initialized. 13:55:29 INFO - 2015-12-14 13:55:29,430 INFO : Running cycle 1/1 for kraken test... 13:55:29 INFO - 2015-12-14 13:55:29,430 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuGdLts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:55:41 INFO - 2015-12-14 13:55:41,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 13:55:41 INFO - 2015-12-14 13:55:41,387 DEBUG : BROWSER_OUTPUT: 13:55:43 INFO - 2015-12-14 13:55:43,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37189/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:44 INFO - 2015-12-14 13:55:44,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 177913856 13:55:44 INFO - 2015-12-14 13:55:44,589 DEBUG : BROWSER_OUTPUT: 13:55:47 INFO - 2015-12-14 13:55:47,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37189/tests/kraken/driver.html?testName=audio-dft) 13:55:47 INFO - 2015-12-14 13:55:47,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 166899712 13:55:47 INFO - 2015-12-14 13:55:47,872 DEBUG : BROWSER_OUTPUT: 13:55:50 INFO - 2015-12-14 13:55:50,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37189/tests/kraken/driver.html?testName=audio-fft) 13:55:51 INFO - 2015-12-14 13:55:51,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 153595904 13:55:51 INFO - 2015-12-14 13:55:51,454 DEBUG : BROWSER_OUTPUT: 13:55:53 INFO - 2015-12-14 13:55:53,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37189/tests/kraken/driver.html?testName=audio-oscillator) 13:55:54 INFO - 2015-12-14 13:55:54,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 156528640 13:55:54 INFO - 2015-12-14 13:55:54,067 DEBUG : BROWSER_OUTPUT: 13:55:56 INFO - 2015-12-14 13:55:56,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:56 INFO - 2015-12-14 13:55:56,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 158171136 13:55:56 INFO - 2015-12-14 13:55:56,902 DEBUG : BROWSER_OUTPUT: 13:55:59 INFO - 2015-12-14 13:55:59,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37189/tests/kraken/driver.html?testName=imaging-darkroom) 13:56:00 INFO - 2015-12-14 13:56:00,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 158269440 13:56:00 INFO - 2015-12-14 13:56:00,454 DEBUG : BROWSER_OUTPUT: 13:56:03 INFO - 2015-12-14 13:56:03,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37189/tests/kraken/driver.html?testName=imaging-desaturate) 13:56:04 INFO - 2015-12-14 13:56:04,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 157712384 13:56:04 INFO - 2015-12-14 13:56:04,435 DEBUG : BROWSER_OUTPUT: 13:56:07 INFO - 2015-12-14 13:56:07,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37189/tests/kraken/driver.html?testName=json-parse-financial) 13:56:07 INFO - 2015-12-14 13:56:07,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 158253056 13:56:07 INFO - 2015-12-14 13:56:07,880 DEBUG : BROWSER_OUTPUT: 13:56:09 INFO - 2015-12-14 13:56:09,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:56:10 INFO - 2015-12-14 13:56:10,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 169246720 13:56:10 INFO - 2015-12-14 13:56:10,230 DEBUG : BROWSER_OUTPUT: 13:56:12 INFO - 2015-12-14 13:56:12,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:56:12 INFO - 2015-12-14 13:56:12,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 168636416 13:56:12 INFO - 2015-12-14 13:56:12,727 DEBUG : BROWSER_OUTPUT: 13:56:14 INFO - 2015-12-14 13:56:14,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:56:15 INFO - 2015-12-14 13:56:15,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 181538816 13:56:15 INFO - 2015-12-14 13:56:15,425 DEBUG : BROWSER_OUTPUT: 13:56:17 INFO - 2015-12-14 13:56:17,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:56:18 INFO - 2015-12-14 13:56:18,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 188989440 13:56:18 INFO - 2015-12-14 13:56:18,540 DEBUG : BROWSER_OUTPUT: 13:56:21 INFO - 2015-12-14 13:56:21,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:21 INFO - 2015-12-14 13:56:21,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 185655296 13:56:21 INFO - 2015-12-14 13:56:21,741 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37189/tests/kraken/driver.html?testName=ai-astar) 13:56:23 INFO - 2015-12-14 13:56:23,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 244797440 13:56:23 INFO - 2015-12-14 13:56:23,766 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,767 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:56:23 INFO - 2015-12-14 13:56:23,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:56:23 INFO - 2015-12-14 13:56:23,767 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:56:23 INFO - 2015-12-14 13:56:23,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:56:23 INFO - 2015-12-14 13:56:23,768 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;104;111;112;111;102;113;111;113 13:56:23 INFO - 2015-12-14 13:56:23,768 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;130;154;175;130;155;153;137;164;131 13:56:23 INFO - 2015-12-14 13:56:23,768 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;161;160;160;162;163;163;162 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;81;91;73;74;72;101;99;73 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;132;93;95;94;135;95;95;131 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;109;109;109;111 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;150;146;146;146 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;96;96;95;96;96;96 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;72;72;73;72;71;80;70;69 13:56:23 INFO - 2015-12-14 13:56:23,769 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;68;68;69;68;68;68;67 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;83;84;83;85;86;83;83 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;123;116;120;129;128;129;124;120 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;147;153;146;153;140;159;150;143;137 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;68;70;70;69;70;69;68;69;68 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 13:56:23 INFO - 2015-12-14 13:56:23,770 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:56:23 INFO - 2015-12-14 13:56:23,771 DEBUG : BROWSER_OUTPUT: __startTimestamp1450130183766__endTimestamp 13:56:23 INFO - 2015-12-14 13:56:23,771 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:56:23 INFO - 2015-12-14 13:56:23,778 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:56:23 INFO - 2015-12-14 13:56:23,778 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,778 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.78 (3.4%) stddev-sans-first:4.01 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 104.0 111.0 112.0 111.0 102.0 113.0 111.0 113.0 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.50 stddev:15.55 (10.1%) stddev-sans-first:16.40 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: Values: 153.0 130.0 154.0 175.0 130.0 155.0 153.0 137.0 164.0 131.0 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 161.0 160.0 160.0 162.0 163.0 163.0 162.0 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:11.76 (16.0%) stddev-sans-first:11.93 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 81.0 91.0 73.0 74.0 72.0 101.0 99.0 73.0 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,779 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.58 (19.8%) stddev-sans-first:19.21 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 132.0 93.0 95.0 94.0 135.0 95.0 95.0 131.0 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 111.0 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 150.0 146.0 146.0 146.0 13:56:23 INFO - 2015-12-14 13:56:23,780 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.50 stddev:2.95 (4.1%) stddev-sans-first:3.13 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 72.0 73.0 72.0 71.0 80.0 70.0 69.0 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 67.0 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:1.42 (1.7%) stddev-sans-first:1.24 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 83.0 84.0 83.0 85.0 86.0 83.0 83.0 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.50 stddev:4.27 (3.5%) stddev-sans-first:4.53 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 123.0 116.0 120.0 129.0 128.0 129.0 124.0 120.0 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,781 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.50 stddev:7.67 (5.2%) stddev-sans-first:6.97 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: Values: 135.0 147.0 153.0 146.0 153.0 140.0 159.0 150.0 143.0 137.0 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 70.0 70.0 69.0 70.0 69.0 68.0 69.0 68.0 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:56:23 INFO - 2015-12-14 13:56:23,782 DEBUG : BROWSER_OUTPUT: 13:56:24 INFO - 2015-12-14 13:56:24,621 INFO : Browser exited with error code: 0 13:56:24 INFO - 2015-12-14 13:56:24,670 INFO : Completed test kraken (00:01:00) 13:56:24 INFO - 2015-12-14 13:56:24,670 INFO : Starting test v8_7 13:56:24 INFO - 2015-12-14 13:56:24,670 DEBUG : operating with platform_type : linux_ 13:56:24 INFO - 2015-12-14 13:56:24,670 INFO : Initialising browser for v8_7 test... 13:56:24 INFO - 2015-12-14 13:56:24,676 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphO8tDo/profile http://localhost:37189/getInfo.html 13:56:28 INFO - 2015-12-14 13:56:28,659 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:56:28 INFO - 2015-12-14 13:56:28,659 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:56:28 INFO - 2015-12-14 13:56:28,659 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:56:28 INFO - 2015-12-14 13:56:28,660 DEBUG : BROWSER_OUTPUT: __metrics 13:56:28 INFO - 2015-12-14 13:56:28,801 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] 13:56:28 INFO - 2015-12-14 13:56:28,861 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] 13:56:29 INFO - 2015-12-14 13:56:29,945 INFO : Browser initialized. 13:56:29 INFO - 2015-12-14 13:56:29,946 INFO : Running cycle 1/1 for v8_7 test... 13:56:29 INFO - 2015-12-14 13:56:29,946 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphO8tDo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:56:41 INFO - 2015-12-14 13:56:41,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 143409152 13:56:41 INFO - 2015-12-14 13:56:41,958 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37189/tests/v8_7/run.html (next: http://localhost:37189/tests/v8_7/run.html) 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 443936768 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |0;Richards;168.9189189189189 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.56716417910448 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 13:57:03 INFO - 2015-12-14 13:57:03,595 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: |7;RegExp;27270.27027027027 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: |8;Splay;605.6935190793458 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: __startTimestamp1450130223589__endTimestamp 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,596 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.92 Median:168.92 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: Values: 168.9 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.57 Median:186.57 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: Values: 186.6 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: Values: 279.9 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,597 DEBUG : BROWSER_OUTPUT: Values: 5207.3 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: Values: 1978.3 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: Values: 791.8 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: Values: 12512.5 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27270.27 Median:27270.27 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: Values: 27270.3 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.69 Median:605.69 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: Values: 605.7 13:57:03 INFO - 2015-12-14 13:57:03,598 DEBUG : BROWSER_OUTPUT: 13:57:03 INFO - 2015-12-14 13:57:03,599 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 13:57:03 INFO - 2015-12-14 13:57:03,599 DEBUG : BROWSER_OUTPUT: Values: 4854.4 13:57:03 INFO - 2015-12-14 13:57:03,599 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:57:03 INFO - 2015-12-14 13:57:03,599 DEBUG : BROWSER_OUTPUT: 13:57:04 INFO - 2015-12-14 13:57:04,501 INFO : Browser exited with error code: 0 13:57:04 INFO - 2015-12-14 13:57:04,520 INFO : Completed test v8_7 (00:00:39) 13:57:04 INFO - 2015-12-14 13:57:04,640 INFO : Completed test suite (00:20:17) 13:57:04 INFO - 2015-12-14 13:57:04,640 DEBUG : Working with test: dromaeo_css 13:57:04 INFO - 2015-12-14 13:57:04,640 DEBUG : Generating results file: dromaeo_css 13:57:04 INFO - 2015-12-14 13:57:04,641 DEBUG : Working with test: kraken 13:57:04 INFO - 2015-12-14 13:57:04,641 DEBUG : Generating results file: kraken 13:57:04 INFO - 2015-12-14 13:57:04,642 INFO : javascript benchmark 13:57:04 INFO - 2015-12-14 13:57:04,642 DEBUG : Working with test: v8_7 13:57:04 INFO - 2015-12-14 13:57:04,642 DEBUG : Generating results file: v8_7 13:57:04 INFO - 2015-12-14 13:57:04,642 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:57:04 INFO - 2015-12-14 13:57:04,700 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 13:57:04 INFO - 2015-12-14 13:57:04,701 DEBUG : process_Request line: dromaeo_css 6334.00 graph.html#tests=[[72,94,35]] 13:57:04 INFO - 2015-12-14 13:57:04,701 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:57:04 INFO - 2015-12-14 13:57:04,734 DEBUG : process_Request line: kraken 1520.10 graph.html#tests=[[232,94,35]] 13:57:04 INFO - 2015-12-14 13:57:04,734 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:57:04 INFO - 2015-12-14 13:57:04,769 DEBUG : process_Request line: v8_7 19661.87 graph.html#tests=[[230,94,35]] 13:57:04 INFO - 2015-12-14 13:57:04,771 INFO : javascript benchmark 13:57:04 INFO - 2015-12-14 13:57:04,775 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.2892818938885, 2743.341598016477, 2748.120601407549, 2762.3922736997865, 2763.4887545804017, 4523.525029871866, 4639.234526303165, 4771.689840160388, 4774.283857421388, 4790.137775200467, 4637.026224492861, 4691.225947718623, 4755.453122890868, 4768.451628062774, 4776.044791041788, 4280.208161490119, 4334.60988511034, 4390.582894625006, 4441.133978874121, 4575.039241759235, 4496.348029535716, 4560.950981274309, 4571.702839315451, 4572.199865023607, 4612.100640375112, 4213.367994800774, 4262.147570485915, 4336.457942757155, 4337.0458499130455, 4397.516273209944, 4402.339649052636, 4430.224710675651, 4433.490148632916, 4436.068425630621, 4471.038726673781, 4403.405540252057, 4415.183191109655, 4424.269995450747, 4449.599536041739, 4456.799444024994, 4495.820167193308, 4551.249043907751, 4603.0, 4606.953930460686, 4677.6491763117565, 5131.897362052738, 5141.974290128563, 5148.2020286855595, 5148.974255128738, 5156.097682905476, 5163.819266325698, 5181.171012637998, 5183.3261675981885, 5214.296070030536, 5234.18870075139, 4607.884802879921, 4634.21218392874, 4719.834805781781, 4728.598069164091, 4819.614430845524, 5264.105102132647, 5275.103232450492, 5280.894382112337, 5284.101702710548, 5287.07476191665, 5064.949350506521, 5066.873328166752, 5067.5185857343495, 5070.188769796815, 5106.795728170831, 4876.634252431082, 4984.626153038536, 4989.226669866177, 4996.550310472002, 5002.699838009658, 5116.488351164928, 5119.564836988823, 5129.0, 5139.922901156486, 5150.742462876841, 5084.610631639801, 5089.4147173074825, 5101.413337466165, 5106.744662766847, 5148.330717006766, 4067.186562687474, 4168.103857670615, 4228.8308467660945, 4314.590113939171, 4347.586979236968, 3660.7071434285726, 3698.8705395311035, 3722.8510859565313, 3728.161163738137, 3755.7746535207975, 4381.605655491021, 4394.0, 4410.2282100632265, 4450.46594408673, 4458.420405347284, 4829.154897892855, 5083.339165908408, 5095.235714642833, 5102.591792656579, 5111.667741596784, 4336.739795612273, 4394.802233899482, 4406.449193850769, 4409.955900440955, 4433.6009759121835, 4512.187806194851, 4527.977360113178, 4531.8413855515555, 4535.727856328631, 4575.107853968444, 4824.49342819006, 4840.854774356775, 4844.878878028077, 4846.975765121152, 4881.8535443936025, 4830.106430310404, 4946.505349465025, 4954.529319714621, 4986.700797952134, 5127.333446652061, 4855.393075865517, 4859.392575928009, 4861.1979023460735, 4863.10032643962, 4903.705777653352, 5057.216131499624, 5058.291839142449, 5062.873428164326, 5065.037642847848, 5066.518680725325, 4784.210605250234, 4946.431160416598, 4955.45489996093, 5022.824201152942, 5158.742062896915, 4972.925406118983, 5012.8496145115705, 5019.949800501949, 5021.297018417352, 5021.6735912165595, 5007.47421520735, 5010.273510341053, 5010.498950105106, 5013.498650134958, 5036.521530454601, 4633.907321853611, 4747.976260118678, 4749.097671442415, 4753.83361582343, 4956.752162391794, 4890.413150421972, 4937.259411088366, 4994.750262486934, 5062.797488100435, 5069.847904562869, 4802.471728109975, 4815.855524334275, 4819.831305904277, 4821.46963833985, 4854.611631069435], "unit": "ms", "name": "dojo.html", "value": 4671.047692705066}, {"lowerIsBetter": false, "replicates": [549.0254797734021, 556.4713522153954, 564.5201578658139, 575.1688809670028, 577.6822747488881, 27211.5918261226, 32819.0, 33510.49734253982, 33576.83211583945, 33621.159471013205, 40107.79946100265, 40879.18241635166, 40941.795291023576, 41028.384574231335, 41087.0, 7063.187733410647, 7167.677454514559, 7871.370290376771, 8037.27664510194, 8039.196080391943, 9959.05388988045, 10131.240156988255, 10250.384976901372, 10251.231157663206, 10259.640912568062, 10072.848907266396, 10176.287659863812, 10195.694129176136, 10195.694129176136, 10195.745106372326, 7311.488195826294, 7505.924940750577, 7518.135414427356, 9896.554655040505, 9985.90014099857, 9803.558839852223, 9945.651902183461, 9959.55182016811, 9959.701208963743, 9962.352447090916, 37260.44109338362, 37629.0, 37766.62233377686, 37792.24415511674, 37825.24349513022, 3035.8026728262594, 3130.5930229070304, 3134.467140586106, 3549.4675798630155, 3684.889453316405, 28496.287592810346, 28882.711172888212, 28894.71105288941, 29039.85480072586, 29152.030858861748, 3302.5963965314645, 3320.7177389921885, 3322.551455553518, 3392.016315268569, 3430.9313813723834, 208058.0, 208890.95554522282, 208985.0, 209090.0, 209357.0, 50282.245766313536, 52095.73952130215, 54390.45609543933, 54930.176047359324, 55069.44930550643, 53643.731781340844, 53882.0, 54122.45877541253, 54265.72867135639, 54446.45553544414, 12495.000399967981, 12632.873671263169, 12644.114911956258, 12666.683332916566, 12709.93645031769, 9610.279229057849, 9710.854337184806, 9715.562799674031, 9720.31957762964, 9721.270904682036, 18816.15327310247, 18963.715544266848, 18973.43079707611, 18976.335828245945, 19027.809721902882, 7453.180150183475, 7754.689812407553, 7772.421888658626, 7776.766696999099, 7828.882566761503, 822.2722890242179, 919.5264438814016, 963.0946909904667, 969.1568335547977, 990.5047476261869, 26585.0, 26618.6007209892, 26728.0, 27086.45827083447, 27094.5935810963, 943.8301105801022, 979.647326962293, 984.4437892590663, 1053.9736506587396, 1087.994560027195, 14052.22712750788, 14061.611232524074, 14077.507287244896, 14185.645358866112, 14310.785338219936, 257017.0, 258603.0, 261231.0, 261522.0, 261623.0, 32057.198570035936, 45208.77395613001, 45457.54542454533, 45488.09023819505, 45518.08963820771, 1092.5848177692426, 1208.4139192491634, 1209.38925842449, 1214.2410993129295, 1215.1797536662718, 24163.395915102265, 25177.622335665346, 26387.60418593684, 26467.60298595561, 26821.463570728865, 30765.538516921817, 31688.524672129475, 31704.682953170173, 36568.0, 37050.0, 235781.0, 239670.0, 243067.0, 243406.0, 243756.0, 26548.0, 26634.600480992412, 26827.0, 26881.193564193105, 26969.303069692873, 35924.28151437009, 36285.0, 36357.27285454329, 37063.81468092642, 37201.4419783698, 31125.0, 32157.0, 33763.15592110217, 35688.464673029404, 37180.25639487249, 32447.218561162375, 33194.834025830685, 33246.667533324355, 33356.833215833765, 33391.49912751359, 32793.34413311768, 33244.34579158871, 33765.83117084399, 33891.15272118217, 34026.659733403336, 25804.741952580232, 27646.861765691043, 27838.443231134857, 27856.721432785413, 27859.16422507328, 22659.320220393416, 23020.539589208456, 23257.767422326237, 23263.41841453977, 23331.300060998197], "unit": "ms", "name": "ext.html", "value": 16863.112118573546}, {"lowerIsBetter": false, "replicates": [332.60420100080916, 335.82704906972907, 336.26861576072065, 336.6868812004836, 338.6139800627285, 12481.188722733015, 12813.0, 15329.69340613187, 15484.60638542531, 16629.417970371054, 12993.1554448961, 13215.405306761195, 13249.801252981213, 13262.336883155827, 13579.932100339485, 4855.417349918006, 4882.121218180726, 4991.051700176955, 4994.775235114428, 5052.115879721053, 3702.592714801383, 3834.5973672764376, 5583.609147359686, 5702.0, 5740.827775166752, 5658.207850900877, 5670.829875103754, 5684.118961560965, 5694.117411801178, 5710.943475457033, 4801.207800712878, 4970.726610036447, 4972.105021096201, 4973.179425394806, 4973.502649735015, 4646.652470783469, 4776.164171270048, 4789.0, 4791.233402655558, 4827.155247831651, 11384.146189035773, 11522.711932201762, 11557.0, 12751.744965100646, 18478.630427391512, 1829.2042961311738, 1859.8698091133626, 1887.5564242403025, 1900.0119937632492, 1913.9855876385539, 9162.770930726785, 9214.585343659552, 10132.746681332952, 11761.529538818522, 13275.933620331836, 1721.277063633277, 1746.3102074680558, 1787.9195436205403, 1794.3091909614761, 1804.6932021556368, 52927.20609190865, 54878.45121548773, 56013.43986560123, 56163.0, 56475.0, 9308.534573271309, 9365.344425890122, 9419.576119074658, 9512.714618561455, 9565.760855978517, 11629.418529073682, 11704.47329870158, 11727.88272117285, 11731.76536469266, 11743.588974385855, 6671.933280667228, 6735.090762746966, 6776.898346524806, 6781.830454238683, 6782.559133656297, 6460.773872914426, 6483.222013358427, 6522.869542609121, 6528.249251336062, 6583.83540411484, 4039.5960403959957, 4156.314208155621, 4252.702310838274, 4260.8721738347895, 4340.60934515895, 1635.5338728462332, 1691.3488307001646, 1696.372342233357, 1697.8556822670212, 1705.3349193814422, 797.8204903896577, 867.1068799136899, 913.55235934393, 932.5849996751381, 937.6858752317913, 13237.867621323663, 15316.387344506318, 15373.231338433257, 15398.615034624225, 15982.200889955688, 845.471580262336, 857.322715055112, 886.2599729226168, 898.2095755734912, 922.4142669404843, 8809.33929955256, 9006.279497640173, 9135.132162444557, 9262.0, 9366.859497107549, 518524.0, 527034.0, 528189.0, 530062.0, 541227.0, 71335.64332178306, 72302.0, 74837.0, 75017.0, 75496.62251688706, 1066.1257768629648, 1072.1369297715414, 1080.9675709728722, 1084.2681190196743, 1085.6851513061124, 14290.928545357207, 14471.421143154577, 14719.55841324762, 14762.261886905397, 14950.92524537414, 33891.32217355688, 34076.31847363088, 34173.0, 35105.473417899266, 35476.0, 43646.781766090964, 45663.54336456593, 45683.77158114188, 45765.31352029656, 48993.2651010228, 8766.386352955487, 8788.824223515367, 8965.282777377664, 8980.416272942239, 9379.296552758708, 15267.541973740805, 15674.059556426651, 15761.842381576038, 16043.438479653623, 16049.197540123181, 13162.0, 13708.0, 13788.310584470535, 13870.65323366924, 14413.567592972227, 9485.059631514252, 12653.557125500563, 12888.39125044989, 13583.0, 13636.318184090558, 12499.812502812283, 13867.791983120464, 14020.579382618538, 14420.567382978528, 14582.125072495684, 8913.242374398249, 8997.28021758271, 9021.503817290111, 9133.862992054992, 9208.631654733736, 12704.801378242446, 13330.200187988752, 13385.263810490516, 13391.196528208338, 13573.932130339681], "unit": "ms", "name": "jquery.html", "value": 8205.449995848003}, {"lowerIsBetter": false, "replicates": [1220.9206401583901, 1679.7816283883096, 1708.658268346331, 1724.0690027385212, 1732.9653406931861, 6310.716017779199, 7251.0, 7415.66629501673, 7432.368248698867, 7433.665485053172, 7292.124945006607, 7441.032665753444, 7472.96263518683, 7474.551526908389, 7492.400607951365, 1778.2353587957173, 1821.5081927879464, 2089.7074409582633, 2117.6082424751394, 2125.7767934366902, 2047.3141497598322, 2105.9473513162216, 2106.0, 2107.2413930984835, 2108.061912448961, 2063.298478517304, 2078.667413213886, 2086.1446806809213, 2105.7788932162134, 2109.789021097893, 2085.780992995729, 2096.863703859244, 2117.1319758898776, 2120.0777661717125, 2122.628540005501, 2061.793820617941, 2078.9168433262653, 2079.5009197792574, 2081.8126368626745, 2083.364573804989, 7285.817854553626, 7372.926270737331, 7375.520591161558, 7380.77857664271, 7389.5935723535185, 4038.7374820636564, 4111.568285330027, 4123.97938010308, 4132.380142978547, 4137.627613514768, 2638.7625113739855, 2695.43395886864, 2708.079253053971, 2718.592211168341, 2743.3141714571357, 838.7483754873514, 878.9692360767342, 884.2660591708866, 885.3536918049796, 899.3030401438937, 9900.504974751233, 9935.05616966387, 9947.303688741718, 9952.552135153936, 9964.701058968243, 3862.806859657062, 3919.2161567686576, 3931.0565464288366, 3933.252681990413, 3986.142979259473, 8533.146685331541, 8538.0, 8539.658413663508, 8543.273821725223, 8548.358873084419, 4187.099773548702, 4190.245755763992, 4200.033992181815, 4204.579542045771, 4219.092895027584, 3798.563165235978, 3814.9809250953567, 3822.560405553397, 3823.9808800956375, 3827.9043023924623, 2792.8603569821425, 2812.4093940272364, 2824.717528247159, 3442.4147894857433, 3527.4532447470683, 946.6923249943795, 1087.445402844555, 1100.5707773968159, 1103.7351035751522, 1104.3539529375246, 831.9001719793542, 845.6997765793178, 858.6007506509503, 863.2317237658489, 865.7316231967984, 6626.4367528760595, 6658.600483970978, 6687.364700353459, 6694.330566943267, 6715.865682686319, 1011.5549158370294, 1025.6666583360438, 1045.2004216774174, 1051.7107795356185, 1053.6364954090827, 5241.580673546107, 5370.892582148335, 5372.167314066326, 5378.139497680352, 5388.245645609618, 8419.494830310201, 8705.303575713928, 8726.171013753683, 8736.432131911406, 8781.69264075767, 8666.913330866737, 8721.912780872237, 8736.213740763362, 8739.650413983369, 8779.12208779117, 6802.557833740791, 6812.523123381415, 6856.6228857412325, 6884.414824739853, 6946.7221311148, 6367.331430199948, 6418.871622567429, 6422.678866056772, 6424.678766061585, 6449.193850768654, 7696.845473179068, 7854.489458185429, 7930.682772689259, 7961.960190199244, 7966.482178658369, 7904.0, 8136.511809291462, 8157.428979971345, 8166.83666326682, 8203.548804815793, 6444.45222156122, 6492.156019717407, 6522.5760325578685, 6531.673416329259, 6535.215774107138, 5966.343702192668, 6859.5541289816, 6915.03189553473, 6916.0, 6943.027976083251, 5775.133729940375, 5863.17915491823, 6357.872842543031, 6454.967725161344, 6511.576747511396, 6273.3099359071375, 6432.485401167989, 6462.256840463407, 6481.189851268591, 6516.771912983023, 6673.833154171185, 6733.562318449285, 6735.4611631070375, 6737.056812046219, 6737.562058466184, 5854.502367298827, 6051.394860513913, 6100.511959043355, 6203.782867599793, 6261.65560894137, 6068.4841788448475, 6120.816375508563, 6127.142200091902, 6127.325994140552, 6133.0], "unit": "ms", "name": "mootools.html", "value": 4106.59368028623}, {"lowerIsBetter": false, "replicates": [302.67008960233346, 309.6531884289596, 315.27644056889443, 315.8247172819086, 316.2773063549789, 5314.78740850366, 5420.186971954209, 5425.864353391157, 5428.022955867942, 5430.837074887755, 5371.140617501201, 5374.435684253156, 5377.274068000819, 5383.084875571152, 5391.676499410039, 3952.584978577251, 4041.1715598302276, 4172.561881002496, 4174.603412675799, 4176.498820141587, 4103.220388126261, 4149.315362965107, 4154.127633197032, 4183.916321673565, 4191.847242008442, 4119.8970025749295, 4125.051238215212, 4126.649234815044, 4128.339465685491, 4135.379693046037, 3904.902377440558, 3990.04238982645, 4023.7786921719294, 4119.443875076856, 4130.070734084837, 3626.1841085755495, 3630.4009838376637, 3632.20091579852, 3644.1071937375514, 3644.398674218751, 5091.363579552556, 5103.362079740033, 5120.950205207923, 5128.333316668809, 5137.280780690707, 4738.099761045391, 4764.833230836939, 4767.237242041257, 4770.713757174581, 4775.068861571995, 5512.944870551323, 5623.662580245157, 5640.802571910004, 5643.238162848004, 5646.463585959327, 3975.7813320267373, 3976.204759048202, 3979.880603581897, 3979.9403008954887, 3987.302222111119, 5946.108083787423, 5949.613275137102, 5950.494207992326, 5958.821235362902, 5963.344032156459, 4083.2854250506043, 4087.3664581989838, 4088.4889388826396, 4089.7526254492072, 4090.365993271048, 3973.9534139917964, 4112.938305925413, 4141.855035073758, 4151.232022075926, 4152.854650087293, 4722.763861806896, 4723.645726570521, 4724.149653062413, 4725.054989002213, 4730.0, 5662.546996240291, 5666.773329066874, 5666.943330566724, 5672.716364181774, 5675.914861277084, 1428.171660436944, 1451.2380999974887, 1453.4767483705857, 1456.7232225877049, 1457.2859298943654, 969.340848223215, 969.7817990951979, 981.3523074770617, 986.7187851462443, 1004.4224570871778, 5008.373953255843, 5009.774560144802, 5017.8243761468175, 5021.899562008739, 5022.070916880316, 5876.7649294028615, 5896.056630939115, 5899.233099697098, 5905.261842269716, 5906.5570082244, 4998.125328067574, 5023.0456213320085, 5030.823921162815, 5031.371078615173, 5038.697678139323, 2922.1817890990555, 3006.7143621355935, 3136.106209730216, 3148.795328303653, 3185.61772587291, 5549.1676248562235, 5554.2779438672715, 5623.0, 5626.1842032905815, 5632.324121105494, 6032.909506357408, 6101.8474538136015, 6105.297890742532, 6109.938900611026, 6115.082737589397, 5610.046292130348, 5613.298337707786, 5618.157276408571, 5618.522425593788, 5620.1288800236025, 5728.3985181557, 5892.381299963614, 5894.941050589439, 5958.553108516965, 5968.134620480093, 5820.417958204146, 5820.912686309624, 5825.79609713658, 5827.3007239131575, 5829.09649004405, 5602.635828671123, 5610.13042978339, 5611.410801865909, 5612.074007788669, 5612.7754889803955, 3903.316919539126, 4023.7786921719585, 4052.63526282636, 4053.4122552229173, 4059.5737447568763, 5797.594168408171, 5799.623024503394, 5838.0, 5896.410358964069, 5901.380355062656, 5688.687122208153, 5689.0, 5689.601727879174, 5689.857753556029, 5692.971535142464, 5681.659100453986, 5684.891446167958, 5686.118651609007, 5686.943130568807, 5689.402612725769, 5408.486193811582, 5570.164475328733, 5575.581831362583, 5576.721163941867, 5579.721013949205, 5711.942880571141, 5720.056190728649, 5721.25623668937, 5731.914021289767, 5733.0540460823495, 5350.7324633767375, 5456.781728730806, 5520.0, 5558.44415558441, 5565.916511252415], "unit": "ms", "name": "prototype.html", "value": 4254.515709271968}, {"lowerIsBetter": false, "replicates": [677.4038845815681, 715.3857618361568, 768.3776141325525, 768.5427170833352, 775.523053322207, 11155.832662510058, 14135.787963180548, 14564.927175364135, 14659.486917957873, 14665.999999999987, 12769.553065642704, 12796.552120675778, 12866.421011054501, 12888.74222515549, 12911.354432278373, 428.3852671416512, 432.96536277097755, 799.2127754162132, 817.8037271054934, 818.3535007344191, 798.2735710503443, 815.9061707903608, 816.8978877640295, 817.3502065857657, 818.0020375142317, 848.7241646464893, 864.5590748718137, 867.4621734524603, 867.6052396159764, 868.0148031983681, 453.39698201392235, 461.19751632160137, 836.6235194162651, 853.8591132463137, 855.8373908957278, 630.9684515774193, 631.7441436218339, 632.1150389454754, 632.3897438971369, 633.2875515045574, 11909.82135267963, 12527.874721252761, 12535.686607834787, 12540.937295313464, 12547.184433011917, 10582.682519524427, 10910.563577456971, 11119.666410007712, 11176.329420234812, 11277.887221127765, 8863.645454181826, 9025.368224224307, 9090.727278181665, 9115.0, 9575.712728618153, 3184.570083038783, 3228.370467758788, 3256.5766450361302, 3266.7059964603063, 3277.393682168806, 39700.0, 39937.0, 40273.395899061245, 40689.38965915514, 40847.59152408497, 9109.362344635812, 9112.49881256524, 9163.81672366549, 9164.816703665889, 9165.495897725556, 16204.594885127966, 16227.756583651255, 16237.756433653505, 16238.837611623969, 16265.349386024427, 6264.0, 6457.063725759738, 6462.32145624712, 6632.1709786276715, 6662.900056499157, 3513.9121521962156, 3556.91107722309, 3568.6431356864623, 3578.320119177348, 3600.42393217084, 2689.825161364505, 2740.082072505693, 2740.8629568521496, 2742.780577553791, 2742.9725702742717, 504.2914704839706, 535.2105644174811, 536.3054843976981, 540.8972295263887, 551.3714365623193, 550.931133608299, 606.9635821850703, 608.14251904814, 625.8372823065945, 628.0328294426623, 7538.773836784905, 7996.28544182775, 8221.54781487012, 8371.58142092893, 8940.597673104727, 431.77979230592626, 472.2538389344827, 505.72943475241306, 538.4561592791231, 558.3662543013709, 3610.1696609779897, 3731.962680373216, 3746.868859589901, 3841.5774264830848, 3972.145988612462, 46396.30405543919, 47197.29204061873, 47374.0, 47377.76311118422, 47515.28727069097, 42162.15675686469, 43621.781891090344, 43797.90505237394, 44562.33156502655, 44841.77579112084, 37681.24637507235, 39651.0, 39687.40468892969, 40506.79746601248, 41582.1683566327, 7938.404619653434, 8104.756857294291, 8185.836283274421, 8436.915630843612, 8464.301192035866, 30001.0, 30030.849845750632, 30875.0, 31234.0, 31313.0, 39447.408288875115, 39523.604763953146, 39684.801575991936, 40442.0, 40649.1870162601, 9842.704718858446, 9936.552855121392, 10151.746206344606, 10328.948355258175, 10349.379037257788, 11061.391623460788, 11242.887571124511, 11504.654860354203, 11753.236039657737, 11840.171188016757, 10836.349819010884, 11097.833532497181, 11155.0, 11181.944090279496, 11343.149263805082, 9594.280428967995, 9733.951330243304, 9756.80486390254, 9812.460314682476, 9943.25425593069, 8504.787380315542, 10192.490375481344, 10199.439030853078, 10303.278770486293, 10798.514066867167, 8998.280137588847, 9132.22376098039, 9159.908400916172, 9190.264778817813, 9485.964491362698, 8935.28517718568, 8966.730998070068, 9090.863637045317, 9262.120098590623, 9427.198688111588], "unit": "ms", "name": "yui.html", "value": 5717.944924961889}], "name": "dromaeo_css", "value": 6334.004740325552}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 111.0, 112.0, 111.0, 102.0, 113.0, 111.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [153.0, 130.0, 154.0, 175.0, 130.0, 155.0, 153.0, 137.0, 164.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 81.0, 91.0, 73.0, 74.0, 72.0, 101.0, 99.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 132.0, 93.0, 95.0, 94.0, 135.0, 95.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 150.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 72.0, 73.0, 72.0, 71.0, 80.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 83.0, 84.0, 83.0, 85.0, 86.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 123.0, 116.0, 120.0, 129.0, 128.0, 129.0, 124.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [135.0, 147.0, 153.0, 146.0, 153.0, 140.0, 159.0, 150.0, 143.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 70.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1520.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.9189189189189], "unit": "score", "name": "Richards", "value": 208.98783999999998}, {"lowerIsBetter": false, "replicates": [186.56716417910448], "unit": "score", "name": "DeltaBlue", "value": 354.39248}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [27270.27027027027], "unit": "score", "name": "RegExp", "value": 33.405792864221986}, {"lowerIsBetter": false, "replicates": [605.6935190793458], "unit": "score", "name": "Splay", "value": 134.541641}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19661.87337852431}]} 13:57:04 INFO - RETURN: dromaeo_css: 6334.00 13:57:04 INFO - RETURN: kraken: 1520.10 13:57:04 INFO - RETURN: v8_7: 19661.87 13:57:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19661.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6334.00"}}} 13:57:04 INFO - Return code: 0 13:57:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:57:04 ERROR - # TBPL SUCCESS # 13:57:04 INFO - Running post-action listener: _resource_record_post_action 13:57:04 INFO - Running post-run listener: _resource_record_post_run 13:57:05 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518311936; Read time: 4; Write time: 435580 13:57:05 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242167808; Read time: 0; Write time: 275184 13:57:05 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275894272; Read time: 4; Write time: 160396 13:57:05 INFO - Running post-run listener: _upload_blobber_files 13:57:05 INFO - Blob upload gear active. 13:57:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:57:05 INFO - Copying logs to upload dir... 13:57:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.024743 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-14 13:57:05.335601) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:57:05.338923) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010113 build_url: 'https://queue.taskcluster.net/v1/task/KNvDEAmWSBOD0T3yC6eZBQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 13:57:05.390086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:57:05.390400) ========= 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=5804b9f07a53938c557deee7000001c5-1450128952.997094-1529202639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 13:57:05.440000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 13:57:05.440299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 13:57:05.440584) ========= ========= Total master_lag: 0.21 =========