builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1463649622.57 results: success (0) buildid: 20160517065136 builduid: ab760662d3a1428fa4c9e673ad9c7baf revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.574517) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.574944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.575218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.588314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.588613) ========= 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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 02:20:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 22.2M=0.001s 2016-05-19 02:20:22 (22.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.691396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.691725) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016597 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.741614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:22.742085) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3780a3a6b83aeda143f9562829c830410a0c961e --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 3780a3a6b83aeda143f9562829c830410a0c961e --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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 02:20:23,095 truncating revision to first 12 chars 2016-05-19 02:20:23,095 Setting DEBUG logging. 2016-05-19 02:20:23,095 attempt 1/10 2016-05-19 02:20:23,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3780a3a6b83a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 02:20:23,352 unpacking tar archive at: mozilla-central-3780a3a6b83a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:23.319020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:23.319333) ========= script_repo_revision: 3780a3a6b83aeda143f9562829c830410a0c961e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:23.319730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:23.320010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 02:20:23.327852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-19 02:20:23.328164) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --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', '--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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:23 INFO - MultiFileLogger online at 20160519 02:20:23 in /builds/slave/test 02:20:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:20:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:23 INFO - {'append_to_log': False, 02:20:23 INFO - 'base_work_dir': '/builds/slave/test', 02:20:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:20:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:23 INFO - 'branch': 'Firefox-Non-PGO', 02:20:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:23 INFO - 'config_files': ('talos/linux_config.py',), 02:20:23 INFO - 'default_actions': ('clobber', 02:20:23 INFO - 'read-buildbot-config', 02:20:23 INFO - 'download-and-extract', 02:20:23 INFO - 'populate-webroot', 02:20:23 INFO - 'create-virtualenv', 02:20:23 INFO - 'install', 02:20:23 INFO - 'run-tests'), 02:20:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:23 INFO - 'download_minidump_stackwalk': True, 02:20:23 INFO - 'download_symbols': 'ondemand', 02:20:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:23 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:23 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:23 INFO - 'installer_path': 'installer.exe', 02:20:23 INFO - 'log_level': 'info', 02:20:23 INFO - 'log_name': 'talos', 02:20:23 INFO - 'log_to_console': True, 02:20:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:23 INFO - 'opt_config_files': (), 02:20:23 INFO - 'pip_index': False, 02:20:23 INFO - 'sps_profile': False, 02:20:23 INFO - 'sps_profile_interval': 0, 02:20:23 INFO - 'suite': 'dromaeojs', 02:20:23 INFO - 'system_bits': '32', 02:20:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:23 INFO - 'title': 'talos-linux64-ix-018', 02:20:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:23 INFO - 'use_talos_json': True, 02:20:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:23 INFO - 'work_dir': 'build'} 02:20:23 INFO - ##### 02:20:23 INFO - ##### Running clobber step. 02:20:23 INFO - ##### 02:20:23 INFO - Running pre-action listener: _resource_record_pre_action 02:20:23 INFO - Running main action method: clobber 02:20:23 INFO - rmtree: /builds/slave/test/build 02:20:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:24 INFO - Running post-action listener: _resource_record_post_action 02:20:24 INFO - ##### 02:20:24 INFO - ##### Finished clobber step (success) 02:20:24 INFO - ##### 02:20:24 INFO - ##### 02:20:24 INFO - ##### Running read-buildbot-config step. 02:20:24 INFO - ##### 02:20:24 INFO - Running pre-action listener: _resource_record_pre_action 02:20:24 INFO - Running main action method: read_buildbot_config 02:20:24 INFO - Using buildbot properties: 02:20:24 INFO - { 02:20:24 INFO - "project": "", 02:20:24 INFO - "product": "firefox", 02:20:24 INFO - "script_repo_revision": "production", 02:20:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:20:24 INFO - "repository": "", 02:20:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:20:24 INFO - "buildid": "20160517065136", 02:20:24 INFO - "pgo_build": "False", 02:20:24 INFO - "basedir": "/builds/slave/test", 02:20:24 INFO - "buildnumber": 509, 02:20:24 INFO - "slavename": "talos-linux64-ix-018", 02:20:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:20:24 INFO - "platform": "ubuntu64_hw", 02:20:24 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:20:24 INFO - "branch": "mozilla-central", 02:20:24 INFO - "repo_path": "mozilla-central", 02:20:24 INFO - "revision": "3780a3a6b83aeda143f9562829c830410a0c961e", 02:20:24 INFO - "stage_platform": "linux64", 02:20:24 INFO - "builduid": "ab760662d3a1428fa4c9e673ad9c7baf", 02:20:24 INFO - "slavebuilddir": "test" 02:20:24 INFO - } 02:20:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:20:24 INFO - Running post-action listener: _resource_record_post_action 02:20:24 INFO - ##### 02:20:24 INFO - ##### Finished read-buildbot-config step (success) 02:20:24 INFO - ##### 02:20:24 INFO - ##### 02:20:24 INFO - ##### Running download-and-extract step. 02:20:24 INFO - ##### 02:20:24 INFO - Running pre-action listener: _resource_record_pre_action 02:20:24 INFO - Running main action method: download_and_extract 02:20:24 INFO - mkdir: /builds/slave/test/build/tests 02:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:24 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:24 INFO - Downloaded 1361 bytes. 02:20:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:20:24 INFO - Using the following test package requirements: 02:20:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'jsshell-linux-x86_64.zip'], 02:20:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:24 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:26 INFO - Downloaded 22447955 bytes. 02:20:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:27 INFO - Return code: 0 02:20:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:20: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')]} 02:20:27 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:28 INFO - Downloaded 22447955 bytes. 02:20:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:30 INFO - Return code: 0 02:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:30 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:31 INFO - Downloaded 10840194 bytes. 02:20:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:31 INFO - Return code: 0 02:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:31 INFO - https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:32 INFO - Downloaded 54754715 bytes. 02:20:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:20:32 INFO - mkdir: /builds/slave/test/properties 02:20:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:32 INFO - Contents: 02:20:32 INFO - build_url:https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:20:33 INFO - Running post-action listener: _resource_record_post_action 02:20:33 INFO - Running post-action listener: set_extra_try_arguments 02:20:33 INFO - ##### 02:20:33 INFO - ##### Finished download-and-extract step (success) 02:20:33 INFO - ##### 02:20:33 INFO - ##### 02:20:33 INFO - ##### Running populate-webroot step. 02:20:33 INFO - ##### 02:20:33 INFO - Running pre-action listener: _resource_record_pre_action 02:20:33 INFO - Running main action method: populate_webroot 02:20:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:33 INFO - '--tppagecycles', 02:20:33 INFO - '7'], 02:20:33 INFO - 'tests': ['tsvgm']}}, 02:20:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['damp', 'tps']}, 02:20:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'tests': ['damp', 'tps']}, 02:20:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['dromaeo_dom']}, 02:20:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['a11yr', 02:20:33 INFO - 'ts_paint', 02:20:33 INFO - 'tpaint', 02:20:33 INFO - 'sessionrestore', 02:20:33 INFO - 'sessionrestore_no_auto_restore', 02:20:33 INFO - 'tabpaint']}, 02:20:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['tsvgx', 02:20:33 INFO - 'tsvgr_opacity', 02:20:33 INFO - 'tart', 02:20:33 INFO - 'tscrollx', 02:20:33 INFO - 'cart']}, 02:20:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:33 INFO - 'tsvgr_opacity', 02:20:33 INFO - 'tart', 02:20:33 INFO - 'tscrollx', 02:20:33 INFO - 'cart']}, 02:20:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'talos_options': ['--disable-e10s'], 02:20:33 INFO - 'tests': ['tp5o']}, 02:20:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'tests': ['tp5o']}, 02:20:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'talos_options': ['--disable-e10s', 02:20:33 INFO - '--xperf_path', 02:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:33 INFO - 'tests': ['tp5n']}, 02:20:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:33 INFO - 'talos_options': ['--xperf_path', 02:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:33 INFO - 'tests': ['tp5n']}}, 02:20:33 INFO - 'talos.zip': {'path': '', 02:20:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:33 INFO - Running post-action listener: _resource_record_post_action 02:20:33 INFO - ##### 02:20:33 INFO - ##### Finished populate-webroot step (success) 02:20:33 INFO - ##### 02:20:33 INFO - ##### 02:20:33 INFO - ##### Running create-virtualenv step. 02:20:33 INFO - ##### 02:20:33 INFO - Running pre-action listener: _resource_record_pre_action 02:20:33 INFO - Running main action method: create_virtualenv 02:20:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:33 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 02:20:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:33 INFO - Using real prefix '/usr' 02:20:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:36 INFO - Installing pip.................done. 02:20:36 INFO - Return code: 0 02:20:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:36 INFO - Using env: {'DISPLAY': ':0', 02:20:36 INFO - 'HOME': '/home/cltbld', 02:20:36 INFO - 'LANG': 'en_US.UTF-8', 02:20:36 INFO - 'LANGUAGE': 'en_US:en', 02:20:36 INFO - 'LOGNAME': 'cltbld', 02:20:36 INFO - 'MAIL': '/var/mail/cltbld', 02:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:36 INFO - 'MOZ_NO_REMOTE': '1', 02:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:36 INFO - 'NO_EM_RESTART': '1', 02:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:36 INFO - 'PWD': '/builds/slave/test', 02:20:36 INFO - 'SHELL': '/bin/bash', 02:20:36 INFO - 'SHLVL': '1', 02:20:36 INFO - 'TERM': 'linux', 02:20:36 INFO - 'TMOUT': '86400', 02:20:36 INFO - 'USER': 'cltbld', 02:20:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:36 INFO - '_': '/tools/buildbot/bin/python'} 02:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:36 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 02:20:36 INFO - Cleaning up... 02:20:36 INFO - Return code: 0 02:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 02:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 02:20:36 INFO - Using env: {'DISPLAY': ':0', 02:20:36 INFO - 'HOME': '/home/cltbld', 02:20:36 INFO - 'LANG': 'en_US.UTF-8', 02:20:36 INFO - 'LANGUAGE': 'en_US:en', 02:20:36 INFO - 'LOGNAME': 'cltbld', 02:20:36 INFO - 'MAIL': '/var/mail/cltbld', 02:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:36 INFO - 'MOZ_NO_REMOTE': '1', 02:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:36 INFO - 'NO_EM_RESTART': '1', 02:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:36 INFO - 'PWD': '/builds/slave/test', 02:20:36 INFO - 'SHELL': '/bin/bash', 02:20:36 INFO - 'SHLVL': '1', 02:20:36 INFO - 'TERM': 'linux', 02:20:36 INFO - 'TMOUT': '86400', 02:20:36 INFO - 'USER': 'cltbld', 02:20:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:36 INFO - '_': '/tools/buildbot/bin/python'} 02:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:36 INFO - Downloading/unpacking psutil>=3.1.1 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:36 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 02:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:38 INFO - Installing collected packages: psutil 02:20:38 INFO - Running setup.py install for psutil 02:20:38 INFO - building 'psutil._psutil_linux' extension 02:20:38 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 02:20:39 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 02:20:39 INFO - building 'psutil._psutil_posix' extension 02:20:39 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 02:20:39 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 02:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:39 INFO - Successfully installed psutil 02:20:39 INFO - Cleaning up... 02:20:39 INFO - Return code: 0 02:20:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 02:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 02:20:39 INFO - Using env: {'DISPLAY': ':0', 02:20:39 INFO - 'HOME': '/home/cltbld', 02:20:39 INFO - 'LANG': 'en_US.UTF-8', 02:20:39 INFO - 'LANGUAGE': 'en_US:en', 02:20:39 INFO - 'LOGNAME': 'cltbld', 02:20:39 INFO - 'MAIL': '/var/mail/cltbld', 02:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:39 INFO - 'MOZ_NO_REMOTE': '1', 02:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:39 INFO - 'NO_EM_RESTART': '1', 02:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:39 INFO - 'PWD': '/builds/slave/test', 02:20:39 INFO - 'SHELL': '/bin/bash', 02:20:39 INFO - 'SHLVL': '1', 02:20:39 INFO - 'TERM': 'linux', 02:20:39 INFO - 'TMOUT': '86400', 02:20:39 INFO - 'USER': 'cltbld', 02:20:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:39 INFO - '_': '/tools/buildbot/bin/python'} 02:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:39 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 02:20:39 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 02:20:39 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 02:20:39 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 02:20:39 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 02:20:39 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 02:20:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:41 INFO - Installing collected packages: mozsystemmonitor 02:20:41 INFO - Running setup.py install for mozsystemmonitor 02:20:41 INFO - Successfully installed mozsystemmonitor 02:20:41 INFO - Cleaning up... 02:20:41 INFO - Return code: 0 02:20:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:41 INFO - Using env: {'DISPLAY': ':0', 02:20:41 INFO - 'HOME': '/home/cltbld', 02:20:41 INFO - 'LANG': 'en_US.UTF-8', 02:20:41 INFO - 'LANGUAGE': 'en_US:en', 02:20:41 INFO - 'LOGNAME': 'cltbld', 02:20:41 INFO - 'MAIL': '/var/mail/cltbld', 02:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:41 INFO - 'MOZ_NO_REMOTE': '1', 02:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:41 INFO - 'NO_EM_RESTART': '1', 02:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:41 INFO - 'PWD': '/builds/slave/test', 02:20:41 INFO - 'SHELL': '/bin/bash', 02:20:41 INFO - 'SHLVL': '1', 02:20:41 INFO - 'TERM': 'linux', 02:20:41 INFO - 'TMOUT': '86400', 02:20:41 INFO - 'USER': 'cltbld', 02:20:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:41 INFO - '_': '/tools/buildbot/bin/python'} 02:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:42 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 02:20:42 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 02:20:42 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 02:20:42 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 02:20:42 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 02:20:42 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 02:20:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:44 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 02:20:44 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 02:20:44 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 02:20:44 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 02:20:44 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 02:20:44 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 02:20:44 INFO - Downloading docopt-0.6.1.tar.gz 02:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:44 INFO - Running setup.py install for blobuploader 02:20:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:44 INFO - Running setup.py install for requests 02:20:45 INFO - Running setup.py install for docopt 02:20:45 INFO - Successfully installed blobuploader requests docopt 02:20:45 INFO - Cleaning up... 02:20:45 INFO - Return code: 0 02:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 02:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 02:20:45 INFO - Using env: {'DISPLAY': ':0', 02:20:45 INFO - 'HOME': '/home/cltbld', 02:20:45 INFO - 'LANG': 'en_US.UTF-8', 02:20:45 INFO - 'LANGUAGE': 'en_US:en', 02:20:45 INFO - 'LOGNAME': 'cltbld', 02:20:45 INFO - 'MAIL': '/var/mail/cltbld', 02:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:45 INFO - 'MOZ_NO_REMOTE': '1', 02:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:45 INFO - 'NO_EM_RESTART': '1', 02:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:45 INFO - 'PWD': '/builds/slave/test', 02:20:45 INFO - 'SHELL': '/bin/bash', 02:20:45 INFO - 'SHLVL': '1', 02:20:45 INFO - 'TERM': 'linux', 02:20:45 INFO - 'TMOUT': '86400', 02:20:45 INFO - 'USER': 'cltbld', 02:20:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:45 INFO - '_': '/tools/buildbot/bin/python'} 02:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:45 INFO - Running setup.py (path:/tmp/pip-rl98KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:45 INFO - Running setup.py (path:/tmp/pip-GhcnMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:45 INFO - Running setup.py (path:/tmp/pip-fVbZ0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:45 INFO - Running setup.py (path:/tmp/pip-ilcYV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:45 INFO - Running setup.py (path:/tmp/pip-jE7YQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:45 INFO - Running setup.py (path:/tmp/pip-PA_xtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:45 INFO - Running setup.py (path:/tmp/pip-o57usu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:46 INFO - Running setup.py (path:/tmp/pip-hy6W8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:46 INFO - Running setup.py (path:/tmp/pip-CNYn9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:46 INFO - Running setup.py (path:/tmp/pip-0aJcpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:46 INFO - Running setup.py (path:/tmp/pip-MOA397-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:46 INFO - Running setup.py (path:/tmp/pip-HrT2eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:46 INFO - Running setup.py (path:/tmp/pip-L6UmDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:46 INFO - Running setup.py (path:/tmp/pip-d3tELC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:46 INFO - Running setup.py (path:/tmp/pip-Q3FKed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:46 INFO - Running setup.py (path:/tmp/pip-m4y_TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:46 INFO - Running setup.py (path:/tmp/pip-cvW3Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:46 INFO - Running setup.py install for manifestparser 02:20:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:46 INFO - Running setup.py install for mozcrash 02:20:46 INFO - Running setup.py install for mozdebug 02:20:47 INFO - Running setup.py install for mozdevice 02:20:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for mozfile 02:20:47 INFO - Running setup.py install for mozhttpd 02:20:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for mozinfo 02:20:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for mozInstall 02:20:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for mozleak 02:20:47 INFO - Running setup.py install for mozlog 02:20:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for moznetwork 02:20:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:47 INFO - Running setup.py install for mozprocess 02:20:47 INFO - Running setup.py install for mozprofile 02:20:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:48 INFO - Running setup.py install for mozrunner 02:20:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:48 INFO - Running setup.py install for mozscreenshot 02:20:48 INFO - Running setup.py install for moztest 02:20:48 INFO - Running setup.py install for mozversion 02:20:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:48 INFO - Cleaning up... 02:20:48 INFO - Return code: 0 02:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:48 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')]} 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 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')]} 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:48 INFO - Using env: {'DISPLAY': ':0', 02:20:48 INFO - 'HOME': '/home/cltbld', 02:20:48 INFO - 'LANG': 'en_US.UTF-8', 02:20:48 INFO - 'LANGUAGE': 'en_US:en', 02:20:48 INFO - 'LOGNAME': 'cltbld', 02:20:48 INFO - 'MAIL': '/var/mail/cltbld', 02:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:48 INFO - 'MOZ_NO_REMOTE': '1', 02:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:48 INFO - 'NO_EM_RESTART': '1', 02:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:48 INFO - 'PWD': '/builds/slave/test', 02:20:48 INFO - 'SHELL': '/bin/bash', 02:20:48 INFO - 'SHLVL': '1', 02:20:48 INFO - 'TERM': 'linux', 02:20:48 INFO - 'TMOUT': '86400', 02:20:48 INFO - 'USER': 'cltbld', 02:20:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:48 INFO - '_': '/tools/buildbot/bin/python'} 02:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:48 INFO - Running setup.py (path:/tmp/pip-9fTWBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:48 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)) 02:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:48 INFO - Running setup.py (path:/tmp/pip-zrFZKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 02:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:48 INFO - Running setup.py (path:/tmp/pip-NpyxAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:48 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)) 02:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:48 INFO - Running setup.py (path:/tmp/pip-dKpdib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:49 INFO - Running setup.py (path:/tmp/pip-mBG8Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:49 INFO - Running setup.py (path:/tmp/pip-g5xpvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:49 INFO - Running setup.py (path:/tmp/pip-dkNXjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:49 INFO - Running setup.py (path:/tmp/pip-fG53OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:49 INFO - Running setup.py (path:/tmp/pip-LyWPTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:49 INFO - Running setup.py (path:/tmp/pip-9sOrdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:49 INFO - Running setup.py (path:/tmp/pip-iwLHVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:49 INFO - Running setup.py (path:/tmp/pip-_WoNWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:49 INFO - Running setup.py (path:/tmp/pip-SfeRF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:49 INFO - Running setup.py (path:/tmp/pip-66_eZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:49 INFO - Running setup.py (path:/tmp/pip-WlU_kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:49 INFO - Running setup.py (path:/tmp/pip-HO8N_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:49 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)) 02:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:49 INFO - Running setup.py (path:/tmp/pip-cFaHG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:49 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)) 02:20:49 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:49 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:49 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)) 02:20:49 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:49 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:49 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 02:20:49 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 02:20:49 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 02:20:49 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 02:20:49 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 02:20:49 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 02:20:51 INFO - Downloading blessings-1.6.tar.gz 02:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:51 INFO - Installing collected packages: blessings 02:20:51 INFO - Running setup.py install for blessings 02:20:52 INFO - Successfully installed blessings 02:20:52 INFO - Cleaning up... 02:20:52 INFO - Return code: 0 02:20:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:52 INFO - Reading from file tmpfile_stdout 02:20:52 INFO - Current package versions: 02:20:52 INFO - argparse == 1.2.1 02:20:52 INFO - blessings == 1.6 02:20:52 INFO - blobuploader == 1.2.4 02:20:52 INFO - docopt == 0.6.1 02:20:52 INFO - manifestparser == 1.1 02:20:52 INFO - mozInstall == 1.12 02:20:52 INFO - mozcrash == 0.17 02:20:52 INFO - mozdebug == 0.1 02:20:52 INFO - mozdevice == 0.48 02:20:52 INFO - mozfile == 1.2 02:20:52 INFO - mozhttpd == 0.7 02:20:52 INFO - mozinfo == 0.9 02:20:52 INFO - mozleak == 0.1 02:20:52 INFO - mozlog == 3.2 02:20:52 INFO - moznetwork == 0.27 02:20:52 INFO - mozprocess == 0.22 02:20:52 INFO - mozprofile == 0.28 02:20:52 INFO - mozrunner == 6.11 02:20:52 INFO - mozscreenshot == 0.1 02:20:52 INFO - mozsystemmonitor == 0.3 02:20:52 INFO - moztest == 0.7 02:20:52 INFO - mozversion == 1.4 02:20:52 INFO - psutil == 3.1.1 02:20:52 INFO - requests == 1.2.3 02:20:52 INFO - wsgiref == 0.1.2 02:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:52 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')]} 02:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:52 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')]} 02:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:52 INFO - Using env: {'DISPLAY': ':0', 02:20:52 INFO - 'HOME': '/home/cltbld', 02:20:52 INFO - 'LANG': 'en_US.UTF-8', 02:20:52 INFO - 'LANGUAGE': 'en_US:en', 02:20:52 INFO - 'LOGNAME': 'cltbld', 02:20:52 INFO - 'MAIL': '/var/mail/cltbld', 02:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:52 INFO - 'MOZ_NO_REMOTE': '1', 02:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:52 INFO - 'NO_EM_RESTART': '1', 02:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:52 INFO - 'PWD': '/builds/slave/test', 02:20:52 INFO - 'SHELL': '/bin/bash', 02:20:52 INFO - 'SHLVL': '1', 02:20:52 INFO - 'TERM': 'linux', 02:20:52 INFO - 'TMOUT': '86400', 02:20:52 INFO - 'USER': 'cltbld', 02:20:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:52 INFO - '_': '/tools/buildbot/bin/python'} 02:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:52 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 2)) 02:20:52 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 3)) 02:20:52 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 4)) 02:20:52 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 5)) 02:20:52 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 6)) 02:20:52 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 7)) 02:20:52 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 8)) 02:20:52 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 9)) 02:20:52 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:52 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 4)) 02:20:52 INFO - Cleaning up... 02:20:52 INFO - Return code: 0 02:20:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:52 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')]} 02:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:52 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')]} 02:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:52 INFO - Using env: {'DISPLAY': ':0', 02:20:52 INFO - 'HOME': '/home/cltbld', 02:20:52 INFO - 'LANG': 'en_US.UTF-8', 02:20:52 INFO - 'LANGUAGE': 'en_US:en', 02:20:52 INFO - 'LOGNAME': 'cltbld', 02:20:52 INFO - 'MAIL': '/var/mail/cltbld', 02:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:52 INFO - 'MOZ_NO_REMOTE': '1', 02:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:52 INFO - 'NO_EM_RESTART': '1', 02:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:52 INFO - 'PWD': '/builds/slave/test', 02:20:52 INFO - 'SHELL': '/bin/bash', 02:20:52 INFO - 'SHLVL': '1', 02:20:52 INFO - 'TERM': 'linux', 02:20:52 INFO - 'TMOUT': '86400', 02:20:52 INFO - 'USER': 'cltbld', 02:20:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:52 INFO - '_': '/tools/buildbot/bin/python'} 02:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:52 INFO - Downloading/unpacking jsonschema 02:20:52 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 02:20:52 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 02:20:52 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 02:20:52 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 02:20:52 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 02:20:52 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 02:20:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:54 INFO - Downloading/unpacking functools32 (from jsonschema) 02:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:54 INFO - warning: no files found matching '*.txt' 02:20:54 INFO - no previously-included directories found matching 'build' 02:20:54 INFO - no previously-included directories found matching 'dist' 02:20:54 INFO - no previously-included directories found matching '.git*' 02:20:54 INFO - Installing collected packages: jsonschema, functools32 02:20:54 INFO - Running setup.py install for functools32 02:20:55 INFO - warning: no files found matching '*.txt' 02:20:55 INFO - no previously-included directories found matching 'build' 02:20:55 INFO - no previously-included directories found matching 'dist' 02:20:55 INFO - no previously-included directories found matching '.git*' 02:20:55 INFO - Successfully installed jsonschema functools32 02:20:55 INFO - Cleaning up... 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:20:55 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')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 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')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fe458cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2833770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, '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': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', '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 02:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 02:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 INFO - Downloading/unpacking flake8 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:55 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 02:20:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:20:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:20:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 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 02:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:57 INFO - no previously-included directories found matching 'docs/_build' 02:20:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:20:57 INFO - Running setup.py install for pep8 02:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:20:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:20:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:20:58 INFO - no previously-included directories found matching 'docs/_build' 02:20:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:20:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:20:58 INFO - Cleaning up... 02:20:58 INFO - Return code: 0 02:20:58 INFO - Running post-action listener: _resource_record_post_action 02:20:58 INFO - Running post-action listener: _start_resource_monitoring 02:20:58 INFO - Starting resource monitoring. 02:20:58 INFO - ##### 02:20:58 INFO - ##### Finished create-virtualenv step (success) 02:20:58 INFO - ##### 02:20:58 INFO - ##### 02:20:58 INFO - ##### Running install step. 02:20:58 INFO - ##### 02:20:58 INFO - Running pre-action listener: _resource_record_pre_action 02:20:58 INFO - Running main action method: install 02:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:58 INFO - Reading from file tmpfile_stdout 02:20:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:58 INFO - Reading from file tmpfile_stdout 02:20:58 INFO - Output received: 02:20:58 INFO - Usage: mozinstall [options] installer 02:20:58 INFO - Options: 02:20:58 INFO - -h, --help show this help message and exit 02:20:58 INFO - -d DEST, --destination=DEST 02:20:58 INFO - Directory to install application into. [default: 02:20:58 INFO - "/builds/slave/test"] 02:20:58 INFO - --app=APP Application being installed. [default: firefox] 02:20:58 INFO - mkdir: /builds/slave/test/build/application 02:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:21:14 INFO - Reading from file tmpfile_stdout 02:21:14 INFO - Output received: 02:21:14 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:14 INFO - Running post-action listener: _resource_record_post_action 02:21:14 INFO - ##### 02:21:14 INFO - ##### Finished install step (success) 02:21:14 INFO - ##### 02:21:14 INFO - ##### 02:21:14 INFO - ##### Running run-tests step. 02:21:14 INFO - ##### 02:21:14 INFO - Running pre-action listener: _resource_record_pre_action 02:21:14 INFO - Running main action method: run_tests 02:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:14 INFO - Python 2.7.3 02:21:14 INFO - Return code: 0 02:21:14 INFO - grabbing minidump binary from tooltool 02:21:14 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')]} 02:21:14 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c29c0>, '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 0x28c38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:14 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 02:21:14 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 02:21:14 INFO - Calling ['/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'] with output_timeout 600 02:21:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:14 INFO - Return code: 0 02:21:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:21:15 INFO - Return code: 0 02:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:21:15 INFO - Using env: {'DISPLAY': ':0', 02:21:15 INFO - 'HOME': '/home/cltbld', 02:21:15 INFO - 'LANG': 'en_US.UTF-8', 02:21:15 INFO - 'LANGUAGE': 'en_US:en', 02:21:15 INFO - 'LOGNAME': 'cltbld', 02:21:15 INFO - 'MAIL': '/var/mail/cltbld', 02:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:15 INFO - 'MOZ_NO_REMOTE': '1', 02:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:15 INFO - 'NO_EM_RESTART': '1', 02:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:15 INFO - 'PWD': '/builds/slave/test', 02:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:15 INFO - 'SHELL': '/bin/bash', 02:21:15 INFO - 'SHLVL': '1', 02:21:15 INFO - 'TERM': 'linux', 02:21:15 INFO - 'TMOUT': '86400', 02:21:15 INFO - 'USER': 'cltbld', 02:21:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422', 02:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:15 INFO - '_': '/tools/buildbot/bin/python'} 02:21:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:21:15 INFO - mozversion application_buildid: 20160517065136 02:21:15 INFO - mozversion application_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 02:21:15 INFO - mozversion application_display_name: Nightly 02:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:15 INFO - mozversion application_name: Firefox 02:21:15 INFO - mozversion application_remotingname: firefox 02:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:21:15 INFO - mozversion application_vendor: Mozilla 02:21:15 INFO - mozversion application_version: 49.0a1 02:21:15 INFO - mozversion platform_buildid: 20160517065136 02:21:15 INFO - mozversion platform_changeset: 3780a3a6b83aeda143f9562829c830410a0c961e 02:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:21:15 INFO - mozversion platform_version: 49.0a1 02:21:15 INFO - using testdate: 1463649675 02:21:15 INFO - actual date: 1463649675 02:21:15 INFO - starting webserver on 'localhost:37760' 02:21:15 INFO - SUITE-START | Running 2 tests 02:21:15 INFO - TEST-START | dromaeo_css 02:21:15 INFO - operating with platform_type : linux_ 02:21:15 INFO - Initialising browser for dromaeo_css test... 02:21:15 INFO - TEST-INFO | started process 10874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkCuWU/profile http://localhost:37760/getInfo.html) 02:21:19 INFO - PROCESS | 10874 | __metrics Screen width/height:1600/1200 02:21:19 INFO - PROCESS | 10874 | colorDepth:24 02:21:19 INFO - PROCESS | 10874 | Browser inner width/height: 1024/697 02:21:19 INFO - PROCESS | 10874 | __metrics 02:21:20 ERROR - PROCESS | 10874 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:21:21 INFO - TEST-INFO | 10874: exit 0 02:21:21 INFO - Browser initialized. 02:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:21 INFO - TEST-INFO | started process 10956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbkCuWU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:33 INFO - PROCESS | 10956 | RSS: Main: 154021888 02:21:33 INFO - PROCESS | 10956 | 02:22:24 INFO - PROCESS | 10956 | 1463649744798 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] 02:24:37 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37760/tests/dromaeo/cssquery-ext.html) 02:24:38 INFO - PROCESS | 10956 | RSS: Main: 252141568 02:24:38 INFO - PROCESS | 10956 | 02:27:41 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-ext.html (next: http://localhost:37760/tests/dromaeo/cssquery-jquery.html) 02:27:41 INFO - PROCESS | 10956 | RSS: Main: 239190016 02:27:41 INFO - PROCESS | 10956 | 02:30:43 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37760/tests/dromaeo/cssquery-mootools.html) 02:30:44 INFO - PROCESS | 10956 | RSS: Main: 236879872 02:30:44 INFO - PROCESS | 10956 | 02:33:46 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37760/tests/dromaeo/cssquery-prototype.html) 02:33:47 INFO - PROCESS | 10956 | RSS: Main: 232251392 02:33:47 INFO - PROCESS | 10956 | 02:36:50 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37760/tests/dromaeo/cssquery-yui.html) 02:36:50 INFO - PROCESS | 10956 | RSS: Main: 224804864 02:36:50 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | Cycle 1(1): loaded http://localhost:37760/tests/dromaeo/cssquery-yui.html (next: http://localhost:37760/tests/dromaeo/cssquery-dojo.html) 02:39:53 INFO - PROCESS | 10956 | RSS: Main: 282218496 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | __start_tp_report 02:39:53 INFO - PROCESS | 10956 | _x_x_mozilla_page_load 02:39:53 INFO - PROCESS | 10956 | _x_x_mozilla_page_load_details 02:39:53 INFO - PROCESS | 10956 | |i|pagename|runs| 02:39:53 INFO - PROCESS | 10956 | |0;dojo.html;2636.670416197975;2638.2876623311695;2677.718839521851;2689;2697.352635367511;4640.976795116019;4643.396358473398;4709.411323584552;4734.928976065362;4787.760611969401;4631.884202894921;4683.391159149314;4713.622910167187;4737.526247375261;4746.7863946122425;4217.536071032192;4262.744235345874;4279.507856596485;4336.804843782022;4470.463544374663;4366.235908715962;4420.226460369422;4444.777761111932;4462.263726485126;4466.57567531084;4210.5157906840495;4248.851290204828;4252.9149417011795;4287.764172970486;4292.334688123346;4282.721623094489;4292.849750258726;4300.78496075195;4302.849400270976;4307.246231909403;4239.618434340924;4241.257779888507;4266.445362102938;4273.1240095780295;4287.2711639021445;4587.931181032287;4598.931016034762;4630.467496237909;4665.346851440767;4669.112868554964;4875.024995000978;5024.070546948826;5073.568746656501;5073.568746656501;5082.542571168576;5051;5083.110455670243;5101.846944591668;5126.436092029874;5164.870878228036;4756.167670657655;4786.617070634341;4789.353437285991;4794.904101918012;4812;5063.5695965843315;5097.209932460474;5223.608229382811;5264.105102132647;5270.578353731692;4927.87680307988;4940.7035577865445;4967.230079337708;5009.273655320031;5010.799568017239;5039.143345631252;5039.672421292605;5044.9495505045215;5046;5098.005888851712;4853.102176097434;4909.3126962225315;4942.332785074041;4994.1759609663995;5004.299398084271;4932.778024988884;4951;4953.6532442729385;4955.677880937727;4989.950100499022;4240.809163587646;4241.97879010603;4243.724157929786;4275.5724427557;4290.592393722592;3680.392735198662;3717.4795528626014;3722.7952462614817;3739.121306492972;3748.962510374916;4324.3513472978675;4345;4349.760763158057;4385.7149285296355;4388.407564978751;5033.219850923113;5069.9746501267255;5071.4928507149725;5072.163093089673;5120.871978200575;4246.235677578065;4275.743455392686;4304.311310190355;4308.46144231971;4334.718243314174;4493.932591011137;4498.865034048984;4512.729236245836;4525.208088584484;4555.043440877386;4716.1510928033285;4716.386869707053;4721.952780472151;4731.384919960383;4779.044191161782;4904.2643603459765;4929.1866841972105;5001.074801161797;5051.974740126276;5107.744612769421;4750.928736068892;4766.261229509293;4776.8566942991765;4809.44691360498;4811.927821082757;4969.676970996874;4979.726115063706;4981.227909674007;4982.601391888713;5034.773435195351;4912.1649319615035;4916.041371932439;4945.826896058765;4947.876303092451;5002.474740152232;4834.371531700997;4838.225883858566;4841.443234027991;4842.539958703917;4883;4832.323474713613;4850.369451971221;4851.393575803025;4854.126257273583;4900.681455705368;4722.622190224705;4857.805687772591;4910.8772280693265;4921.606271498343;4982.252662100714;5017.397912250553;5023.623228257822;5024.522670346311;5055.595552355876;5058.038972595195;4690.765461726968;4907.77914993819;4928.901421971612;4931.482194369683;4986.476419975996 02:39:53 INFO - PROCESS | 10956 | |1;ext.html;552.8534938241364;588.6085752974273;599.8830228105519;605.8095841671116;612.5497759147026;42750.78624606877;44765.328520072224;44808.999999999956;44875.77562112193;49139;43714.78142609291;44276.3358549622;44315.55684443154;44330.11339773203;44395;7702.46082774206;7869.881951770728;7870.803229919269;8052.315553177972;8236.299914507244;7787.493812902171;10263.692089237335;10514.106300964428;10537.68386948389;10844;10458.9477052615;10496.160307175445;10507.054365107138;10508;10510.737231569234;7816.49192802466;10264.281500294983;10446.79106417875;10511.369317840954;10520.999999999962;10050.849237261447;10379.273450858444;10382.740431489197;10385.89614103857;10386.636467723594;38926;39339.8033009836;39341.213175736324;39353.60646393557;39423.21153576941;3327.900162995114;3361.462166053444;3432.9485057724155;3630.455431685242;3931.6658084062888;28163;29211.70788292111;29702.85148574265;29843.850780746176;30245.395092098253;3461.2212252243294;3521.683048525645;3600.117971097072;3602.0994751312173;3606.2607165531003;264823;266202;266394;266419;266836;58621;59998.40009599438;60142.39857601368;60159.398406016255;60195;36043;37047.66571008622;37098.81450592784;39093.80453097716;56077.719611401684;15707.214639267992;15852.603684907739;15866.603334916488;15868.04791712501;15873.841261587468;10733.731656708645;12256.877431225752;12342.81485777714;12495.562655307021;13037.217766934014;19944.70082948757;20230.29193978233;20261.797382026285;20350.18599256013;20401.591968160552;7256.709731610782;7302.817429564303;7316.926830731731;7330.193344088529;7416.666250018762;826.4215049465398;934.4766930518931;955.5126885288553;983.7884854756119;1076.4402510694395;27534.44931101367;27749.167524974284;27795.166145015683;27818.165455036382;28024;960;984.4339504784778;1021.6577446555488;1040.6409788622914;1122.5117074072805;13575.32123393846;14134.858651413355;14222;14551.490697825526;14684.339204735812;367840;370565;370872;371078;371715;54334.45665543294;55000;55025.44974550283;55027.17459238115;55062.449375506534;1125.8648962124598;1132.1791701016698;1263.3493750718203;1286.9034822388357;1295.2746461981321;27967.300817479725;30517.694823051486;30566.388672225985;30907.227319317197;31401.8429907849;45288.32067518924;45816.77091614521;45843.083138337715;45885.77057114693;45907.54092459166;245765;251065;251337;251376;252482;24049;26580.202593922215;27113.45773084567;27272.59091113595;27382.178534643994;44299.11401772011;44781.55218447774;45525;45630;46059.53940460687;37244.81377593095;38711.419328709526;38759.6124038756;39155.41266880942;39690.2061958765;37530;37864.81067594644;38818;39159.6084039156;39242.41136382899;37389.25221495609;37922.43116353312;38027.42958855675;38288.23423531458;38295.04262393463;33400;33943.727995372996;34761;35004;35214.823925880206;26352.736472635796;26626.467470650867;27214.863925680245;28461.715382845905;28620.713792861803 02:39:53 INFO - PROCESS | 10956 | |2;jquery.html;377.9433085037245;386.08112691793525;389.22349911925704;399.7361741250775;400.3374415342609;16141.273642686077;17471.301147954066;18626.534336641573;18637.627247455075;18641.906790466062;17491.562710932234;17625.383111591098;18181.636367272647;18326.725099123523;18340.541486462844;5096.362954630671;5171.56041736451;5226.346706661668;5242.187460943541;5280.313559237294;3634.963650363502;5645.887082258352;5938.46553810157;5940.435658612447;6044.304904935922;5220.295260139889;5967.313758917737;5972.6715030673295;5977.850553736148;6003.159557661931;3512.5609298837644;5403.297571315743;5493;5528.834134975958;5542.501174894259;4976.35307410038;5287.206918962186;5312.681239125664;5405.486478784548;5409.107497262947;20091.39725808228;20286.188552457883;21055.789442105535;21468;21487.355379338645;1977.9208831646717;1986.7119267706246;2053.743282089739;2357.6817129687443;2525.936851578707;9459.52702364886;9514.476703781289;9806.90193098067;11413.48639311233;13005.154664946844;1819.954501137469;1821;1821.8997955112463;1852.786424891698;1853.1938606705992;67540.3245967539;70063.64968175127;70470.99999999949;71420.28579714189;71934;10044.246681498917;10358.585656573803;10426.895731042745;10499.737506562396;10738.94630526858;14625.561233162809;14710;14732.926335368255;14740.557783266519;14754.188519631309;7483.438742094365;7643.617819109022;7655.961720191363;7785.727499537489;7837.882431763528;7379.298966598165;7387.076615423072;7429.517081389692;7497.962510187524;7500.437467189982;4498.460184777782;4546.227141385973;4604.815807367735;4619.538046195354;4671.32265821454;1720.9741853872201;1783.785945686526;1888.792232854385;1910.808919108078;1937.8837269763578;880.264978742757;943.1464524605243;948.4451595816524;948.6584829461389;1006.1900170362928;16707.83292167087;16975;17139.400120995706;17660.381886633906;17804.109794510223;887.6138879587401;899.078444594283;916.5554705967601;916.6929078758557;928.2295694573488;9472.194863436685;9853.113219810251;9866.260030497742;9946.502674866228;10003.299769016245;372883;374445;382091;384735;384867;46697;70736.64631676809;73645;74289;74569;908.3232991421434;929.1266209762802;929.4748467116058;936.9297302702324;941.990580094204;15154.3180556873;15349.155796430858;15513.301901414237;15626.734123552249;15902.920485397963;32529.186770330933;33016.83491582527;33106.50340244947;34793;36388.27223455463;49882.50117498779;50523.74738126286;51058.74470627623;51210.15923805804;51366.48633513617;6981.301869812978;7348.412127029932;7477.66350514239;7560.810979725551;7701.037370328709;11983.940080299542;12312.26126432417;12369.443375047964;12423.937880310541;12471.438785254866;8539.462896678657;10607.20445966571;10691.839622405825;10757.246992710436;11118.777624447304;10636.255462117577;10821.51303191374;10854.131669466582;10865.69663979899;10870;10318.277720559488;10705;11017.614383496539;11099.334039957306;11194.104471642411;6965.094537710268;7263.709451622088;7358.006230529595;7492.550446973199;7747.418943579367;8302.294304984143;10502.789944201226;10606.098481629147;10635.89364106349;11037.889621103686 02:39:53 INFO - PROCESS | 10956 | |3;mootools.html;1293.922364658121;1501.1593507635725;1546.6288090858193;1703.7188863837468;1856.9442916712494;6725.461963042957;7604.277593628603;7830.138684744674;7833.412494062954;8067.5159490430615;7740;7907.090684571262;7912.604369781502;7913;7913.446058775874;2196.286206982733;2230.119102954332;2236.105557776886;2238.921637742679;2241.081156725743;2174.152080688533;2202.1631779923605;2206.8896555172178;2209.5249521352907;2210.8673479591193;2185.0495034659893;2188.4966457714736;2193.2104442400723;2194.122351059581;2225.343523660516;2127.6914847347202;2135.29535253366;2135.5728854229137;2144.2173606633623;2145.3885642591863;2107.3045894854663;2145.0347343695244;2145.356393082069;2146.3239079689847;2148.559545293211;7575.772726818149;7817.843643127106;7860.842783144305;7919.247671471258;7927.167647396998;4565.6347492200875;4656.627469802408;4662.417197850269;4665.300204969248;4671.532846715335;2965.4365670522534;3003.714647108521;3023.425549145655;3030.1667041563746;3078.9846050769825;891.3404080980093;895.6820328783253;913.9680111196076;929.6374413978554;946.4841661294611;10161.441120738356;10177.287589868713;10178.083972442442;10197.847032294521;10207.438590877498;3895.4741109949796;3973.0663294125857;3993.101552150743;4043.1509383029893;4043.575424580377;8207.7948051298;8210.507369557727;8227.13615070421;8266.214709602578;8282.420230583923;4459.620932220798;4461.24158892989;4466.2630665940405;4466.39703640011;4467.620252278528;3788.412796016622;4071.246819338432;4089.1208390196252;4179.665626749853;4236.724612900151;3388.762786604914;3389.6610338966398;3446.362422951762;3473.2879759649213;3581.982090089585;1003.6738060130486;1013.5287091502339;1022.6114076650825;1024.779672370444;1030.9587616495255;900.9278063154505;914.8033172867732;932.2728271947756;941.026038050628;942.2744486745167;5339.813106541253;5528.695921724344;5595.300587426572;5694.971525142348;5846.824595262149;941.5245301122889;954.7947191353753;962.5427921737258;981.8379967305458;997.8553109799184;3722.3113723960614;3795.8291876865605;3810.123671555558;3839.9424008639894;3967.0875698589484;9015.233705135137;9303.25573954082;9373.109554592304;9377.156055954996;9401.529923503798;9037.593308301142;9302.813943721223;9323.160915517636;9336.39313444624;9397.248220142372;7301.269873012656;7399.889001664979;7429;7462.029936108272;7473.252674732484;5483.506484416422;5632.324121105494;5702.40124786908;5724.685142317213;5735.713214339183;8750.562471876254;8860.512671802855;8862.291016718777;8886;8888.333374996771;8704.129587041245;8900.243479304332;8930.19628233462;9139.497327647043;9149.359544831797;6136.20229370179;6605.47156227491;6779.762708305186;6874.793756187322;6997.965010174917;7553.546787192786;7589.279018493235;7625.199354067743;7630.084389873251;7656.119546252252;6783.626900520321;6934.861302773816;6950.721971121098;7017.754378596725;7071.045408869737;6527.869442611216;6553.541252112306;6574.441172500391;6595.472362211108;6626.039224312544;6217.782377616762;6255.53083518747;6316.62100273985;6319.431251187231;6333.20834895638;4739.715617062987;4753.263244197016;4867.878303042452;4896.583790377716;4933.235348520985;4832.758362081952;4880.389951256093;4903.779329930233;4915.778789954532;4990.001999600167 02:39:53 INFO - PROCESS | 10956 | |4;prototype.html;288.6709151567214;294.41117764471073;294.80542841724457;296.5670121622431;297.81981900949927;4829.734364609945;4833.178359678855;4890.926636100461;4896.849240428501;4923.82766603169;4809.326694262806;4828.348172996644;4828.493008234129;4828.661993660445;4846.200376937801;3586.8923932282073;3698.3712768829228;3718.609545997672;3781.4664175002813;3825.61743825618;3776.244751049801;3783.6216378362083;3794.165283637595;3799.620037996206;3805.1248212911046;3572.821358932056;3758.473813666089;3768.773873567581;3772.188979369435;3775.2826962876966;3560.394732895388;3662.505561749156;3697.5378077740415;3697.7411581189326;3732.64539868712;3301.2833326669997;3329;3339.3989081965237;3342.4484959981573;3351.173610382323;4629.537046295377;4631.078102587422;4650.720956742606;4681.836135735267;4711.575958163782;4191.476065491814;4234.734417086844;4291.206126866539;4311.267084595626;4319.546447623017;5027.195648696191;5049.873753156164;5056.191009438509;5058.595312375001;5103.770330335144;3652.3060618482405;3655.963440365589;3657.012606596231;3661.1030297577;3663.249033948034;5131.7434128293435;5274.55166310864;5305.575553955674;5317.41508434072;5364.517193452569;3675.2358867743633;3695.593484716679;3697.6487233712755;3698.8890333290046;3706.832347810431;3728.5458671118286;3740.2893450244364;3749.1564398010228;3750.2686976039954;3761.3793724035777;4236.724612900151;4255.127698821734;4263.850765223202;4264;4265.573442655709;4858.692690659614;5039.269305950616;5045.621578381636;5057.620678449131;5074.949250507448;1315.5855905389772;1318.6352125550009;1322.307446468522;1327.4093028602178;1332.9269937700244;832.4339449174498;855.2901092093548;861.3152543727751;870.2602787630464;871.7559083456642;4361.80371883266;4500.797464114123;4506.324051392317;4515.14212299662;4526.977365113219;5257.658252213594;5274.657147285414;5275.86568887691;5284.7886084556185;5285.418603953562;4498.977505112453;4515.841945531891;4518.2319005769095;4526.524714904954;4529.297958816389;2636.670416197975;2822.4778415993105;2826.23691603266;2831.4903317403064;2833.220864262303;4948.975255123773;4953.554180123806;4958.429780575208;4985.601151907838;4989;5186.533212010937;5381.165919282517;5391.919121213185;5409.350877894678;5412.296401467784;4931.334269873593;4937.987712518925;4952.950470495321;4959.702417855013;4969.204927211629;5281.551068159096;5291.629585928948;5291.830349556663;5294.152935530296;5309.194873742946;5020.6234532410945;5149.794008239628;5176.592884308814;5188.58491320701;5195.064888320138;4927.778249978831;4933.654644174873;4935.4570997190995;4935.555799978019;4941.33292005589;3305.438075527118;3347.3807345641135;3352.3127758809874;3400.9149771255916;3410.9829450852585;4657.48767635553;4719.551642593948;4730.763461826964;4735.786889589908;4963.553280204799;5110.437851836369;5130.204818253177;5132;5133.127368347465;5141;5086.855457522028;5102.770375333193;5120.923186152137;5121.74391280442;5130.461301563282;4805.5915247204375;5036.269740887624;5040.899182016413;5049.596032317332;5050.696958182521;4940.654154209171;5063.87317326731;5082.593392528515;5083.669561478492;5170.224466330081;4931.002943807764;4968.726720030433;4978.30303757467;4986.227134794112;5048.7728052237 02:39:53 INFO - PROCESS | 10956 | |5;yui.html;732.2933369298628;739.0023468317771;740.3041141327152;759.9886001709975;807.9232472915071;12815.102942793996;13223.404946777395;13731.65670858229;13742.725145497085;13800.585982420544;12824.871751282484;12855.100142989995;12934.611961641142;12962.157459765109;13007.804882926765;679.857229981702;856.7429771068686;872.8777971084053;886.0652012127204;888.3248730964481;865.1953683074738;875.4309698695866;876.2595606712318;876.5047748022379;876.5573385440343;915.2860768600502;920.4155361345561;920.5949382271779;920.8204400141975;922.1331947968921;704.1303989572873;882.6734108379876;905.3345790843724;913.0869130869131;913.2055112052524;677.8712044711489;677.8745932002595;678.1827897383641;678.4504551313452;678.7149397253116;12837.165584236995;12977.35113244334;12977.545785897542;12979.091463597551;12999.87000129996;12323.383830808423;12760.680982975407;12826.23042617446;12928.676783080404;12943.91732459857;11113;11157.553697852076;11205.21563490556;11238.438078096062;11403.315801051964;4128.967758060485;4129.236091323115;4139.461869956886;4162.7502349859105;4168.8332466701295;45352.546474535164;45757.62727118192;46319;46466.76766616145;46564.7671761639;10140.543675534618;10206.4386458744;10240.590376385011;10293;10449.634262800766;18294.08529573516;18295.54261143482;18306.542336441697;18325.816741832678;18331.725024124647;6513.153290072355;6587.769428069994;6708.228553716385;6766.49251306154;6918.238993710688;3535.699465545406;3656.3784156693428;3728.5831384073877;3776.376897811885;3814.3515602347666;2787.4007088476073;2876.3384421582737;2892.2769307673084;2892.754115900172;2892.8842846286334;487.1839668555156;488.3919520197306;489.20015774208713;505.3228673577424;506.0233748864653;509.86998315429327;556.9220309156722;594.2542109652445;628.1080865171467;641.4579680170249;7870.72452464161;7956.761297161094;7967.8406431871035;7983.5209887406945;8120.147384524658;513.6661170239374;612.984675383119;644.690548536705;658.2660333727858;658.2890478283442;3713.5729391119826;3742.214135031619;3816.065064059323;3832.463455116286;3846.480725102075;57180.14229786557;57790.711046445336;57901;57992.13011804826;58199.709001455565;52157.478425216024;52527.47472525302;53495.732521337144;54046;54976.72511637416;47609.285860712116;47906.76046619745;48044.27933580999;48561;48757.75621121943;7508;7606.569715335417;7738.613069346397;7801.1808760079375;7957.084935232291;31871.681283187798;31912.8404357986;31931.840340799077;32309.676903230666;32410.351792963538;38995.805020974716;41170;41276.38085428661;41574.792126039174;43100.56899431091;9882.950585247316;9900;9957.601695932372;10011.199104071802;10024.649137280161;10397.948010259901;10699.679009629723;10737.332695984665;10880.564777408816;11099.278546894426;8701.912980870111;8868.600912959062;10057.263606959592;11368.204225704452;11860.34768087729;11153.609623663133;11749;11763.764724705628;11860.40697965081;12172.14794964344;11159.832602510807;11327.830082548604;11676.416179191176;11695.532178712756;11926.522939082339;9312.953435232781;9345.813073744137;9366.325165258526;9420;9795.804083918425;9675.951620242135;9991.200703943521;10025.799484010133;10038.698839034842;10088.243381746252 02:39:53 INFO - PROCESS | 10956 | __end_tp_report 02:39:53 INFO - PROCESS | 10956 | __start_cc_report 02:39:53 INFO - PROCESS | 10956 | _x_x_mozilla_cycle_collect,931 02:39:53 INFO - PROCESS | 10956 | __end_cc_report 02:39:53 INFO - PROCESS | 10956 | __startTimestamp1463650793845__endTimestamp 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | ------- Summary: start ------- 02:39:53 INFO - PROCESS | 10956 | Number of tests: 6 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#0] dojo.html Cycles:165 Average:4650.73 Median:4789.35 stddev:487.76 (10.2%) stddev-sans-first:462.96 02:39:53 INFO - PROCESS | 10956 | Values: 2636.7 2638.3 2677.7 2689.0 2697.4 4641.0 4643.4 4709.4 4734.9 4787.8 4631.9 4683.4 4713.6 4737.5 4746.8 4217.5 4262.7 4279.5 4336.8 4470.5 4366.2 4420.2 4444.8 4462.3 4466.6 4210.5 4248.9 4252.9 4287.8 4292.3 4282.7 4292.8 4300.8 4302.8 4307.2 4239.6 4241.3 4266.4 4273.1 4287.3 4587.9 4598.9 4630.5 4665.3 4669.1 4875.0 5024.1 5073.6 5073.6 5082.5 5051.0 5083.1 5101.8 5126.4 5164.9 4756.2 4786.6 4789.4 4794.9 4812.0 5063.6 5097.2 5223.6 5264.1 5270.6 4927.9 4940.7 4967.2 5009.3 5010.8 5039.1 5039.7 5044.9 5046.0 5098.0 4853.1 4909.3 4942.3 4994.2 5004.3 4932.8 4951.0 4953.7 4955.7 4990.0 4240.8 4242.0 4243.7 4275.6 4290.6 3680.4 3717.5 3722.8 3739.1 3749.0 4324.4 4345.0 4349.8 4385.7 4388.4 5033.2 5070.0 5071.5 5072.2 5120.9 4246.2 4275.7 4304.3 4308.5 4334.7 4493.9 4498.9 4512.7 4525.2 4555.0 4716.2 4716.4 4722.0 4731.4 4779.0 4904.3 4929.2 5001.1 5052.0 5107.7 4750.9 4766.3 4776.9 4809.4 4811.9 4969.7 4979.7 4981.2 4982.6 5034.8 4912.2 4916.0 4945.8 4947.9 5002.5 4834.4 4838.2 4841.4 4842.5 4883.0 4832.3 4850.4 4851.4 4854.1 4900.7 4722.6 4857.8 4910.9 4921.6 4982.3 5017.4 5023.6 5024.5 5055.6 5058.0 4690.8 4907.8 4928.9 4931.5 4986.5 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#1] ext.html Cycles:180 Average:46748.87 Median:19368.25 stddev:78623.06 (405.9%) stddev-sans-first:78767.11 02:39:53 INFO - PROCESS | 10956 | Values: 552.9 588.6 599.9 605.8 612.5 42750.8 44765.3 44809.0 44875.8 49139.0 43714.8 44276.3 44315.6 44330.1 44395.0 7702.5 7869.9 7870.8 8052.3 8236.3 7787.5 10263.7 10514.1 10537.7 10844.0 10458.9 10496.2 10507.1 10508.0 10510.7 7816.5 10264.3 10446.8 10511.4 10521.0 10050.8 10379.3 10382.7 10385.9 10386.6 38926.0 39339.8 39341.2 39353.6 39423.2 3327.9 3361.5 3432.9 3630.5 3931.7 28163.0 29211.7 29702.9 29843.9 30245.4 3461.2 3521.7 3600.1 3602.1 3606.3 264823.0 266202.0 266394.0 266419.0 266836.0 58621.0 59998.4 60142.4 60159.4 60195.0 36043.0 37047.7 37098.8 39093.8 56077.7 15707.2 15852.6 15866.6 15868.0 15873.8 10733.7 12256.9 12342.8 12495.6 13037.2 19944.7 20230.3 20261.8 20350.2 20401.6 7256.7 7302.8 7316.9 7330.2 7416.7 826.4 934.5 955.5 983.8 1076.4 27534.4 27749.2 27795.2 27818.2 28024.0 960.0 984.4 1021.7 1040.6 1122.5 13575.3 14134.9 14222.0 14551.5 14684.3 367840.0 370565.0 370872.0 371078.0 371715.0 54334.5 55000.0 55025.4 55027.2 55062.4 1125.9 1132.2 1263.3 1286.9 1295.3 27967.3 30517.7 30566.4 30907.2 31401.8 45288.3 45816.8 45843.1 45885.8 45907.5 245765.0 251065.0 251337.0 251376.0 252482.0 24049.0 26580.2 27113.5 27272.6 27382.2 44299.1 44781.6 45525.0 45630.0 46059.5 37244.8 38711.4 38759.6 39155.4 39690.2 37530.0 37864.8 38818.0 39159.6 39242.4 37389.3 37922.4 38027.4 38288.2 38295.0 33400.0 33943.7 34761.0 35004.0 35214.8 26352.7 26626.5 27214.9 28461.7 28620.7 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#2] jquery.html Cycles:180 Average:23969.67 Median:387.65 stddev:62573.60 (16141.7%) stddev-sans-first:62724.06 02:39:53 INFO - PROCESS | 10956 | Values: 377.9 386.1 389.2 399.7 400.3 16141.3 17471.3 18626.5 18637.6 18641.9 17491.6 17625.4 18181.6 18326.7 18340.5 5096.4 5171.6 5226.3 5242.2 5280.3 3635.0 5645.9 5938.5 5940.4 6044.3 5220.3 5967.3 5972.7 5977.9 6003.2 3512.6 5403.3 5493.0 5528.8 5542.5 4976.4 5287.2 5312.7 5405.5 5409.1 20091.4 20286.2 21055.8 21468.0 21487.4 1977.9 1986.7 2053.7 2357.7 2525.9 9459.5 9514.5 9806.9 11413.5 13005.2 1820.0 1821.0 1821.9 1852.8 1853.2 67540.3 70063.6 70471.0 71420.3 71934.0 10044.2 10358.6 10426.9 10499.7 10738.9 14625.6 14710.0 14732.9 14740.6 14754.2 7483.4 7643.6 7656.0 7785.7 7837.9 7379.3 7387.1 7429.5 7498.0 7500.4 4498.5 4546.2 4604.8 4619.5 4671.3 1721.0 1783.8 1888.8 1910.8 1937.9 880.3 943.1 948.4 948.7 1006.2 16707.8 16975.0 17139.4 17660.4 17804.1 887.6 899.1 916.6 916.7 928.2 9472.2 9853.1 9866.3 9946.5 10003.3 372883.0 374445.0 382091.0 384735.0 384867.0 46697.0 70736.6 73645.0 74289.0 74569.0 908.3 929.1 929.5 936.9 942.0 15154.3 15349.2 15513.3 15626.7 15902.9 32529.2 33016.8 33106.5 34793.0 36388.3 49882.5 50523.7 51058.7 51210.2 51366.5 6981.3 7348.4 7477.7 7560.8 7701.0 11983.9 12312.3 12369.4 12423.9 12471.4 8539.5 10607.2 10691.8 10757.2 11118.8 10636.3 10821.5 10854.1 10865.7 10870.0 10318.3 10705.0 11017.6 11099.3 11194.1 6965.1 7263.7 7358.0 7492.6 7747.4 8302.3 10502.8 10606.1 10635.9 11037.9 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#3] mootools.html Cycles:180 Average:5122.91 Median:5698.69 stddev:2790.40 (49.0%) stddev-sans-first:2783.39 02:39:53 INFO - PROCESS | 10956 | Values: 1293.9 1501.2 1546.6 1703.7 1856.9 6725.5 7604.3 7830.1 7833.4 8067.5 7740.0 7907.1 7912.6 7913.0 7913.4 2196.3 2230.1 2236.1 2238.9 2241.1 2174.2 2202.2 2206.9 2209.5 2210.9 2185.0 2188.5 2193.2 2194.1 2225.3 2127.7 2135.3 2135.6 2144.2 2145.4 2107.3 2145.0 2145.4 2146.3 2148.6 7575.8 7817.8 7860.8 7919.2 7927.2 4565.6 4656.6 4662.4 4665.3 4671.5 2965.4 3003.7 3023.4 3030.2 3079.0 891.3 895.7 914.0 929.6 946.5 10161.4 10177.3 10178.1 10197.8 10207.4 3895.5 3973.1 3993.1 4043.2 4043.6 8207.8 8210.5 8227.1 8266.2 8282.4 4459.6 4461.2 4466.3 4466.4 4467.6 3788.4 4071.2 4089.1 4179.7 4236.7 3388.8 3389.7 3446.4 3473.3 3582.0 1003.7 1013.5 1022.6 1024.8 1031.0 900.9 914.8 932.3 941.0 942.3 5339.8 5528.7 5595.3 5695.0 5846.8 941.5 954.8 962.5 981.8 997.9 3722.3 3795.8 3810.1 3839.9 3967.1 9015.2 9303.3 9373.1 9377.2 9401.5 9037.6 9302.8 9323.2 9336.4 9397.2 7301.3 7399.9 7429.0 7462.0 7473.3 5483.5 5632.3 5702.4 5724.7 5735.7 8750.6 8860.5 8862.3 8886.0 8888.3 8704.1 8900.2 8930.2 9139.5 9149.4 6136.2 6605.5 6779.8 6874.8 6998.0 7553.5 7589.3 7625.2 7630.1 7656.1 6783.6 6934.9 6950.7 7017.8 7071.0 6527.9 6553.5 6574.4 6595.5 6626.0 6217.8 6255.5 6316.6 6319.4 6333.2 4739.7 4753.3 4867.9 4896.6 4933.2 4832.8 4880.4 4903.8 4915.8 4990.0 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#4] prototype.html Cycles:180 Average:4199.80 Median:4818.84 stddev:1227.95 (25.5%) stddev-sans-first:1195.79 02:39:53 INFO - PROCESS | 10956 | Values: 288.7 294.4 294.8 296.6 297.8 4829.7 4833.2 4890.9 4896.8 4923.8 4809.3 4828.3 4828.5 4828.7 4846.2 3586.9 3698.4 3718.6 3781.5 3825.6 3776.2 3783.6 3794.2 3799.6 3805.1 3572.8 3758.5 3768.8 3772.2 3775.3 3560.4 3662.5 3697.5 3697.7 3732.6 3301.3 3329.0 3339.4 3342.4 3351.2 4629.5 4631.1 4650.7 4681.8 4711.6 4191.5 4234.7 4291.2 4311.3 4319.5 5027.2 5049.9 5056.2 5058.6 5103.8 3652.3 3656.0 3657.0 3661.1 3663.2 5131.7 5274.6 5305.6 5317.4 5364.5 3675.2 3695.6 3697.6 3698.9 3706.8 3728.5 3740.3 3749.2 3750.3 3761.4 4236.7 4255.1 4263.9 4264.0 4265.6 4858.7 5039.3 5045.6 5057.6 5074.9 1315.6 1318.6 1322.3 1327.4 1332.9 832.4 855.3 861.3 870.3 871.8 4361.8 4500.8 4506.3 4515.1 4527.0 5257.7 5274.7 5275.9 5284.8 5285.4 4499.0 4515.8 4518.2 4526.5 4529.3 2636.7 2822.5 2826.2 2831.5 2833.2 4949.0 4953.6 4958.4 4985.6 4989.0 5186.5 5381.2 5391.9 5409.4 5412.3 4931.3 4938.0 4953.0 4959.7 4969.2 5281.6 5291.6 5291.8 5294.2 5309.2 5020.6 5149.8 5176.6 5188.6 5195.1 4927.8 4933.7 4935.5 4935.6 4941.3 3305.4 3347.4 3352.3 3400.9 3411.0 4657.5 4719.6 4730.8 4735.8 4963.6 5110.4 5130.2 5132.0 5133.1 5141.0 5086.9 5102.8 5120.9 5121.7 5130.5 4805.6 5036.3 5040.9 5049.6 5050.7 4940.7 5063.9 5082.6 5083.7 5170.2 4931.0 4968.7 4978.3 4986.2 5048.8 02:39:53 INFO - PROCESS | 10956 | 02:39:53 INFO - PROCESS | 10956 | [#5] yui.html Cycles:180 Average:13551.57 Median:46392.88 stddev:15870.71 (34.2%) stddev-sans-first:15886.03 02:39:53 INFO - PROCESS | 10956 | Values: 732.3 739.0 740.3 760.0 807.9 12815.1 13223.4 13731.7 13742.7 13800.6 12824.9 12855.1 12934.6 12962.2 13007.8 679.9 856.7 872.9 886.1 888.3 865.2 875.4 876.3 876.5 876.6 915.3 920.4 920.6 920.8 922.1 704.1 882.7 905.3 913.1 913.2 677.9 677.9 678.2 678.5 678.7 12837.2 12977.4 12977.5 12979.1 12999.9 12323.4 12760.7 12826.2 12928.7 12943.9 11113.0 11157.6 11205.2 11238.4 11403.3 4129.0 4129.2 4139.5 4162.8 4168.8 45352.5 45757.6 46319.0 46466.8 46564.8 10140.5 10206.4 10240.6 10293.0 10449.6 18294.1 18295.5 18306.5 18325.8 18331.7 6513.2 6587.8 6708.2 6766.5 6918.2 3535.7 3656.4 3728.6 3776.4 3814.4 2787.4 2876.3 2892.3 2892.8 2892.9 487.2 488.4 489.2 505.3 506.0 509.9 556.9 594.3 628.1 641.5 7870.7 7956.8 7967.8 7983.5 8120.1 513.7 613.0 644.7 658.3 658.3 3713.6 3742.2 3816.1 3832.5 3846.5 57180.1 57790.7 57901.0 57992.1 58199.7 52157.5 52527.5 53495.7 54046.0 54976.7 47609.3 47906.8 48044.3 48561.0 48757.8 7508.0 7606.6 7738.6 7801.2 7957.1 31871.7 31912.8 31931.8 32309.7 32410.4 38995.8 41170.0 41276.4 41574.8 43100.6 9883.0 9900.0 9957.6 10011.2 10024.6 10397.9 10699.7 10737.3 10880.6 11099.3 8701.9 8868.6 10057.3 11368.2 11860.3 11153.6 11749.0 11763.8 11860.4 12172.1 11159.8 11327.8 11676.4 11695.5 11926.5 9313.0 9345.8 9366.3 9420.0 9795.8 9676.0 9991.2 10025.8 10038.7 10088.2 02:39:53 INFO - PROCESS | 10956 | -------- Summary: end -------- 02:39:53 INFO - PROCESS | 10956 | 02:39:54 INFO - TEST-INFO | 10956: exit 0 02:39:54 INFO - TEST-OK | dromaeo_css | took 1119074ms 02:39:54 INFO - TEST-START | kraken 02:39:54 INFO - operating with platform_type : linux_ 02:39:54 INFO - Initialising browser for kraken test... 02:39:54 INFO - TEST-INFO | started process 11128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqtCFcv/profile http://localhost:37760/getInfo.html) 02:39:58 INFO - PROCESS | 11128 | __metrics Screen width/height:1600/1200 02:39:58 INFO - PROCESS | 11128 | colorDepth:24 02:39:58 INFO - PROCESS | 11128 | Browser inner width/height: 1024/697 02:39:58 INFO - PROCESS | 11128 | __metrics 02:39:59 ERROR - PROCESS | 11128 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:40:00 INFO - TEST-INFO | 11128: exit 0 02:40:00 INFO - Browser initialized. 02:40:00 INFO - Running cycle 1/1 for kraken test... 02:40:00 INFO - TEST-INFO | started process 11207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqtCFcv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:12 INFO - PROCESS | 11207 | RSS: Main: 154169344 02:40:12 INFO - PROCESS | 11207 | 02:40:15 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:16 INFO - PROCESS | 11207 | RSS: Main: 209694720 02:40:16 INFO - PROCESS | 11207 | 02:40:18 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-dft) 02:40:19 INFO - PROCESS | 11207 | RSS: Main: 198291456 02:40:19 INFO - PROCESS | 11207 | 02:40:22 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-fft) 02:40:23 INFO - PROCESS | 11207 | RSS: Main: 267022336 02:40:23 INFO - PROCESS | 11207 | 02:40:25 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37760/tests/kraken/driver.html?testName=audio-oscillator) 02:40:26 INFO - PROCESS | 11207 | RSS: Main: 175370240 02:40:26 INFO - PROCESS | 11207 | 02:40:28 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:29 INFO - PROCESS | 11207 | RSS: Main: 179847168 02:40:29 INFO - PROCESS | 11207 | 02:40:32 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:33 INFO - PROCESS | 11207 | RSS: Main: 215822336 02:40:33 INFO - PROCESS | 11207 | 02:40:36 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37760/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:37 INFO - PROCESS | 11207 | RSS: Main: 214106112 02:40:37 INFO - PROCESS | 11207 | 02:40:40 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37760/tests/kraken/driver.html?testName=json-parse-financial) 02:40:41 INFO - PROCESS | 11207 | RSS: Main: 214982656 02:40:41 INFO - PROCESS | 11207 | 02:40:42 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37760/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:43 INFO - PROCESS | 11207 | RSS: Main: 207593472 02:40:43 INFO - PROCESS | 11207 | 02:40:45 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:46 INFO - PROCESS | 11207 | RSS: Main: 211697664 02:40:46 INFO - PROCESS | 11207 | 02:40:48 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:49 INFO - PROCESS | 11207 | RSS: Main: 215023616 02:40:49 INFO - PROCESS | 11207 | 02:40:51 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:52 INFO - PROCESS | 11207 | RSS: Main: 219639808 02:40:52 INFO - PROCESS | 11207 | 02:40:55 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:56 INFO - PROCESS | 11207 | RSS: Main: 218517504 02:40:56 INFO - PROCESS | 11207 | 02:40:57 INFO - PROCESS | 11207 | Cycle 1(1): loaded http://localhost:37760/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37760/tests/kraken/driver.html?testName=ai-astar) 02:40:58 INFO - PROCESS | 11207 | RSS: Main: 265355264 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | __start_tp_report 02:40:58 INFO - PROCESS | 11207 | _x_x_mozilla_page_load 02:40:58 INFO - PROCESS | 11207 | _x_x_mozilla_page_load_details 02:40:58 INFO - PROCESS | 11207 | |i|pagename|runs| 02:40:58 INFO - PROCESS | 11207 | |0;ai-astar;114;112;113;115;114;114;113;115;111;115 02:40:58 INFO - PROCESS | 11207 | |1;audio-beat-detection;162;129;151;219;129;153;156;136;185;133 02:40:58 INFO - PROCESS | 11207 | |2;audio-dft;161;161;162;163;162;161;162;161;161;161 02:40:58 INFO - PROCESS | 11207 | |3;audio-fft;75;78;75;150;76;75;78;74;130;76 02:40:58 INFO - PROCESS | 11207 | |4;audio-oscillator;91;93;150;93;92;92;128;92;92;129 02:40:58 INFO - PROCESS | 11207 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;117;118;117 02:40:58 INFO - PROCESS | 11207 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;146;146 02:40:58 INFO - PROCESS | 11207 | |7;imaging-desaturate;94;94;95;95;95;94;94;94;95;95 02:40:58 INFO - PROCESS | 11207 | |8;json-parse-financial;63;63;63;62;63;64;64;64;63;63 02:40:58 INFO - PROCESS | 11207 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;65;65;64 02:40:58 INFO - PROCESS | 11207 | |10;stanford-crypto-aes;82;86;84;87;80;82;82;81;139;82 02:40:58 INFO - PROCESS | 11207 | |11;stanford-crypto-ccm;131;133;142;128;128;142;127;130;147;136 02:40:58 INFO - PROCESS | 11207 | |12;stanford-crypto-pbkdf2;168;169;171;168;172;171;167;170;168;169 02:40:58 INFO - PROCESS | 11207 | |13;stanford-crypto-sha256-iterative;67;66;66;67;66;70;65;65;65;64 02:40:58 INFO - PROCESS | 11207 | __end_tp_report 02:40:58 INFO - PROCESS | 11207 | __start_cc_report 02:40:58 INFO - PROCESS | 11207 | _x_x_mozilla_cycle_collect,2055 02:40:58 INFO - PROCESS | 11207 | __end_cc_report 02:40:58 INFO - PROCESS | 11207 | __startTimestamp1463650858035__endTimestamp 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | ------- Summary: start ------- 02:40:58 INFO - PROCESS | 11207 | Number of tests: 14 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 02:40:58 INFO - PROCESS | 11207 | Values: 114.0 112.0 113.0 115.0 114.0 114.0 113.0 115.0 111.0 115.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:154.50 stddev:28.41 (18.4%) stddev-sans-first:30.03 02:40:58 INFO - PROCESS | 11207 | Values: 162.0 129.0 151.0 219.0 129.0 153.0 156.0 136.0 185.0 133.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 02:40:58 INFO - PROCESS | 11207 | Values: 161.0 161.0 162.0 163.0 162.0 161.0 162.0 161.0 161.0 161.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.50 stddev:27.48 (36.4%) stddev-sans-first:28.69 02:40:58 INFO - PROCESS | 11207 | Values: 75.0 78.0 75.0 150.0 76.0 75.0 78.0 74.0 130.0 76.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:92.00 stddev:21.83 (23.7%) stddev-sans-first:22.54 02:40:58 INFO - PROCESS | 11207 | Values: 91.0 93.0 150.0 93.0 92.0 92.0 128.0 92.0 92.0 129.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:40:58 INFO - PROCESS | 11207 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 118.0 117.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:40:58 INFO - PROCESS | 11207 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:40:58 INFO - PROCESS | 11207 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:40:58 INFO - PROCESS | 11207 | Values: 63.0 63.0 63.0 62.0 63.0 64.0 64.0 64.0 63.0 63.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 02:40:58 INFO - PROCESS | 11207 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:82.00 stddev:17.88 (21.8%) stddev-sans-first:18.81 02:40:58 INFO - PROCESS | 11207 | Values: 82.0 86.0 84.0 87.0 80.0 82.0 82.0 81.0 139.0 82.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:134.50 stddev:7.04 (5.2%) stddev-sans-first:7.36 02:40:58 INFO - PROCESS | 11207 | Values: 131.0 133.0 142.0 128.0 128.0 142.0 127.0 130.0 147.0 136.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:1.64 (1.0%) stddev-sans-first:1.67 02:40:58 INFO - PROCESS | 11207 | Values: 168.0 169.0 171.0 168.0 172.0 171.0 167.0 170.0 168.0 169.0 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - PROCESS | 11207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 02:40:58 INFO - PROCESS | 11207 | Values: 67.0 66.0 66.0 67.0 66.0 70.0 65.0 65.0 65.0 64.0 02:40:58 INFO - PROCESS | 11207 | -------- Summary: end -------- 02:40:58 INFO - PROCESS | 11207 | 02:40:58 INFO - TEST-INFO | 11207: exit 0 02:40:59 INFO - TEST-OK | kraken | took 64532ms 02:40:59 INFO - SUITE-END | took 1183s 02:40:59 INFO - Completed test suite (00:19:43) 02:40:59 INFO - javascript benchmark 02:40:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.670416197975, 2638.2876623311695, 2677.718839521851, 2689.0, 2697.352635367511, 4640.976795116019, 4643.396358473398, 4709.411323584552, 4734.928976065362, 4787.760611969401, 4631.884202894921, 4683.391159149314, 4713.622910167187, 4737.526247375261, 4746.7863946122425, 4217.536071032192, 4262.744235345874, 4279.507856596485, 4336.804843782022, 4470.463544374663, 4366.235908715962, 4420.226460369422, 4444.777761111932, 4462.263726485126, 4466.57567531084, 4210.5157906840495, 4248.851290204828, 4252.9149417011795, 4287.764172970486, 4292.334688123346, 4282.721623094489, 4292.849750258726, 4300.78496075195, 4302.849400270976, 4307.246231909403, 4239.618434340924, 4241.257779888507, 4266.445362102938, 4273.1240095780295, 4287.2711639021445, 4587.931181032287, 4598.931016034762, 4630.467496237909, 4665.346851440767, 4669.112868554964, 4875.024995000978, 5024.070546948826, 5073.568746656501, 5073.568746656501, 5082.542571168576, 5051.0, 5083.110455670243, 5101.846944591668, 5126.436092029874, 5164.870878228036, 4756.167670657655, 4786.617070634341, 4789.353437285991, 4794.904101918012, 4812.0, 5063.5695965843315, 5097.209932460474, 5223.608229382811, 5264.105102132647, 5270.578353731692, 4927.87680307988, 4940.7035577865445, 4967.230079337708, 5009.273655320031, 5010.799568017239, 5039.143345631252, 5039.672421292605, 5044.9495505045215, 5046.0, 5098.005888851712, 4853.102176097434, 4909.3126962225315, 4942.332785074041, 4994.1759609663995, 5004.299398084271, 4932.778024988884, 4951.0, 4953.6532442729385, 4955.677880937727, 4989.950100499022, 4240.809163587646, 4241.97879010603, 4243.724157929786, 4275.5724427557, 4290.592393722592, 3680.392735198662, 3717.4795528626014, 3722.7952462614817, 3739.121306492972, 3748.962510374916, 4324.3513472978675, 4345.0, 4349.760763158057, 4385.7149285296355, 4388.407564978751, 5033.219850923113, 5069.9746501267255, 5071.4928507149725, 5072.163093089673, 5120.871978200575, 4246.235677578065, 4275.743455392686, 4304.311310190355, 4308.46144231971, 4334.718243314174, 4493.932591011137, 4498.865034048984, 4512.729236245836, 4525.208088584484, 4555.043440877386, 4716.1510928033285, 4716.386869707053, 4721.952780472151, 4731.384919960383, 4779.044191161782, 4904.2643603459765, 4929.1866841972105, 5001.074801161797, 5051.974740126276, 5107.744612769421, 4750.928736068892, 4766.261229509293, 4776.8566942991765, 4809.44691360498, 4811.927821082757, 4969.676970996874, 4979.726115063706, 4981.227909674007, 4982.601391888713, 5034.773435195351, 4912.1649319615035, 4916.041371932439, 4945.826896058765, 4947.876303092451, 5002.474740152232, 4834.371531700997, 4838.225883858566, 4841.443234027991, 4842.539958703917, 4883.0, 4832.323474713613, 4850.369451971221, 4851.393575803025, 4854.126257273583, 4900.681455705368, 4722.622190224705, 4857.805687772591, 4910.8772280693265, 4921.606271498343, 4982.252662100714, 5017.397912250553, 5023.623228257822, 5024.522670346311, 5055.595552355876, 5058.038972595195, 4690.765461726968, 4907.77914993819, 4928.901421971612, 4931.482194369683, 4986.476419975996], "value": 4619.93072118419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8534938241364, 588.6085752974273, 599.8830228105519, 605.8095841671116, 612.5497759147026, 42750.78624606877, 44765.328520072224, 44808.999999999956, 44875.77562112193, 49139.0, 43714.78142609291, 44276.3358549622, 44315.55684443154, 44330.11339773203, 44395.0, 7702.46082774206, 7869.881951770728, 7870.803229919269, 8052.315553177972, 8236.299914507244, 7787.493812902171, 10263.692089237335, 10514.106300964428, 10537.68386948389, 10844.0, 10458.9477052615, 10496.160307175445, 10507.054365107138, 10508.0, 10510.737231569234, 7816.49192802466, 10264.281500294983, 10446.79106417875, 10511.369317840954, 10520.999999999962, 10050.849237261447, 10379.273450858444, 10382.740431489197, 10385.89614103857, 10386.636467723594, 38926.0, 39339.8033009836, 39341.213175736324, 39353.60646393557, 39423.21153576941, 3327.900162995114, 3361.462166053444, 3432.9485057724155, 3630.455431685242, 3931.6658084062888, 28163.0, 29211.70788292111, 29702.85148574265, 29843.850780746176, 30245.395092098253, 3461.2212252243294, 3521.683048525645, 3600.117971097072, 3602.0994751312173, 3606.2607165531003, 264823.0, 266202.0, 266394.0, 266419.0, 266836.0, 58621.0, 59998.40009599438, 60142.39857601368, 60159.398406016255, 60195.0, 36043.0, 37047.66571008622, 37098.81450592784, 39093.80453097716, 56077.719611401684, 15707.214639267992, 15852.603684907739, 15866.603334916488, 15868.04791712501, 15873.841261587468, 10733.731656708645, 12256.877431225752, 12342.81485777714, 12495.562655307021, 13037.217766934014, 19944.70082948757, 20230.29193978233, 20261.797382026285, 20350.18599256013, 20401.591968160552, 7256.709731610782, 7302.817429564303, 7316.926830731731, 7330.193344088529, 7416.666250018762, 826.4215049465398, 934.4766930518931, 955.5126885288553, 983.7884854756119, 1076.4402510694395, 27534.44931101367, 27749.167524974284, 27795.166145015683, 27818.165455036382, 28024.0, 960.0, 984.4339504784778, 1021.6577446555488, 1040.6409788622914, 1122.5117074072805, 13575.32123393846, 14134.858651413355, 14222.0, 14551.490697825526, 14684.339204735812, 367840.0, 370565.0, 370872.0, 371078.0, 371715.0, 54334.45665543294, 55000.0, 55025.44974550283, 55027.17459238115, 55062.449375506534, 1125.8648962124598, 1132.1791701016698, 1263.3493750718203, 1286.9034822388357, 1295.2746461981321, 27967.300817479725, 30517.694823051486, 30566.388672225985, 30907.227319317197, 31401.8429907849, 45288.32067518924, 45816.77091614521, 45843.083138337715, 45885.77057114693, 45907.54092459166, 245765.0, 251065.0, 251337.0, 251376.0, 252482.0, 24049.0, 26580.202593922215, 27113.45773084567, 27272.59091113595, 27382.178534643994, 44299.11401772011, 44781.55218447774, 45525.0, 45630.0, 46059.53940460687, 37244.81377593095, 38711.419328709526, 38759.6124038756, 39155.41266880942, 39690.2061958765, 37530.0, 37864.81067594644, 38818.0, 39159.6084039156, 39242.41136382899, 37389.25221495609, 37922.43116353312, 38027.42958855675, 38288.23423531458, 38295.04262393463, 33400.0, 33943.727995372996, 34761.0, 35004.0, 35214.823925880206, 26352.736472635796, 26626.467470650867, 27214.863925680245, 28461.715382845905, 28620.713792861803], "value": 18682.037899081006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9433085037245, 386.08112691793525, 389.22349911925704, 399.7361741250775, 400.3374415342609, 16141.273642686077, 17471.301147954066, 18626.534336641573, 18637.627247455075, 18641.906790466062, 17491.562710932234, 17625.383111591098, 18181.636367272647, 18326.725099123523, 18340.541486462844, 5096.362954630671, 5171.56041736451, 5226.346706661668, 5242.187460943541, 5280.313559237294, 3634.963650363502, 5645.887082258352, 5938.46553810157, 5940.435658612447, 6044.304904935922, 5220.295260139889, 5967.313758917737, 5972.6715030673295, 5977.850553736148, 6003.159557661931, 3512.5609298837644, 5403.297571315743, 5493.0, 5528.834134975958, 5542.501174894259, 4976.35307410038, 5287.206918962186, 5312.681239125664, 5405.486478784548, 5409.107497262947, 20091.39725808228, 20286.188552457883, 21055.789442105535, 21468.0, 21487.355379338645, 1977.9208831646717, 1986.7119267706246, 2053.743282089739, 2357.6817129687443, 2525.936851578707, 9459.52702364886, 9514.476703781289, 9806.90193098067, 11413.48639311233, 13005.154664946844, 1819.954501137469, 1821.0, 1821.8997955112463, 1852.786424891698, 1853.1938606705992, 67540.3245967539, 70063.64968175127, 70470.99999999949, 71420.28579714189, 71934.0, 10044.246681498917, 10358.585656573803, 10426.895731042745, 10499.737506562396, 10738.94630526858, 14625.561233162809, 14710.0, 14732.926335368255, 14740.557783266519, 14754.188519631309, 7483.438742094365, 7643.617819109022, 7655.961720191363, 7785.727499537489, 7837.882431763528, 7379.298966598165, 7387.076615423072, 7429.517081389692, 7497.962510187524, 7500.437467189982, 4498.460184777782, 4546.227141385973, 4604.815807367735, 4619.538046195354, 4671.32265821454, 1720.9741853872201, 1783.785945686526, 1888.792232854385, 1910.808919108078, 1937.8837269763578, 880.264978742757, 943.1464524605243, 948.4451595816524, 948.6584829461389, 1006.1900170362928, 16707.83292167087, 16975.0, 17139.400120995706, 17660.381886633906, 17804.109794510223, 887.6138879587401, 899.078444594283, 916.5554705967601, 916.6929078758557, 928.2295694573488, 9472.194863436685, 9853.113219810251, 9866.260030497742, 9946.502674866228, 10003.299769016245, 372883.0, 374445.0, 382091.0, 384735.0, 384867.0, 46697.0, 70736.64631676809, 73645.0, 74289.0, 74569.0, 908.3232991421434, 929.1266209762802, 929.4748467116058, 936.9297302702324, 941.990580094204, 15154.3180556873, 15349.155796430858, 15513.301901414237, 15626.734123552249, 15902.920485397963, 32529.186770330933, 33016.83491582527, 33106.50340244947, 34793.0, 36388.27223455463, 49882.50117498779, 50523.74738126286, 51058.74470627623, 51210.15923805804, 51366.48633513617, 6981.301869812978, 7348.412127029932, 7477.66350514239, 7560.810979725551, 7701.037370328709, 11983.940080299542, 12312.26126432417, 12369.443375047964, 12423.937880310541, 12471.438785254866, 8539.462896678657, 10607.20445966571, 10691.839622405825, 10757.246992710436, 11118.777624447304, 10636.255462117577, 10821.51303191374, 10854.131669466582, 10865.69663979899, 10870.0, 10318.277720559488, 10705.0, 11017.614383496539, 11099.334039957306, 11194.104471642411, 6965.094537710268, 7263.709451622088, 7358.006230529595, 7492.550446973199, 7747.418943579367, 8302.294304984143, 10502.789944201226, 10606.098481629147, 10635.89364106349, 11037.889621103686], "value": 8418.63156479904, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.922364658121, 1501.1593507635725, 1546.6288090858193, 1703.7188863837468, 1856.9442916712494, 6725.461963042957, 7604.277593628603, 7830.138684744674, 7833.412494062954, 8067.5159490430615, 7740.0, 7907.090684571262, 7912.604369781502, 7913.0, 7913.446058775874, 2196.286206982733, 2230.119102954332, 2236.105557776886, 2238.921637742679, 2241.081156725743, 2174.152080688533, 2202.1631779923605, 2206.8896555172178, 2209.5249521352907, 2210.8673479591193, 2185.0495034659893, 2188.4966457714736, 2193.2104442400723, 2194.122351059581, 2225.343523660516, 2127.6914847347202, 2135.29535253366, 2135.5728854229137, 2144.2173606633623, 2145.3885642591863, 2107.3045894854663, 2145.0347343695244, 2145.356393082069, 2146.3239079689847, 2148.559545293211, 7575.772726818149, 7817.843643127106, 7860.842783144305, 7919.247671471258, 7927.167647396998, 4565.6347492200875, 4656.627469802408, 4662.417197850269, 4665.300204969248, 4671.532846715335, 2965.4365670522534, 3003.714647108521, 3023.425549145655, 3030.1667041563746, 3078.9846050769825, 891.3404080980093, 895.6820328783253, 913.9680111196076, 929.6374413978554, 946.4841661294611, 10161.441120738356, 10177.287589868713, 10178.083972442442, 10197.847032294521, 10207.438590877498, 3895.4741109949796, 3973.0663294125857, 3993.101552150743, 4043.1509383029893, 4043.575424580377, 8207.7948051298, 8210.507369557727, 8227.13615070421, 8266.214709602578, 8282.420230583923, 4459.620932220798, 4461.24158892989, 4466.2630665940405, 4466.39703640011, 4467.620252278528, 3788.412796016622, 4071.246819338432, 4089.1208390196252, 4179.665626749853, 4236.724612900151, 3388.762786604914, 3389.6610338966398, 3446.362422951762, 3473.2879759649213, 3581.982090089585, 1003.6738060130486, 1013.5287091502339, 1022.6114076650825, 1024.779672370444, 1030.9587616495255, 900.9278063154505, 914.8033172867732, 932.2728271947756, 941.026038050628, 942.2744486745167, 5339.813106541253, 5528.695921724344, 5595.300587426572, 5694.971525142348, 5846.824595262149, 941.5245301122889, 954.7947191353753, 962.5427921737258, 981.8379967305458, 997.8553109799184, 3722.3113723960614, 3795.8291876865605, 3810.123671555558, 3839.9424008639894, 3967.0875698589484, 9015.233705135137, 9303.25573954082, 9373.109554592304, 9377.156055954996, 9401.529923503798, 9037.593308301142, 9302.813943721223, 9323.160915517636, 9336.39313444624, 9397.248220142372, 7301.269873012656, 7399.889001664979, 7429.0, 7462.029936108272, 7473.252674732484, 5483.506484416422, 5632.324121105494, 5702.40124786908, 5724.685142317213, 5735.713214339183, 8750.562471876254, 8860.512671802855, 8862.291016718777, 8886.0, 8888.333374996771, 8704.129587041245, 8900.243479304332, 8930.19628233462, 9139.497327647043, 9149.359544831797, 6136.20229370179, 6605.47156227491, 6779.762708305186, 6874.793756187322, 6997.965010174917, 7553.546787192786, 7589.279018493235, 7625.199354067743, 7630.084389873251, 7656.119546252252, 6783.626900520321, 6934.861302773816, 6950.721971121098, 7017.754378596725, 7071.045408869737, 6527.869442611216, 6553.541252112306, 6574.441172500391, 6595.472362211108, 6626.039224312544, 6217.782377616762, 6255.53083518747, 6316.62100273985, 6319.431251187231, 6333.20834895638, 4739.715617062987, 4753.263244197016, 4867.878303042452, 4896.583790377716, 4933.235348520985, 4832.758362081952, 4880.389951256093, 4903.779329930233, 4915.778789954532, 4990.001999600167], "value": 4159.299929980338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.6709151567214, 294.41117764471073, 294.80542841724457, 296.5670121622431, 297.81981900949927, 4829.734364609945, 4833.178359678855, 4890.926636100461, 4896.849240428501, 4923.82766603169, 4809.326694262806, 4828.348172996644, 4828.493008234129, 4828.661993660445, 4846.200376937801, 3586.8923932282073, 3698.3712768829228, 3718.609545997672, 3781.4664175002813, 3825.61743825618, 3776.244751049801, 3783.6216378362083, 3794.165283637595, 3799.620037996206, 3805.1248212911046, 3572.821358932056, 3758.473813666089, 3768.773873567581, 3772.188979369435, 3775.2826962876966, 3560.394732895388, 3662.505561749156, 3697.5378077740415, 3697.7411581189326, 3732.64539868712, 3301.2833326669997, 3329.0, 3339.3989081965237, 3342.4484959981573, 3351.173610382323, 4629.537046295377, 4631.078102587422, 4650.720956742606, 4681.836135735267, 4711.575958163782, 4191.476065491814, 4234.734417086844, 4291.206126866539, 4311.267084595626, 4319.546447623017, 5027.195648696191, 5049.873753156164, 5056.191009438509, 5058.595312375001, 5103.770330335144, 3652.3060618482405, 3655.963440365589, 3657.012606596231, 3661.1030297577, 3663.249033948034, 5131.7434128293435, 5274.55166310864, 5305.575553955674, 5317.41508434072, 5364.517193452569, 3675.2358867743633, 3695.593484716679, 3697.6487233712755, 3698.8890333290046, 3706.832347810431, 3728.5458671118286, 3740.2893450244364, 3749.1564398010228, 3750.2686976039954, 3761.3793724035777, 4236.724612900151, 4255.127698821734, 4263.850765223202, 4264.0, 4265.573442655709, 4858.692690659614, 5039.269305950616, 5045.621578381636, 5057.620678449131, 5074.949250507448, 1315.5855905389772, 1318.6352125550009, 1322.307446468522, 1327.4093028602178, 1332.9269937700244, 832.4339449174498, 855.2901092093548, 861.3152543727751, 870.2602787630464, 871.7559083456642, 4361.80371883266, 4500.797464114123, 4506.324051392317, 4515.14212299662, 4526.977365113219, 5257.658252213594, 5274.657147285414, 5275.86568887691, 5284.7886084556185, 5285.418603953562, 4498.977505112453, 4515.841945531891, 4518.2319005769095, 4526.524714904954, 4529.297958816389, 2636.670416197975, 2822.4778415993105, 2826.23691603266, 2831.4903317403064, 2833.220864262303, 4948.975255123773, 4953.554180123806, 4958.429780575208, 4985.601151907838, 4989.0, 5186.533212010937, 5381.165919282517, 5391.919121213185, 5409.350877894678, 5412.296401467784, 4931.334269873593, 4937.987712518925, 4952.950470495321, 4959.702417855013, 4969.204927211629, 5281.551068159096, 5291.629585928948, 5291.830349556663, 5294.152935530296, 5309.194873742946, 5020.6234532410945, 5149.794008239628, 5176.592884308814, 5188.58491320701, 5195.064888320138, 4927.778249978831, 4933.654644174873, 4935.4570997190995, 4935.555799978019, 4941.33292005589, 3305.438075527118, 3347.3807345641135, 3352.3127758809874, 3400.9149771255916, 3410.9829450852585, 4657.48767635553, 4719.551642593948, 4730.763461826964, 4735.786889589908, 4963.553280204799, 5110.437851836369, 5130.204818253177, 5132.0, 5133.127368347465, 5141.0, 5086.855457522028, 5102.770375333193, 5120.923186152137, 5121.74391280442, 5130.461301563282, 4805.5915247204375, 5036.269740887624, 5040.899182016413, 5049.596032317332, 5050.696958182521, 4940.654154209171, 5063.87317326731, 5082.593392528515, 5083.669561478492, 5170.224466330081, 4931.002943807764, 4968.726720030433, 4978.30303757467, 4986.227134794112, 5048.7728052237], "value": 3809.7201859078264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.2933369298628, 739.0023468317771, 740.3041141327152, 759.9886001709975, 807.9232472915071, 12815.102942793996, 13223.404946777395, 13731.65670858229, 13742.725145497085, 13800.585982420544, 12824.871751282484, 12855.100142989995, 12934.611961641142, 12962.157459765109, 13007.804882926765, 679.857229981702, 856.7429771068686, 872.8777971084053, 886.0652012127204, 888.3248730964481, 865.1953683074738, 875.4309698695866, 876.2595606712318, 876.5047748022379, 876.5573385440343, 915.2860768600502, 920.4155361345561, 920.5949382271779, 920.8204400141975, 922.1331947968921, 704.1303989572873, 882.6734108379876, 905.3345790843724, 913.0869130869131, 913.2055112052524, 677.8712044711489, 677.8745932002595, 678.1827897383641, 678.4504551313452, 678.7149397253116, 12837.165584236995, 12977.35113244334, 12977.545785897542, 12979.091463597551, 12999.87000129996, 12323.383830808423, 12760.680982975407, 12826.23042617446, 12928.676783080404, 12943.91732459857, 11113.0, 11157.553697852076, 11205.21563490556, 11238.438078096062, 11403.315801051964, 4128.967758060485, 4129.236091323115, 4139.461869956886, 4162.7502349859105, 4168.8332466701295, 45352.546474535164, 45757.62727118192, 46319.0, 46466.76766616145, 46564.7671761639, 10140.543675534618, 10206.4386458744, 10240.590376385011, 10293.0, 10449.634262800766, 18294.08529573516, 18295.54261143482, 18306.542336441697, 18325.816741832678, 18331.725024124647, 6513.153290072355, 6587.769428069994, 6708.228553716385, 6766.49251306154, 6918.238993710688, 3535.699465545406, 3656.3784156693428, 3728.5831384073877, 3776.376897811885, 3814.3515602347666, 2787.4007088476073, 2876.3384421582737, 2892.2769307673084, 2892.754115900172, 2892.8842846286334, 487.1839668555156, 488.3919520197306, 489.20015774208713, 505.3228673577424, 506.0233748864653, 509.86998315429327, 556.9220309156722, 594.2542109652445, 628.1080865171467, 641.4579680170249, 7870.72452464161, 7956.761297161094, 7967.8406431871035, 7983.5209887406945, 8120.147384524658, 513.6661170239374, 612.984675383119, 644.690548536705, 658.2660333727858, 658.2890478283442, 3713.5729391119826, 3742.214135031619, 3816.065064059323, 3832.463455116286, 3846.480725102075, 57180.14229786557, 57790.711046445336, 57901.0, 57992.13011804826, 58199.709001455565, 52157.478425216024, 52527.47472525302, 53495.732521337144, 54046.0, 54976.72511637416, 47609.285860712116, 47906.76046619745, 48044.27933580999, 48561.0, 48757.75621121943, 7508.0, 7606.569715335417, 7738.613069346397, 7801.1808760079375, 7957.084935232291, 31871.681283187798, 31912.8404357986, 31931.840340799077, 32309.676903230666, 32410.351792963538, 38995.805020974716, 41170.0, 41276.38085428661, 41574.792126039174, 43100.56899431091, 9882.950585247316, 9900.0, 9957.601695932372, 10011.199104071802, 10024.649137280161, 10397.948010259901, 10699.679009629723, 10737.332695984665, 10880.564777408816, 11099.278546894426, 8701.912980870111, 8868.600912959062, 10057.263606959592, 11368.204225704452, 11860.34768087729, 11153.609623663133, 11749.0, 11763.764724705628, 11860.40697965081, 12172.14794964344, 11159.832602510807, 11327.830082548604, 11676.416179191176, 11695.532178712756, 11926.522939082339, 9312.953435232781, 9345.813073744137, 9366.325165258526, 9420.0, 9795.804083918425, 9675.951620242135, 9991.200703943521, 10025.799484010133, 10038.698839034842, 10088.243381746252], "value": 6171.476281851208, "unit": "score"}], "name": "dromaeo_css", "value": 6435.901477847996, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 115.0, 114.0, 114.0, 113.0, 115.0, 111.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 151.0, 219.0, 129.0, 153.0, 156.0, 136.0, 185.0, 133.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 75.0, 150.0, 76.0, 75.0, 78.0, 74.0, 130.0, 76.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 150.0, 93.0, 92.0, 92.0, 128.0, 92.0, 92.0, 129.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 84.0, 87.0, 80.0, 82.0, 82.0, 81.0, 139.0, 82.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 142.0, 128.0, 128.0, 142.0, 127.0, 130.0, 147.0, 136.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 171.0, 168.0, 172.0, 171.0, 167.0, 170.0, 168.0, 169.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 66.0, 70.0, 65.0, 65.0, 65.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1567.4, "alertThreshold": 2.0}]} 02:40:59 INFO - Return code: 0 02:40:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:40:59 ERROR - # TBPL SUCCESS # 02:40:59 INFO - Running post-action listener: _resource_record_post_action 02:40:59 INFO - ##### 02:40:59 INFO - ##### Finished run-tests step (success) 02:40:59 INFO - ##### 02:40:59 INFO - Running post-run listener: _resource_record_post_run 02:40:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 533291008; Read time: 0; Write time: 602648 02:40:59 INFO - TinderboxPrint: CPU usage
13.1% 02:40:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:40:59 INFO - TinderboxPrint: I/O write bytes / time
533,291,008 / 602,648 02:40:59 INFO - TinderboxPrint: CPU idle
8,326.2 (86.9%) 02:40:59 INFO - TinderboxPrint: CPU user
1,215.1 (12.7%) 02:40:59 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242671616; Read time: 0; Write time: 326556 02:40:59 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 290488320; Read time: 0; Write time: 276092 02:40:59 INFO - Running post-run listener: _upload_blobber_files 02:40:59 INFO - Blob upload gear active. 02:40:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:01 INFO - (blobuploader) - INFO - Done attempting. 02:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:01 INFO - (blobuploader) - INFO - Done attempting. 02:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:06 INFO - (blobuploader) - INFO - Done attempting. 02:41:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:06 INFO - Return code: 0 02:41:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23cf9e99e6cb72780f080a688aeddcd6f8acd74ae57bc5327f06566f0aa9f156a45a233145d65c1065c822645477b8d474e874da7e718372c5abf23e34cf22f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69caee82231966c9aa1b12a5d1bdeeebb84d1aedfd8ed0f2d97b0b58929ebaa796db740436102c9c09ef971f9fcfb09b9aafed99cb48f0c4f33630814cccae1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/634efb9c55adc68cc3726bc168d326f7cbd1cabcaaf2936666b15b24805c4134e6518e1fd5475d4b4c24b7f77a3866d9735cc1164c521d2b8d227f451ccde954"} 02:41:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:06 INFO - Contents: 02:41:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23cf9e99e6cb72780f080a688aeddcd6f8acd74ae57bc5327f06566f0aa9f156a45a233145d65c1065c822645477b8d474e874da7e718372c5abf23e34cf22f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69caee82231966c9aa1b12a5d1bdeeebb84d1aedfd8ed0f2d97b0b58929ebaa796db740436102c9c09ef971f9fcfb09b9aafed99cb48f0c4f33630814cccae1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/634efb9c55adc68cc3726bc168d326f7cbd1cabcaaf2936666b15b24805c4134e6518e1fd5475d4b4c24b7f77a3866d9735cc1164c521d2b8d227f451ccde954"} 02:41:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:06 INFO - Copying logs to upload dir... 02:41:06 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.457142 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-19 02:41:05.806543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:41:05.809912) ========= 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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23cf9e99e6cb72780f080a688aeddcd6f8acd74ae57bc5327f06566f0aa9f156a45a233145d65c1065c822645477b8d474e874da7e718372c5abf23e34cf22f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69caee82231966c9aa1b12a5d1bdeeebb84d1aedfd8ed0f2d97b0b58929ebaa796db740436102c9c09ef971f9fcfb09b9aafed99cb48f0c4f33630814cccae1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/634efb9c55adc68cc3726bc168d326f7cbd1cabcaaf2936666b15b24805c4134e6518e1fd5475d4b4c24b7f77a3866d9735cc1164c521d2b8d227f451ccde954"} build_url:https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/GAV4o0vHSny44V3k-nOFtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23cf9e99e6cb72780f080a688aeddcd6f8acd74ae57bc5327f06566f0aa9f156a45a233145d65c1065c822645477b8d474e874da7e718372c5abf23e34cf22f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69caee82231966c9aa1b12a5d1bdeeebb84d1aedfd8ed0f2d97b0b58929ebaa796db740436102c9c09ef971f9fcfb09b9aafed99cb48f0c4f33630814cccae1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/634efb9c55adc68cc3726bc168d326f7cbd1cabcaaf2936666b15b24805c4134e6518e1fd5475d4b4c24b7f77a3866d9735cc1164c521d2b8d227f451ccde954"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 02:41:05.835043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:41:05.835395) ========= 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=62c568580acbfdaac3eec7be000001dc-1463649621.749759-1092372422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004343 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 02:41:05.919221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:41:05.919682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 02:41:05.920127) ========= ========= Total master_lag: 0.17 =========