builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1464099992.93 results: success (0) buildid: 20160524055509 builduid: 7b184da7e9404d6784228b66b8fb2b35 revision: 829d3be6ba648b838ee1953fdfa1a477dace752f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:32.934848) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:32.935287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:32.935603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:32.956037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:32.956304) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 07:26:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-24 07:26:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:33.071093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:33.071390) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:33.120950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 07:26:33.121270) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 829d3be6ba648b838ee1953fdfa1a477dace752f --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 829d3be6ba648b838ee1953fdfa1a477dace752f --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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 07:26:33,486 truncating revision to first 12 chars 2016-05-24 07:26:33,486 Setting DEBUG logging. 2016-05-24 07:26:33,486 attempt 1/10 2016-05-24 07:26:33,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/829d3be6ba64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 07:26:34,445 unpacking tar archive at: mozilla-central-829d3be6ba64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.271236 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 07:26:34.406937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:34.407241) ========= script_repo_revision: 829d3be6ba648b838ee1953fdfa1a477dace752f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:34.407658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:34.407928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 07:26:34.418166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-24 07:26:34.418460) ========= /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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:26:34 INFO - MultiFileLogger online at 20160524 07:26:34 in /builds/slave/test 07:26:34 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 07:26:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:26:34 INFO - {'append_to_log': False, 07:26:34 INFO - 'base_work_dir': '/builds/slave/test', 07:26:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:26:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:26:34 INFO - 'branch': 'Firefox-Non-PGO', 07:26:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:26:34 INFO - 'config_files': ('talos/linux_config.py',), 07:26:34 INFO - 'default_actions': ('clobber', 07:26:34 INFO - 'read-buildbot-config', 07:26:34 INFO - 'download-and-extract', 07:26:34 INFO - 'populate-webroot', 07:26:34 INFO - 'create-virtualenv', 07:26:34 INFO - 'install', 07:26:34 INFO - 'run-tests'), 07:26:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:26:34 INFO - 'download_minidump_stackwalk': True, 07:26:34 INFO - 'download_symbols': 'ondemand', 07:26:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:26:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:26:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:26:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:26:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:26:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:26:34 INFO - 'installer_path': 'installer.exe', 07:26:34 INFO - 'log_level': 'info', 07:26:34 INFO - 'log_name': 'talos', 07:26:34 INFO - 'log_to_console': True, 07:26:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:26:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:26:34 INFO - 'opt_config_files': (), 07:26:34 INFO - 'pip_index': False, 07:26:34 INFO - 'sps_profile': False, 07:26:34 INFO - 'sps_profile_interval': 0, 07:26:34 INFO - 'suite': 'dromaeojs', 07:26:34 INFO - 'system_bits': '32', 07:26:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:26:34 INFO - 'title': 'talos-linux64-ix-039', 07:26:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:26:34 INFO - 'use_talos_json': True, 07:26:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:26:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:26:34 INFO - 'work_dir': 'build'} 07:26:34 INFO - ##### 07:26:34 INFO - ##### Running clobber step. 07:26:34 INFO - ##### 07:26:34 INFO - Running pre-action listener: _resource_record_pre_action 07:26:34 INFO - Running main action method: clobber 07:26:34 INFO - rmtree: /builds/slave/test/build 07:26:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:26:35 INFO - Running post-action listener: _resource_record_post_action 07:26:35 INFO - ##### 07:26:35 INFO - ##### Finished clobber step (success) 07:26:35 INFO - ##### 07:26:35 INFO - ##### 07:26:35 INFO - ##### Running read-buildbot-config step. 07:26:35 INFO - ##### 07:26:35 INFO - Running pre-action listener: _resource_record_pre_action 07:26:35 INFO - Running main action method: read_buildbot_config 07:26:35 INFO - Using buildbot properties: 07:26:35 INFO - { 07:26:35 INFO - "project": "", 07:26:35 INFO - "product": "firefox", 07:26:35 INFO - "script_repo_revision": "production", 07:26:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:26:35 INFO - "repository": "", 07:26:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:26:35 INFO - "buildid": "20160524055509", 07:26:35 INFO - "pgo_build": "False", 07:26:35 INFO - "basedir": "/builds/slave/test", 07:26:35 INFO - "buildnumber": 511, 07:26:35 INFO - "slavename": "talos-linux64-ix-039", 07:26:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:26:35 INFO - "platform": "ubuntu64_hw", 07:26:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:26:35 INFO - "branch": "mozilla-central", 07:26:35 INFO - "repo_path": "mozilla-central", 07:26:35 INFO - "revision": "829d3be6ba648b838ee1953fdfa1a477dace752f", 07:26:35 INFO - "stage_platform": "linux64", 07:26:35 INFO - "builduid": "7b184da7e9404d6784228b66b8fb2b35", 07:26:35 INFO - "slavebuilddir": "test" 07:26:35 INFO - } 07:26:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:26:35 INFO - Running post-action listener: _resource_record_post_action 07:26:35 INFO - ##### 07:26:35 INFO - ##### Finished read-buildbot-config step (success) 07:26:35 INFO - ##### 07:26:35 INFO - ##### 07:26:35 INFO - ##### Running download-and-extract step. 07:26:35 INFO - ##### 07:26:35 INFO - Running pre-action listener: _resource_record_pre_action 07:26:35 INFO - Running main action method: download_and_extract 07:26:35 INFO - mkdir: /builds/slave/test/build/tests 07:26:35 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')]} 07:26:35 INFO - https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:37 INFO - Downloaded 1361 bytes. 07:26:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:26:37 INFO - Using the following test package requirements: 07:26:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:26:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:26:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:26:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'jsshell-linux-x86_64.zip'], 07:26:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:26:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:26:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:26:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:26:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:26:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:26:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:26:37 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')]} 07:26:37 INFO - https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:41 INFO - Downloaded 22844234 bytes. 07:26:41 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'] 07:26:41 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 07:26:42 INFO - Return code: 0 07:26:42 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 07:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:42 INFO - https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:47 INFO - Downloaded 22844234 bytes. 07:26:47 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'] 07:26:47 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 07:26:48 INFO - Return code: 0 07:26: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')]} 07:26:48 INFO - https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:49 INFO - Downloaded 10840359 bytes. 07:26:49 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'] 07:26:49 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 07:26:50 INFO - Return code: 0 07:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:50 INFO - https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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 07:26:51 INFO - Downloaded 54823616 bytes. 07:26:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:26:51 INFO - mkdir: /builds/slave/test/properties 07:26:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:26:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:26:51 INFO - Contents: 07:26:51 INFO - build_url:https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:26:52 INFO - Running post-action listener: _resource_record_post_action 07:26:52 INFO - Running post-action listener: set_extra_try_arguments 07:26:52 INFO - ##### 07:26:52 INFO - ##### Finished download-and-extract step (success) 07:26:52 INFO - ##### 07:26:52 INFO - ##### 07:26:52 INFO - ##### Running populate-webroot step. 07:26:52 INFO - ##### 07:26:52 INFO - Running pre-action listener: _resource_record_pre_action 07:26:52 INFO - Running main action method: populate_webroot 07:26:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:26:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:26:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:26:52 INFO - '--tppagecycles', 07:26:52 INFO - '7'], 07:26:52 INFO - 'tests': ['tsvgm']}}, 07:26:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:26:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:26:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:26:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:26:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['damp', 'tps']}, 07:26:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'tests': ['damp', 'tps']}, 07:26:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['dromaeo_dom']}, 07:26:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:26:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['a11yr', 07:26:52 INFO - 'ts_paint', 07:26:52 INFO - 'tpaint', 07:26:52 INFO - 'sessionrestore', 07:26:52 INFO - 'sessionrestore_no_auto_restore', 07:26:52 INFO - 'tabpaint']}, 07:26:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['tsvgx', 07:26:52 INFO - 'tsvgr_opacity', 07:26:52 INFO - 'tart', 07:26:52 INFO - 'tscrollx', 07:26:52 INFO - 'cart']}, 07:26:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:26:52 INFO - 'tsvgr_opacity', 07:26:52 INFO - 'tart', 07:26:52 INFO - 'tscrollx', 07:26:52 INFO - 'cart']}, 07:26:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'talos_options': ['--disable-e10s'], 07:26:52 INFO - 'tests': ['tp5o']}, 07:26:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'tests': ['tp5o']}, 07:26:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'talos_options': ['--disable-e10s', 07:26:52 INFO - '--xperf_path', 07:26:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:52 INFO - 'tests': ['tp5n']}, 07:26:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:52 INFO - 'talos_options': ['--xperf_path', 07:26:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:52 INFO - 'tests': ['tp5n']}}, 07:26:52 INFO - 'talos.zip': {'path': '', 07:26:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:26:52 INFO - Running post-action listener: _resource_record_post_action 07:26:52 INFO - ##### 07:26:52 INFO - ##### Finished populate-webroot step (success) 07:26:52 INFO - ##### 07:26:52 INFO - ##### 07:26:52 INFO - ##### Running create-virtualenv step. 07:26:52 INFO - ##### 07:26:52 INFO - Running pre-action listener: _resource_record_pre_action 07:26:52 INFO - Running main action method: create_virtualenv 07:26:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:26:52 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 07:26:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:26:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:26:52 INFO - Using real prefix '/usr' 07:26:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:26:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:26:54 INFO - Installing pip.................done. 07:26:54 INFO - Return code: 0 07:26:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:54 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:26:54 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 07:26:54 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 07:26:54 INFO - Using env: {'DISPLAY': ':0', 07:26:54 INFO - 'HOME': '/home/cltbld', 07:26:54 INFO - 'LANG': 'en_US.UTF-8', 07:26:54 INFO - 'LANGUAGE': 'en_US:en', 07:26:54 INFO - 'LOGNAME': 'cltbld', 07:26:54 INFO - 'MAIL': '/var/mail/cltbld', 07:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:54 INFO - 'MOZ_NO_REMOTE': '1', 07:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:54 INFO - 'NO_EM_RESTART': '1', 07:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:54 INFO - 'PWD': '/builds/slave/test', 07:26:54 INFO - 'SHELL': '/bin/bash', 07:26:54 INFO - 'SHLVL': '1', 07:26:54 INFO - 'TERM': 'linux', 07:26:54 INFO - 'TMOUT': '86400', 07:26:54 INFO - 'USER': 'cltbld', 07:26:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:54 INFO - '_': '/tools/buildbot/bin/python'} 07:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:54 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 07:26:54 INFO - Cleaning up... 07:26:54 INFO - Return code: 0 07:26:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:54 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:26:54 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 07:26:54 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 07:26:54 INFO - Using env: {'DISPLAY': ':0', 07:26:54 INFO - 'HOME': '/home/cltbld', 07:26:54 INFO - 'LANG': 'en_US.UTF-8', 07:26:54 INFO - 'LANGUAGE': 'en_US:en', 07:26:54 INFO - 'LOGNAME': 'cltbld', 07:26:54 INFO - 'MAIL': '/var/mail/cltbld', 07:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:54 INFO - 'MOZ_NO_REMOTE': '1', 07:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:54 INFO - 'NO_EM_RESTART': '1', 07:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:54 INFO - 'PWD': '/builds/slave/test', 07:26:54 INFO - 'SHELL': '/bin/bash', 07:26:54 INFO - 'SHLVL': '1', 07:26:54 INFO - 'TERM': 'linux', 07:26:54 INFO - 'TMOUT': '86400', 07:26:54 INFO - 'USER': 'cltbld', 07:26:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:54 INFO - '_': '/tools/buildbot/bin/python'} 07:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:55 INFO - Downloading/unpacking psutil>=3.1.1 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:26:57 INFO - Installing collected packages: psutil 07:26:57 INFO - Running setup.py install for psutil 07:26:57 INFO - building 'psutil._psutil_linux' extension 07:26:57 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 07:26:57 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 07:26:57 INFO - building 'psutil._psutil_posix' extension 07:26:57 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 07:26:57 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 07:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:26:57 INFO - Successfully installed psutil 07:26:57 INFO - Cleaning up... 07:26:57 INFO - Return code: 0 07:26:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:57 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:26:57 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 07:26:57 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 07:26:57 INFO - Using env: {'DISPLAY': ':0', 07:26:57 INFO - 'HOME': '/home/cltbld', 07:26:57 INFO - 'LANG': 'en_US.UTF-8', 07:26:57 INFO - 'LANGUAGE': 'en_US:en', 07:26:57 INFO - 'LOGNAME': 'cltbld', 07:26:57 INFO - 'MAIL': '/var/mail/cltbld', 07:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:57 INFO - 'MOZ_NO_REMOTE': '1', 07:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:57 INFO - 'NO_EM_RESTART': '1', 07:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:57 INFO - 'PWD': '/builds/slave/test', 07:26:57 INFO - 'SHELL': '/bin/bash', 07:26:57 INFO - 'SHLVL': '1', 07:26:57 INFO - 'TERM': 'linux', 07:26:57 INFO - 'TMOUT': '86400', 07:26:57 INFO - 'USER': 'cltbld', 07:26:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:57 INFO - '_': '/tools/buildbot/bin/python'} 07:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26: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 07:26:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:26:59 INFO - Installing collected packages: mozsystemmonitor 07:26:59 INFO - Running setup.py install for mozsystemmonitor 07:26:59 INFO - Successfully installed mozsystemmonitor 07:26:59 INFO - Cleaning up... 07:26:59 INFO - Return code: 0 07:26:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:59 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:26:59 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 07:26:59 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 07:26:59 INFO - Using env: {'DISPLAY': ':0', 07:26:59 INFO - 'HOME': '/home/cltbld', 07:26:59 INFO - 'LANG': 'en_US.UTF-8', 07:26:59 INFO - 'LANGUAGE': 'en_US:en', 07:26:59 INFO - 'LOGNAME': 'cltbld', 07:26:59 INFO - 'MAIL': '/var/mail/cltbld', 07:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:59 INFO - 'MOZ_NO_REMOTE': '1', 07:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:59 INFO - 'NO_EM_RESTART': '1', 07:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:59 INFO - 'PWD': '/builds/slave/test', 07:26:59 INFO - 'SHELL': '/bin/bash', 07:26:59 INFO - 'SHLVL': '1', 07:26:59 INFO - 'TERM': 'linux', 07:26:59 INFO - 'TMOUT': '86400', 07:26:59 INFO - 'USER': 'cltbld', 07:26:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:59 INFO - '_': '/tools/buildbot/bin/python'} 07:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:00 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 07:27:00 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 07:27:00 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 07:27:00 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 07:27:00 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 07:27:00 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 07:27:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 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 07:27:02 INFO - Downloading docopt-0.6.1.tar.gz 07:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:02 INFO - Running setup.py install for blobuploader 07:27:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:02 INFO - Running setup.py install for requests 07:27:03 INFO - Running setup.py install for docopt 07:27:03 INFO - Successfully installed blobuploader requests docopt 07:27:03 INFO - Cleaning up... 07:27:03 INFO - Return code: 0 07:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:03 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:27:03 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 07:27:03 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 07:27:03 INFO - Using env: {'DISPLAY': ':0', 07:27:03 INFO - 'HOME': '/home/cltbld', 07:27:03 INFO - 'LANG': 'en_US.UTF-8', 07:27:03 INFO - 'LANGUAGE': 'en_US:en', 07:27:03 INFO - 'LOGNAME': 'cltbld', 07:27:03 INFO - 'MAIL': '/var/mail/cltbld', 07:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:03 INFO - 'MOZ_NO_REMOTE': '1', 07:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:03 INFO - 'NO_EM_RESTART': '1', 07:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:03 INFO - 'PWD': '/builds/slave/test', 07:27:03 INFO - 'SHELL': '/bin/bash', 07:27:03 INFO - 'SHLVL': '1', 07:27:03 INFO - 'TERM': 'linux', 07:27:03 INFO - 'TMOUT': '86400', 07:27:03 INFO - 'USER': 'cltbld', 07:27:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:03 INFO - '_': '/tools/buildbot/bin/python'} 07:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:03 INFO - Running setup.py (path:/tmp/pip-W1dOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:03 INFO - Running setup.py (path:/tmp/pip-fS5Eu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:03 INFO - Running setup.py (path:/tmp/pip-9BK26y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:03 INFO - Running setup.py (path:/tmp/pip-Nxhiav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:03 INFO - Running setup.py (path:/tmp/pip-nRcFmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:04 INFO - Running setup.py (path:/tmp/pip-a_3VhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:04 INFO - Running setup.py (path:/tmp/pip-vKCjSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:04 INFO - Running setup.py (path:/tmp/pip-qYckf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:04 INFO - Running setup.py (path:/tmp/pip-XEErmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:04 INFO - Running setup.py (path:/tmp/pip-pefSsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:04 INFO - Running setup.py (path:/tmp/pip-QYfjZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:04 INFO - Running setup.py (path:/tmp/pip-_bNmYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:04 INFO - Running setup.py (path:/tmp/pip-4untMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:04 INFO - Running setup.py (path:/tmp/pip-Z6O_RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:04 INFO - Running setup.py (path:/tmp/pip-DksWbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:04 INFO - Running setup.py (path:/tmp/pip-T_ytOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:04 INFO - Running setup.py (path:/tmp/pip-NPhU2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:04 INFO - Running setup.py install for manifestparser 07:27:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:04 INFO - Running setup.py install for mozcrash 07:27:05 INFO - Running setup.py install for mozdebug 07:27:05 INFO - Running setup.py install for mozdevice 07:27:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Running setup.py install for mozfile 07:27:05 INFO - Running setup.py install for mozhttpd 07:27:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Running setup.py install for mozinfo 07:27:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Running setup.py install for mozInstall 07:27:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Running setup.py install for mozleak 07:27:05 INFO - Running setup.py install for mozlog 07:27:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:05 INFO - Running setup.py install for moznetwork 07:27:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Running setup.py install for mozprocess 07:27:06 INFO - Running setup.py install for mozprofile 07:27:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Running setup.py install for mozrunner 07:27:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Running setup.py install for mozscreenshot 07:27:06 INFO - Running setup.py install for moztest 07:27:06 INFO - Running setup.py install for mozversion 07:27:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:06 INFO - Cleaning up... 07:27:06 INFO - Return code: 0 07:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:27:06 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 07:27:06 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 07:27:06 INFO - Using env: {'DISPLAY': ':0', 07:27:06 INFO - 'HOME': '/home/cltbld', 07:27:06 INFO - 'LANG': 'en_US.UTF-8', 07:27:06 INFO - 'LANGUAGE': 'en_US:en', 07:27:06 INFO - 'LOGNAME': 'cltbld', 07:27:06 INFO - 'MAIL': '/var/mail/cltbld', 07:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:06 INFO - 'MOZ_NO_REMOTE': '1', 07:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:06 INFO - 'NO_EM_RESTART': '1', 07:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:06 INFO - 'PWD': '/builds/slave/test', 07:27:06 INFO - 'SHELL': '/bin/bash', 07:27:06 INFO - 'SHLVL': '1', 07:27:06 INFO - 'TERM': 'linux', 07:27:06 INFO - 'TMOUT': '86400', 07:27:06 INFO - 'USER': 'cltbld', 07:27:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:06 INFO - '_': '/tools/buildbot/bin/python'} 07:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:06 INFO - Running setup.py (path:/tmp/pip-SjKcK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:06 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)) 07:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:06 INFO - Running setup.py (path:/tmp/pip-auVvg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:07 INFO - Running setup.py (path:/tmp/pip-52B0Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:07 INFO - Running setup.py (path:/tmp/pip-Oy_Ifo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:07 INFO - Running setup.py (path:/tmp/pip-L5Phq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:07 INFO - Running setup.py (path:/tmp/pip-txKdsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:07 INFO - Running setup.py (path:/tmp/pip-Z082c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:07 INFO - Running setup.py (path:/tmp/pip-sTqSj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:07 INFO - Running setup.py (path:/tmp/pip-ZUraxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:07 INFO - Running setup.py (path:/tmp/pip-HZ9GVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:07 INFO - Running setup.py (path:/tmp/pip-sdeZaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:07 INFO - Running setup.py (path:/tmp/pip-4Gbuie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:07 INFO - Running setup.py (path:/tmp/pip-7Xu4O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:07 INFO - Running setup.py (path:/tmp/pip-abNpLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:07 INFO - Running setup.py (path:/tmp/pip-D8zjW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:07 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)) 07:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:07 INFO - Running setup.py (path:/tmp/pip-M43z13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:08 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)) 07:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:08 INFO - Running setup.py (path:/tmp/pip-fWGtiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:08 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)) 07:27:08 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)) 07:27:08 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)) 07:27:08 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)) 07:27:08 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)) 07:27:08 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)) 07:27:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:09 INFO - Downloading blessings-1.6.tar.gz 07:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:10 INFO - Installing collected packages: blessings 07:27:10 INFO - Running setup.py install for blessings 07:27:10 INFO - Successfully installed blessings 07:27:10 INFO - Cleaning up... 07:27:10 INFO - Return code: 0 07:27:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:10 INFO - Reading from file tmpfile_stdout 07:27:10 INFO - Current package versions: 07:27:10 INFO - argparse == 1.2.1 07:27:10 INFO - blessings == 1.6 07:27:10 INFO - blobuploader == 1.2.4 07:27:10 INFO - docopt == 0.6.1 07:27:10 INFO - manifestparser == 1.1 07:27:10 INFO - mozInstall == 1.12 07:27:10 INFO - mozcrash == 0.17 07:27:10 INFO - mozdebug == 0.1 07:27:10 INFO - mozdevice == 0.48 07:27:10 INFO - mozfile == 1.2 07:27:10 INFO - mozhttpd == 0.7 07:27:10 INFO - mozinfo == 0.9 07:27:10 INFO - mozleak == 0.1 07:27:10 INFO - mozlog == 3.2 07:27:10 INFO - moznetwork == 0.27 07:27:10 INFO - mozprocess == 0.22 07:27:10 INFO - mozprofile == 0.28 07:27:10 INFO - mozrunner == 6.11 07:27:10 INFO - mozscreenshot == 0.1 07:27:10 INFO - mozsystemmonitor == 0.3 07:27:10 INFO - moztest == 0.7 07:27:10 INFO - mozversion == 1.4 07:27:10 INFO - psutil == 3.1.1 07:27:10 INFO - requests == 1.2.3 07:27:10 INFO - wsgiref == 0.1.2 07:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:27:10 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 07:27:10 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 07:27:10 INFO - Using env: {'DISPLAY': ':0', 07:27:10 INFO - 'HOME': '/home/cltbld', 07:27:10 INFO - 'LANG': 'en_US.UTF-8', 07:27:10 INFO - 'LANGUAGE': 'en_US:en', 07:27:10 INFO - 'LOGNAME': 'cltbld', 07:27:10 INFO - 'MAIL': '/var/mail/cltbld', 07:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:10 INFO - 'MOZ_NO_REMOTE': '1', 07:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:10 INFO - 'NO_EM_RESTART': '1', 07:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:10 INFO - 'PWD': '/builds/slave/test', 07:27:10 INFO - 'SHELL': '/bin/bash', 07:27:10 INFO - 'SHLVL': '1', 07:27:10 INFO - 'TERM': 'linux', 07:27:10 INFO - 'TMOUT': '86400', 07:27:10 INFO - 'USER': 'cltbld', 07:27:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:10 INFO - '_': '/tools/buildbot/bin/python'} 07:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 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)) 07:27:10 INFO - Cleaning up... 07:27:10 INFO - Return code: 0 07:27:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:27:10 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 07:27:10 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 07:27:10 INFO - Using env: {'DISPLAY': ':0', 07:27:10 INFO - 'HOME': '/home/cltbld', 07:27:10 INFO - 'LANG': 'en_US.UTF-8', 07:27:10 INFO - 'LANGUAGE': 'en_US:en', 07:27:10 INFO - 'LOGNAME': 'cltbld', 07:27:10 INFO - 'MAIL': '/var/mail/cltbld', 07:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:10 INFO - 'MOZ_NO_REMOTE': '1', 07:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:10 INFO - 'NO_EM_RESTART': '1', 07:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:10 INFO - 'PWD': '/builds/slave/test', 07:27:10 INFO - 'SHELL': '/bin/bash', 07:27:10 INFO - 'SHLVL': '1', 07:27:10 INFO - 'TERM': 'linux', 07:27:10 INFO - 'TMOUT': '86400', 07:27:10 INFO - 'USER': 'cltbld', 07:27:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:10 INFO - '_': '/tools/buildbot/bin/python'} 07:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:10 INFO - Downloading/unpacking jsonschema 07:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 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 07:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:13 INFO - warning: no files found matching '*.txt' 07:27:13 INFO - no previously-included directories found matching 'build' 07:27:13 INFO - no previously-included directories found matching 'dist' 07:27:13 INFO - no previously-included directories found matching '.git*' 07:27:13 INFO - Installing collected packages: jsonschema, functools32 07:27:13 INFO - Running setup.py install for functools32 07:27:13 INFO - warning: no files found matching '*.txt' 07:27:13 INFO - no previously-included directories found matching 'build' 07:27:13 INFO - no previously-included directories found matching 'dist' 07:27:13 INFO - no previously-included directories found matching '.git*' 07:27:13 INFO - Successfully installed jsonschema functools32 07:27:13 INFO - Cleaning up... 07:27:13 INFO - Return code: 0 07:27:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:13 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 0x7f77d907cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, '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': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', '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 07:27:13 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 07:27:13 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 07:27:13 INFO - Using env: {'DISPLAY': ':0', 07:27:13 INFO - 'HOME': '/home/cltbld', 07:27:13 INFO - 'LANG': 'en_US.UTF-8', 07:27:13 INFO - 'LANGUAGE': 'en_US:en', 07:27:13 INFO - 'LOGNAME': 'cltbld', 07:27:13 INFO - 'MAIL': '/var/mail/cltbld', 07:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:13 INFO - 'MOZ_NO_REMOTE': '1', 07:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:13 INFO - 'NO_EM_RESTART': '1', 07:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:13 INFO - 'PWD': '/builds/slave/test', 07:27:13 INFO - 'SHELL': '/bin/bash', 07:27:13 INFO - 'SHLVL': '1', 07:27:13 INFO - 'TERM': 'linux', 07:27:13 INFO - 'TMOUT': '86400', 07:27:13 INFO - 'USER': 'cltbld', 07:27:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:13 INFO - '_': '/tools/buildbot/bin/python'} 07:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:13 INFO - Downloading/unpacking flake8 07:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:27:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:27:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:16 INFO - no previously-included directories found matching 'docs/_build' 07:27:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:27:16 INFO - Running setup.py install for pep8 07:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:16 INFO - no previously-included directories found matching 'docs/_build' 07:27:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:27:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:27:16 INFO - Cleaning up... 07:27:16 INFO - Return code: 0 07:27:16 INFO - Running post-action listener: _resource_record_post_action 07:27:16 INFO - Running post-action listener: _start_resource_monitoring 07:27:16 INFO - Starting resource monitoring. 07:27:16 INFO - ##### 07:27:16 INFO - ##### Finished create-virtualenv step (success) 07:27:16 INFO - ##### 07:27:16 INFO - ##### 07:27:16 INFO - ##### Running install step. 07:27:16 INFO - ##### 07:27:16 INFO - Running pre-action listener: _resource_record_pre_action 07:27:16 INFO - Running main action method: install 07:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:16 INFO - Reading from file tmpfile_stdout 07:27:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:27:16 INFO - Reading from file tmpfile_stdout 07:27:16 INFO - Output received: 07:27:16 INFO - Usage: mozinstall [options] installer 07:27:16 INFO - Options: 07:27:16 INFO - -h, --help show this help message and exit 07:27:16 INFO - -d DEST, --destination=DEST 07:27:16 INFO - Directory to install application into. [default: 07:27:16 INFO - "/builds/slave/test"] 07:27:16 INFO - --app=APP Application being installed. [default: firefox] 07:27:16 INFO - mkdir: /builds/slave/test/build/application 07:27:16 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'] 07:27:16 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 07:27:32 INFO - Reading from file tmpfile_stdout 07:27:32 INFO - Output received: 07:27:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:27:32 INFO - Running post-action listener: _resource_record_post_action 07:27:32 INFO - ##### 07:27:32 INFO - ##### Finished install step (success) 07:27:32 INFO - ##### 07:27:32 INFO - ##### 07:27:32 INFO - ##### Running run-tests step. 07:27:32 INFO - ##### 07:27:32 INFO - Running pre-action listener: _resource_record_pre_action 07:27:32 INFO - Running main action method: run_tests 07:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:27:32 INFO - Python 2.7.3 07:27:32 INFO - Return code: 0 07:27:32 INFO - grabbing minidump binary from tooltool 07:27:32 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')]} 07:27:32 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 0x152f9c0>, '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 0x15308c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:27:32 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 07:27:32 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 07:27:32 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 07:27:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:27:32 INFO - Return code: 0 07:27:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:27:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:27:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:27:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:27:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:27:33 INFO - Return code: 0 07:27:33 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/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:27:33 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/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:27:33 INFO - Using env: {'DISPLAY': ':0', 07:27:33 INFO - 'HOME': '/home/cltbld', 07:27:33 INFO - 'LANG': 'en_US.UTF-8', 07:27:33 INFO - 'LANGUAGE': 'en_US:en', 07:27:33 INFO - 'LOGNAME': 'cltbld', 07:27:33 INFO - 'MAIL': '/var/mail/cltbld', 07:27:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:27:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:33 INFO - 'MOZ_NO_REMOTE': '1', 07:27:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:33 INFO - 'NO_EM_RESTART': '1', 07:27:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:33 INFO - 'PWD': '/builds/slave/test', 07:27:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:27:33 INFO - 'SHELL': '/bin/bash', 07:27:33 INFO - 'SHLVL': '1', 07:27:33 INFO - 'TERM': 'linux', 07:27:33 INFO - 'TMOUT': '86400', 07:27:33 INFO - 'USER': 'cltbld', 07:27:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987', 07:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:33 INFO - '_': '/tools/buildbot/bin/python'} 07:27:33 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/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:27:33 INFO - mozversion application_buildid: 20160524055509 07:27:33 INFO - mozversion application_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 07:27:33 INFO - mozversion application_display_name: Nightly 07:27:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:27:33 INFO - mozversion application_name: Firefox 07:27:33 INFO - mozversion application_remotingname: firefox 07:27:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:27:33 INFO - mozversion application_vendor: Mozilla 07:27:33 INFO - mozversion application_version: 49.0a1 07:27:33 INFO - mozversion platform_buildid: 20160524055509 07:27:33 INFO - mozversion platform_changeset: 829d3be6ba648b838ee1953fdfa1a477dace752f 07:27:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:27:33 INFO - mozversion platform_version: 49.0a1 07:27:33 INFO - using testdate: 1464100053 07:27:33 INFO - actual date: 1464100053 07:27:33 INFO - starting webserver on 'localhost:48049' 07:27:33 INFO - SUITE-START | Running 2 tests 07:27:33 INFO - TEST-START | dromaeo_css 07:27:33 INFO - operating with platform_type : linux_ 07:27:33 INFO - Initialising browser for dromaeo_css test... 07:27:33 INFO - TEST-INFO | started process 18254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaJGei/profile http://localhost:48049/getInfo.html) 07:27:38 INFO - PROCESS | 18254 | __metrics Screen width/height:1600/1200 07:27:38 INFO - PROCESS | 18254 | colorDepth:24 07:27:38 INFO - PROCESS | 18254 | Browser inner width/height: 1024/697 07:27:38 INFO - PROCESS | 18254 | __metrics 07:27:39 ERROR - PROCESS | 18254 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:27:40 INFO - TEST-INFO | 18254: exit 0 07:27:40 INFO - Browser initialized. 07:27:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:27:40 INFO - TEST-INFO | started process 18336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaJGei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:52 INFO - PROCESS | 18336 | RSS: Main: 154157056 07:27:52 INFO - PROCESS | 18336 | 07:28:44 INFO - PROCESS | 18336 | 1464100123997 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] 07:30:55 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48049/tests/dromaeo/cssquery-ext.html) 07:30:56 INFO - PROCESS | 18336 | RSS: Main: 238649344 07:30:56 INFO - PROCESS | 18336 | 07:33:59 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-ext.html (next: http://localhost:48049/tests/dromaeo/cssquery-jquery.html) 07:33:59 INFO - PROCESS | 18336 | RSS: Main: 244523008 07:33:59 INFO - PROCESS | 18336 | 07:37:02 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48049/tests/dromaeo/cssquery-mootools.html) 07:37:02 INFO - PROCESS | 18336 | RSS: Main: 238768128 07:37:02 INFO - PROCESS | 18336 | 07:40:04 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48049/tests/dromaeo/cssquery-prototype.html) 07:40:05 INFO - PROCESS | 18336 | RSS: Main: 242266112 07:40:05 INFO - PROCESS | 18336 | 07:43:08 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48049/tests/dromaeo/cssquery-yui.html) 07:43:08 INFO - PROCESS | 18336 | RSS: Main: 215212032 07:43:08 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | Cycle 1(1): loaded http://localhost:48049/tests/dromaeo/cssquery-yui.html (next: http://localhost:48049/tests/dromaeo/cssquery-dojo.html) 07:46:11 INFO - PROCESS | 18336 | RSS: Main: 271216640 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | __start_tp_report 07:46:11 INFO - PROCESS | 18336 | _x_x_mozilla_page_load 07:46:11 INFO - PROCESS | 18336 | _x_x_mozilla_page_load_details 07:46:11 INFO - PROCESS | 18336 | |i|pagename|runs| 07:46:11 INFO - PROCESS | 18336 | |0;dojo.html;2684.382592003839;2694.676638803344;2729.1266794625703;2729.686086100098;2749.766269867061;4579.450465944092;4643.466001409839;4723;4802.807887684493;4812.181929072058;4713.410823647044;4720.268358404444;4735.076660051292;4778.3549220855175;4778.784954677039;4317.33081372387;4318.07161460286;4387.824487020515;4420.97789511052;4553.066621342633;4483.260262056757;4510.278355463127;4516.345129956155;4541.205289074399;4570.725756454607;4237.894052648678;4298.204832106039;4300.763458009808;4387.692861499696;4450.243458612027;4340.7178533395545;4341.261985462479;4346.0655958968655;4401.5818497243035;4480.686351955332;4362.411074504933;4369.519352871182;4395.4725432947935;4405.295152775572;4411.117776444692;4456.019675671347;4655.650826188049;4731.810727570893;4769.880752981168;4781.904361912742;5082.110630639623;5109.080365534202;5153.6907785532985;5154.793808247666;5162.845114646529;5135.6918584885025;5185.844424667228;5202.557782588485;5206.0368831766245;5210.296609957645;4650.302454631832;4790.161721698689;4831.130396528623;4837.080954618611;4840.782164802592;5324.148136298251;5327.920081198785;5351.224072509464;5361.142217245222;5377.596680248997;5094.363204599425;5125.718085505258;5135.948640513547;5142.51146141116;5143.434222235551;4913.828016019494;5018.799248030111;5051.318072060299;5063.772130254148;5219.1388420910125;4993.800247990112;5000.874978125576;5013.373328333958;5015.82444614444;5065.39215294167;5015.773496557587;5018.222175562793;5018.2974383586325;5021.121303771898;5025.698458092526;4258.53156152823;4293.592108749664;4295.033617436052;4336.3278691802825;4339.7830108494445;3788.886333410002;3810.237952409529;3815.1988082502985;3824.6366595173413;3829.5021647185686;4420.58004489573;4427.579379958899;4435.756033418193;4437.33439984005;4439.0234148487925;5140.254663073833;5166;5170.431252562215;5174.482551744795;5207.817726379634;4456.242438785414;4458.420405347284;4464.419625448736;4468.173387923244;4512.638988880882;4476.082403107355;4653.325267836145;4679.040796636681;4692.319613656001;4715.221988371949;4892.357240183327;4896.2410826321975;4903.583195428429;4904.2643603459765;4940.456549779521;5168.276441298296;5207.661502002357;5215.608829337739;5217.321748172713;5228.816991405435;4674.298855171752;4848.951510484992;4855.1988921828915;4891.755412229445;4899.804007839646;5101.744912754421;5121.231815227746;5123.205903085028;5123.974380128225;5176.4047134578495;5177.7670004849115;5184.066867963803;5188.377394712658;5191.195364718475;5193.896122077462;4782.402199725035;4935.407751069894;4942.654014219114;4978.975105124451;4990.051890140861;4966.950330496793;4995.750212489288;4996.650234483696;5002.424721156968;5055.469175736494;4754.976225118852;4914.5822605078965;4930.433000205022;4934.259861020875;4978.975105124596;4965.230389289666;5009.924851127309;5021.84934451967;5026.120428924851;5034.144195486703;4916.311716359641;4929.926051109164;4930.630202734881;4936.407631084293;4988.4263309719845 07:46:11 INFO - PROCESS | 18336 | |1;ext.html;596.439347013807;612.9693515324234;613.408061220922;627.5952010952939;633.2211380002594;28068.719312806865;41480;42466.787666061624;42723.57276427235;46774.53225467753;44523.3321500177;45004;45065.7746711266;45074.549254507445;45108.77445612767;7760.146383897767;7940.841183176333;7942.960285198595;7944.563049032301;7952.483088599222;7729.574873381962;7867.252611001974;7887.526748395086;7889.526628402315;7896;7878.330341920943;7883.526988380716;7921.089074756419;7931.325837303836;7953.403494737918;7846.176151504095;7922.088959769642;7925.286724194792;7926.365890728728;7926.405519586026;7840.0591928968315;7843.803904902366;7909.288164065204;7930.405219608552;7935.920640793576;40164.59835401638;40693.389599156035;41099.589004109876;41144.97137571555;41155.176896461904;3145.370925814846;3230.48312270038;3231.4021905947475;3302.9009129725905;3424.520567120605;30572.54141187884;30603.081907542808;30726.231844204074;31155;31746.841265793755;3546.148924258185;3553.008023726668;3557.804320762357;3596.6942809861193;3620.6198349173483;273184;273359;273772.999999998;274594;275657;58497.415025850045;58506;58966.57750668717;59056;59182.40817591769;49499.752501237985;58116.70941645265;59060.409395906354;62064;62207;15439.768403473958;15650.843491565167;15655.138967356677;15666.216689165496;15684.607884802743;11547.942260288644;11673.533058677558;11686.94156529212;11691.064714822794;11697.532098716127;15944.123073231083;17830.732539011926;18505.81494185041;18521.259149634134;18810.43568692914;6451.903221451682;6453.386928241809;6503.902441463382;6535.477161827042;6642.634655094016;866.6966561703354;938.2072149034192;963.8313295173317;1007.1690855044471;1062.2245760594808;27898.442031159262;28844.278893027844;29422.264443389085;29494.410111797642;29800.552991705143;978.5449765858909;981.2346369831542;993.8956409577034;998.9650362237287;1002.7192386131894;14998.775018374734;15425.84574154244;15511.612209694622;15713.764293535605;15724.135172565619;387831;390465;391100;392085;394279;50885.49114508882;51078.744606277476;51187.488125118274;51226.487735122915;51385;1095.7205912492263;1207.1610230889623;1251.8122281657825;1289.9677508062373;1412.3644360038024;28579.714202857704;30890;30911.845440772653;30982.69017309798;31463;45302;46068.53931460776;46174.076518470116;46242.53757462382;46268.768656156506;354820;362178;362700;364203;364602;33715.325693486484;39526.60473395229;39936.40095398513;40173;43466.565334346255;44651.55348446474;44773.32840007468;45421.31868022049;45503.772481137385;45960.54039459563;37781;38096;38128;39118.41322380109;39655.206895862495;37627.81186094052;37763.04238931518;38086;38286;38299.617003829604;37770.62229377781;37854.43218351672;37903.24193516169;38269;38321.42517862179;33648;34980;35622.465663015595;35801.28397432089;36065.098372540895;25882.35294117662;26007.479850403266;26015.479690405708;26234.21297361082;26554.336141596614 07:46:11 INFO - PROCESS | 18336 | |2;jquery.html;367.5442451360313;367.95584529856416;369.5140889730003;381.572638644718;386.1389102301865;16056;17589.82410175898;17703.203355848986;17894.463166105004;18049.097545122724;15971.281292341844;16676;16728.581785455368;16740.748888766648;17403.12984350784;4502.999999999992;4632.930506042412;4635.629149668035;4806.735629540374;4822.469528351879;3506.105942984548;3671.4125739881624;5231.084560201968;5543;5556.083246264361;5575.191597218401;5577.749001294951;5578.219049333076;5591.217229587861;5606.775728970836;5229.2156176573435;5538.363088244863;5540.252065971083;5561.416051314594;5571.721413929328;3384.8815291464925;5076.705440112784;5360.812371567015;5365.839024829262;5400.270963419927;11692.883071169264;12016.279023258632;12029.699257518545;12039.63881083569;12308.569200078044;1780.777402824647;1846.1784505894882;1870.8503319734389;1889.3198448558508;1977.7033444983224;8938.597763100675;9153.582529688354;9638.662646807328;9807.06832850878;9958.352707074017;1691.805442374118;1748.0997286397514;1764.1884733022825;1784.9379619126598;1791.9462416127537;65464.67267663631;65852.3414765851;67944;69643.65178174077;69947.65026174938;10290.228232882564;10337.896621033844;10416.635417760343;10431.113355364727;10478.738031549272;14411.42354305837;14433.711325773636;14440.566782996317;14452.494162704255;14463.1322120671;7123;7245.89131163033;7249.601271930094;7359.963200183965;7416.666250018654;6504.577202481823;6535.150430444012;6646.136002319668;6678.5307232408795;6681.799546013627;4186.706930514834;4197.91604167921;4467.128909862546;4468.374427580141;4541.84103556374;1731.5411415974777;1748.5978225008319;1777.4934143768965;1840.1081712178914;1870.1303893689228;798.0423491809852;839.3159574946399;892.3218354050838;895.1048951048951;910.2263076385152;16307.347706091623;16616;16819.663606727798;16881.91559042197;17150;833.9624716887755;850.6980022092192;862.7584276402617;872.6858331000834;905.1627244798535;9075.364724469357;9636.855447168298;9668.951655241679;9671.806563868824;9808.950955245178;378693;395352;397011;397309;399895;69944;70029.29970700228;71434.64282678554;72127.6393618039;72871.63564182252;926.6710317837205;928.7445952363154;929.2194556572512;930.8929473110679;941.5621735892843;14737.336819842918;15057.698846023237;15097;15234;15484.303206355517;35121.82439087788;35257.64742352646;35493.82253088821;35726.10684732799;36405.81797090998;45465;47841.760791197215;49374.50625493699;50115.24827127669;50185.74907125441;7399.741009064657;7405.666744996381;7512.887306690294;7518.323350898446;7633;7804.453688241996;10554.472276386303;10718;10831.51258193399;11009.83485247738;8653.221210091122;9469.66856160031;9831.95084024604;9846.064623860722;9973.252006099427;9251.67619133327;9489.95255023748;9499.38254013487;9575.952120239634;9617.807643846943;9696.272779541421;9902.207823373968;9929.553170107507;9965.651202207888;9970.55132519024;6605.867882642417;6689.866202676017;6907.827304317432;7048.506604537838;7379.077615298088;7543.547387156788;8926.955365223132;9727.513624318897;9939.751506212402;10054.89945100569 07:46:11 INFO - PROCESS | 18336 | |3;mootools.html;1229.4774720743683;1376.4081444978656;1413.455819509489;1526.6183454136467;1756.4203812741805;6967.442604591633;7810.218978102194;7958;7960.681572737083;8267.91732082679;7991.840163196747;8194.590270486482;8196.42625016249;8197.467164634294;8199.057108432533;2191.5288213034196;2221.533477969628;2222.5221577360944;2224.088123869214;2224.5773303072447;2126.13891373993;2144.2602302205714;2147.3235930681863;2147.398728356055;2166.458385403649;2116.7565729941025;2132.0299263834995;2169.2624507667388;2185.672149177628;2188.4419473034354;2133.4133113393864;2139.9251026214088;2140.7538133114736;2143.239150101715;2144.7533533643673;2074.7406574178226;2099.88450635215;2102.5059111108876;2103.2323202031303;2104.389726979174;7987.840243195162;8050.235227653422;8112.472689275178;8119.75640730779;8124.106348301682;4641.744704041276;4801.591864691471;4807.42310922688;4808.927866082012;4812.230043193073;2916.6208392908998;2938.8824447022307;2982.9701702983125;3010.909672709822;3017.2758537950954;917.5504003038529;926.1803304075942;927.5640448988964;929.8423462788803;951.0774548687762;11197.16021298406;11295.096392288679;11314.038306743936;11319.830202546967;11323.43382830855;4022.1754540319166;4127.360259159835;4183.288840897055;4200.054987627759;4208.431861698693;8843.159899809507;8905.376623636283;8932.285417166611;8933.642654293755;8933.821323573493;4670.626349892001;4679.508651591602;4680.531946805292;4686.133065382915;4686.320483529869;3766.227923275777;4106.07613287008;4232.132412855357;4248.915021699549;4344.695871288979;3431.1936694876686;3482.9825850870584;3512.034190597555;3553.218291975761;3578.570571531433;999.1066928171075;1023.053675350298;1027.50679673757;1043.0456132638703;1058.8464672622426;843.1526316052328;859.0679113162164;871.0940621753306;876.7501262140387;880.4321212817824;5143.562797162208;5582;5694.914576281359;5791.739371728282;5798.623089499169;933.73855320509;935.3911272611098;994.4878387630376;1001.7395477175987;1011.7217765114652;3805.2199299144163;3863.092173339263;3915.138669492707;3962.6829853611644;4019.0756126090578;9835.508224588742;10048.246381521416;10148.543315550818;10234.59061637541;10236.027577380137;9980.101790838715;9988.900110998797;10069.69790906274;10074.74813129663;10104.393736375841;7562.848743025109;7600.1639819619795;7796.298333150044;7832.255935686101;7882.881756773539;5622.353429355677;5711.361106694281;5789.797357092481;5810.477057064715;5871.911921321098;9279.582418791035;9504.572294246636;9626.759331016781;9640.614375425184;9659.806803864023;9406.717798466058;9669.70990870275;9677.661281855102;9889.554970026222;9926.900730992598;5908.940910590839;6314.6842657866;6470.158879345655;6565.343465653396;6667.599944003376;7992.760217193493;8000.479968802009;8077.636506357346;8077.7576672699915;8087.8786818196595;7105.964470177616;7246.492745507975;7293.890591641236;7382.224866388952;7440.181580026301;6744.69648865812;6981.825454363681;7152.640998210323;7161.104861892263;7265.636718164176;6055.394460553909;6247.375262473716;6249.593776404519;6262.15460912771;6327.145835312174;4739.123262196505;4793.832215872567;4803.255495398219;4838.395200599925;4906.313116163811;4925.507449255046;4981.227909674007;4989.176785830297;5049.6465247432325;5071.290019397214 07:46:11 INFO - PROCESS | 18336 | |4;prototype.html;298.7654691067512;299.08927316321797;303.64928507573745;308.03584779639726;310.77468835094544;4707.482176960531;4715.764211789409;4737.170995075857;4743.217369134093;4798.032806549316;4672.299155126732;4696.319033740106;4723.669343145981;4725.149473094842;4726.7400292983875;3540.0972751948216;3640.290143422034;3661.8535258589623;3739.420389839566;3783.716221283401;3715.940956827305;3735.682466990309;3741.812909354535;3754.1177823211524;3758.3422900992355;3548.6451354864435;3722.7207959403154;3726.8322925468283;3733.1600389912323;3764.4353346997896;3604.711623070148;3741.906452338686;3746.232022435408;3751.624837516254;3766.4915236443276;3328.4341661917533;3333.300006998509;3345.1637090727318;3346.6486018967903;3352;4498.820047198108;4544.386507821435;4554.2485489894125;4559.407277053995;4569.588737013684;4005.2990726622725;4202.3696445533415;4234.640055595278;4237.7669228192435;4253.787310634487;4922.630802689777;4949.727764972925;4957.801687932479;4959.7024178549045;4976.5023497649945;3421.760476766627;3525.453554699026;3543.6102028776813;3557.4130268505664;3559.2169722660974;5139.743012849342;5179.663321884065;5195.895662256792;5197.8440646780655;5206.271122042879;3591.5510561179854;3623.1123374772824;3623.1304486923477;3633.8546458141377;3639.1811842335264;3665.90022993101;3666.7066634669163;3691.2248427830455;3691.5602914863225;3694.8152592370275;4086.938695919504;4114.979425102855;4175.394567787654;4176.665866730655;4226.260404429274;4923.926141107886;4948.455669876311;4951;4951.282064100686;4965.652404331734;1265.4938024790158;1276.0238417610535;1276.6553030681664;1277.8913792327571;1278.2075113429732;808.2321794295443;817.7178873288825;847.809242920338;870.5473153959905;874.191372979991;4378.605925466723;4407.581279778416;4410.69125161242;4421.646268298528;4426.44669416323;5000.67495612784;5033.748312584356;5038.697678139323;5077.822276220315;5081.74591270435;4264.850730224427;4393.253146965024;4398.604125628644;4401.427814384109;4402.273624851928;2648.2717252755647;2675.451532435846;2677.2771351735314;2679.3033811209225;2698.595210718408;4781;4796.664233503621;4819.204831202883;4822.781520500609;4844.75776211188;4923.679960802537;5157.277981082651;5170.638055336166;5171.612129090258;5216.400113986864;4837.201861692782;4849.830255941025;4852.660313778002;4858.246971719389;4884.655365424545;5086.465921078234;5143.897122057613;5147.9227811583605;5166.328377310925;5172.5344718975475;4805.711657300573;5019.247112933089;5030.320906677552;5041.974790126173;5052.393712754493;4837.540433658797;4861.538153875376;4881.170201065756;4898.559129678346;4904.5095490452095;3657.5062366580173;3680.5215322007966;3689.538807649044;3695.2240029594086;3709.888703338904;4974;5163.845084647316;5170.095233334227;5215.556677682288;5252.212168174804;4977.875553111201;4988.650794444354;4988.725620090785;4993.700377977188;5001.299818025406;4939.901201976012;4947.381577302837;4980.153373926513;4996.000799840119;5027.572656324107;4654.48800631937;4917.803287868445;4942.75286235694;4943.480934501969;4956.553910148104;4779.737114458738;4860.392450943632;4949.406071271326;4982.576480999156;5010.720122344397;4885.633577481632;4887.462379138363;4894.583960363267;4908.656394052382;4919.852404427873 07:46:11 INFO - PROCESS | 18336 | |5;yui.html;686.3376841348098;692.750609780479;704.471646265301;733.5122143774389;767.0641816983281;12074.517019319228;12323;12447;12478.064145189102;12478.688032799184;12038.81941770874;12061.638150855488;12067.698307542316;12070.396480175978;12077.094217933647;611.3916652930341;754.6754895394978;769.6651956398985;783.3145997252404;790.2847922630029;749.9887501687479;763.2177018555969;764.0487592946789;764.8623247815391;765.2003656179306;785;786.7757689058619;787.4173111897184;787.6376866641352;788.1645455816824;478.5501628469228;785.6896525872277;819.7049062337584;845.1295165979052;845.2392846438194;586.920765696634;597.5936363272973;598.0371601721225;599.2000679093416;599.5743022454063;12147.878521214763;12166.878331216663;12187.695307617292;12187.756244875141;12190.268583884996;12746.171498852545;13253.403596838165;13281.003924705588;13494.797578036338;13586.25275609841;10057.145142662883;10124.69625911224;10416;10451.79096418075;10458.111060559862;3292.193412613901;3368.208471009311;3388.5086662434055;3460.1522626956307;3464.6015708193377;45626;45889;46020;47220;47323.526764732254;9775.755606109904;9785.26610504215;9827.164691001202;10347.844782328271;10375.533101010473;18324.725129123075;18410.17154228063;18538.814611853977;18612;18672.34646787383;6893.827654308582;6956.200036995709;7081.610511421921;7141.607211603412;7184.712611495586;3806.7906265155684;3827.2919509890203;3867.903302417406;3877.006673210995;3936.8228429720157;2815.0710265612297;2904.085213157891;2915.2566095645475;2929.6923822998706;2931.4430258250864;487.91461494238365;552.1772558887229;587.9470847623735;589.6727316339473;605.0832988023149;528.3738769558086;607.3804719186494;609.8749756299948;610.1975901689265;610.9755609775559;7403.897470684125;7861.292483676497;7865.331446826969;7876.842463150705;8065.637046332812;606.2452246952572;618.0543768034913;623.8159742875863;624.8812725582125;631.7946667333135;3879.6287054595928;3885.494885664902;4075.89810254746;4150.169966006811;4194;54966.725166374716;55450;55774;55988.16017759737;56020;49005;49465;50214.24678629824;50893;51601.74199129055;46313.53686463092;46375;46694.066118678114;47074.764626175966;47498;7457.179710231979;7468.738594149178;7508.699652013858;7575.090989081125;7727.768166955;31353.52969705502;31501;31738.20654483564;32246.677533224367;33184.834075829465;38706.225875482894;39676.80161599174;41473.1705365897;41744.37383439312;41847.58152418437;10132.645357412455;10262.076413122557;10312.071913527818;10332.896671033493;10441.791164176826;10508.684739457829;10556.261061725605;10637.308574942605;10925.508352124014;11193.552257909592;9300.488473134043;10140.847887281549;10461.110805581611;10472.68581942543;10557.15542756593;9642.974975254994;10229.34889208614;10505.264631475724;10725.946370268099;11025.669229923114;10381.84427233577;10486.213533984828;10533.578656853946;10539.682539682539;10697.946510267398;8303.667853286042;8400.957995210229;8406.621702023545;8648.394612377326;9246;8668.393212475066;8900.243479304332;8958.10418958099;9020.323475739215;9053.275737940818 07:46:11 INFO - PROCESS | 18336 | __end_tp_report 07:46:11 INFO - PROCESS | 18336 | __start_cc_report 07:46:11 INFO - PROCESS | 18336 | _x_x_mozilla_cycle_collect,928 07:46:11 INFO - PROCESS | 18336 | __end_cc_report 07:46:11 INFO - PROCESS | 18336 | __startTimestamp1464101171666__endTimestamp 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | ------- Summary: start ------- 07:46:11 INFO - PROCESS | 18336 | Number of tests: 6 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#0] dojo.html Cycles:165 Average:4740.86 Median:4896.24 stddev:498.67 (10.2%) stddev-sans-first:473.39 07:46:11 INFO - PROCESS | 18336 | Values: 2684.4 2694.7 2729.1 2729.7 2749.8 4579.5 4643.5 4723.0 4802.8 4812.2 4713.4 4720.3 4735.1 4778.4 4778.8 4317.3 4318.1 4387.8 4421.0 4553.1 4483.3 4510.3 4516.3 4541.2 4570.7 4237.9 4298.2 4300.8 4387.7 4450.2 4340.7 4341.3 4346.1 4401.6 4480.7 4362.4 4369.5 4395.5 4405.3 4411.1 4456.0 4655.7 4731.8 4769.9 4781.9 5082.1 5109.1 5153.7 5154.8 5162.8 5135.7 5185.8 5202.6 5206.0 5210.3 4650.3 4790.2 4831.1 4837.1 4840.8 5324.1 5327.9 5351.2 5361.1 5377.6 5094.4 5125.7 5135.9 5142.5 5143.4 4913.8 5018.8 5051.3 5063.8 5219.1 4993.8 5000.9 5013.4 5015.8 5065.4 5015.8 5018.2 5018.3 5021.1 5025.7 4258.5 4293.6 4295.0 4336.3 4339.8 3788.9 3810.2 3815.2 3824.6 3829.5 4420.6 4427.6 4435.8 4437.3 4439.0 5140.3 5166.0 5170.4 5174.5 5207.8 4456.2 4458.4 4464.4 4468.2 4512.6 4476.1 4653.3 4679.0 4692.3 4715.2 4892.4 4896.2 4903.6 4904.3 4940.5 5168.3 5207.7 5215.6 5217.3 5228.8 4674.3 4849.0 4855.2 4891.8 4899.8 5101.7 5121.2 5123.2 5124.0 5176.4 5177.8 5184.1 5188.4 5191.2 5193.9 4782.4 4935.4 4942.7 4979.0 4990.1 4967.0 4995.8 4996.7 5002.4 5055.5 4755.0 4914.6 4930.4 4934.3 4979.0 4965.2 5009.9 5021.8 5026.1 5034.1 4916.3 4929.9 4930.6 4936.4 4988.4 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#1] ext.html Cycles:180 Average:50994.65 Median:215109.21 stddev:90975.59 (42.3%) stddev-sans-first:91152.10 07:46:11 INFO - PROCESS | 18336 | Values: 596.4 613.0 613.4 627.6 633.2 28068.7 41480.0 42466.8 42723.6 46774.5 44523.3 45004.0 45065.8 45074.5 45108.8 7760.1 7940.8 7943.0 7944.6 7952.5 7729.6 7867.3 7887.5 7889.5 7896.0 7878.3 7883.5 7921.1 7931.3 7953.4 7846.2 7922.1 7925.3 7926.4 7926.4 7840.1 7843.8 7909.3 7930.4 7935.9 40164.6 40693.4 41099.6 41145.0 41155.2 3145.4 3230.5 3231.4 3302.9 3424.5 30572.5 30603.1 30726.2 31155.0 31746.8 3546.1 3553.0 3557.8 3596.7 3620.6 273184.0 273359.0 273773.0 274594.0 275657.0 58497.4 58506.0 58966.6 59056.0 59182.4 49499.8 58116.7 59060.4 62064.0 62207.0 15439.8 15650.8 15655.1 15666.2 15684.6 11547.9 11673.5 11686.9 11691.1 11697.5 15944.1 17830.7 18505.8 18521.3 18810.4 6451.9 6453.4 6503.9 6535.5 6642.6 866.7 938.2 963.8 1007.2 1062.2 27898.4 28844.3 29422.3 29494.4 29800.6 978.5 981.2 993.9 999.0 1002.7 14998.8 15425.8 15511.6 15713.8 15724.1 387831.0 390465.0 391100.0 392085.0 394279.0 50885.5 51078.7 51187.5 51226.5 51385.0 1095.7 1207.2 1251.8 1290.0 1412.4 28579.7 30890.0 30911.8 30982.7 31463.0 45302.0 46068.5 46174.1 46242.5 46268.8 354820.0 362178.0 362700.0 364203.0 364602.0 33715.3 39526.6 39936.4 40173.0 43466.6 44651.6 44773.3 45421.3 45503.8 45960.5 37781.0 38096.0 38128.0 39118.4 39655.2 37627.8 37763.0 38086.0 38286.0 38299.6 37770.6 37854.4 37903.2 38269.0 38321.4 33648.0 34980.0 35622.5 35801.3 36065.1 25882.4 26007.5 26015.5 26234.2 26554.3 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#2] jquery.html Cycles:180 Average:23714.80 Median:5295.95 stddev:64871.21 (1224.9%) stddev-sans-first:65029.50 07:46:11 INFO - PROCESS | 18336 | Values: 367.5 368.0 369.5 381.6 386.1 16056.0 17589.8 17703.2 17894.5 18049.1 15971.3 16676.0 16728.6 16740.7 17403.1 4503.0 4632.9 4635.6 4806.7 4822.5 3506.1 3671.4 5231.1 5543.0 5556.1 5575.2 5577.7 5578.2 5591.2 5606.8 5229.2 5538.4 5540.3 5561.4 5571.7 3384.9 5076.7 5360.8 5365.8 5400.3 11692.9 12016.3 12029.7 12039.6 12308.6 1780.8 1846.2 1870.9 1889.3 1977.7 8938.6 9153.6 9638.7 9807.1 9958.4 1691.8 1748.1 1764.2 1784.9 1791.9 65464.7 65852.3 67944.0 69643.7 69947.7 10290.2 10337.9 10416.6 10431.1 10478.7 14411.4 14433.7 14440.6 14452.5 14463.1 7123.0 7245.9 7249.6 7360.0 7416.7 6504.6 6535.2 6646.1 6678.5 6681.8 4186.7 4197.9 4467.1 4468.4 4541.8 1731.5 1748.6 1777.5 1840.1 1870.1 798.0 839.3 892.3 895.1 910.2 16307.3 16616.0 16819.7 16881.9 17150.0 834.0 850.7 862.8 872.7 905.2 9075.4 9636.9 9669.0 9671.8 9809.0 378693.0 395352.0 397011.0 397309.0 399895.0 69944.0 70029.3 71434.6 72127.6 72871.6 926.7 928.7 929.2 930.9 941.6 14737.3 15057.7 15097.0 15234.0 15484.3 35121.8 35257.6 35493.8 35726.1 36405.8 45465.0 47841.8 49374.5 50115.2 50185.7 7399.7 7405.7 7512.9 7518.3 7633.0 7804.5 10554.5 10718.0 10831.5 11009.8 8653.2 9469.7 9832.0 9846.1 9973.3 9251.7 9490.0 9499.4 9576.0 9617.8 9696.3 9902.2 9929.6 9965.7 9970.6 6605.9 6689.9 6907.8 7048.5 7379.1 7543.5 8927.0 9727.5 9939.8 10054.9 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#3] mootools.html Cycles:180 Average:5325.67 Median:5019.41 stddev:3043.80 (60.6%) stddev-sans-first:3036.78 07:46:11 INFO - PROCESS | 18336 | Values: 1229.5 1376.4 1413.5 1526.6 1756.4 6967.4 7810.2 7958.0 7960.7 8267.9 7991.8 8194.6 8196.4 8197.5 8199.1 2191.5 2221.5 2222.5 2224.1 2224.6 2126.1 2144.3 2147.3 2147.4 2166.5 2116.8 2132.0 2169.3 2185.7 2188.4 2133.4 2139.9 2140.8 2143.2 2144.8 2074.7 2099.9 2102.5 2103.2 2104.4 7987.8 8050.2 8112.5 8119.8 8124.1 4641.7 4801.6 4807.4 4808.9 4812.2 2916.6 2938.9 2983.0 3010.9 3017.3 917.6 926.2 927.6 929.8 951.1 11197.2 11295.1 11314.0 11319.8 11323.4 4022.2 4127.4 4183.3 4200.1 4208.4 8843.2 8905.4 8932.3 8933.6 8933.8 4670.6 4679.5 4680.5 4686.1 4686.3 3766.2 4106.1 4232.1 4248.9 4344.7 3431.2 3483.0 3512.0 3553.2 3578.6 999.1 1023.1 1027.5 1043.0 1058.8 843.2 859.1 871.1 876.8 880.4 5143.6 5582.0 5694.9 5791.7 5798.6 933.7 935.4 994.5 1001.7 1011.7 3805.2 3863.1 3915.1 3962.7 4019.1 9835.5 10048.2 10148.5 10234.6 10236.0 9980.1 9988.9 10069.7 10074.7 10104.4 7562.8 7600.2 7796.3 7832.3 7882.9 5622.4 5711.4 5789.8 5810.5 5871.9 9279.6 9504.6 9626.8 9640.6 9659.8 9406.7 9669.7 9677.7 9889.6 9926.9 5908.9 6314.7 6470.2 6565.3 6667.6 7992.8 8000.5 8077.6 8077.8 8087.9 7106.0 7246.5 7293.9 7382.2 7440.2 6744.7 6981.8 7152.6 7161.1 7265.6 6055.4 6247.4 6249.6 6262.2 6327.1 4739.1 4793.8 4803.3 4838.4 4906.3 4925.5 4981.2 4989.2 5049.6 5071.3 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#4] prototype.html Cycles:180 Average:4129.64 Median:4724.41 stddev:1194.44 (25.3%) stddev-sans-first:1162.67 07:46:11 INFO - PROCESS | 18336 | Values: 298.8 299.1 303.6 308.0 310.8 4707.5 4715.8 4737.2 4743.2 4798.0 4672.3 4696.3 4723.7 4725.1 4726.7 3540.1 3640.3 3661.9 3739.4 3783.7 3715.9 3735.7 3741.8 3754.1 3758.3 3548.6 3722.7 3726.8 3733.2 3764.4 3604.7 3741.9 3746.2 3751.6 3766.5 3328.4 3333.3 3345.2 3346.6 3352.0 4498.8 4544.4 4554.2 4559.4 4569.6 4005.3 4202.4 4234.6 4237.8 4253.8 4922.6 4949.7 4957.8 4959.7 4976.5 3421.8 3525.5 3543.6 3557.4 3559.2 5139.7 5179.7 5195.9 5197.8 5206.3 3591.6 3623.1 3623.1 3633.9 3639.2 3665.9 3666.7 3691.2 3691.6 3694.8 4086.9 4115.0 4175.4 4176.7 4226.3 4923.9 4948.5 4951.0 4951.3 4965.7 1265.5 1276.0 1276.7 1277.9 1278.2 808.2 817.7 847.8 870.5 874.2 4378.6 4407.6 4410.7 4421.6 4426.4 5000.7 5033.7 5038.7 5077.8 5081.7 4264.9 4393.3 4398.6 4401.4 4402.3 2648.3 2675.5 2677.3 2679.3 2698.6 4781.0 4796.7 4819.2 4822.8 4844.8 4923.7 5157.3 5170.6 5171.6 5216.4 4837.2 4849.8 4852.7 4858.2 4884.7 5086.5 5143.9 5147.9 5166.3 5172.5 4805.7 5019.2 5030.3 5042.0 5052.4 4837.5 4861.5 4881.2 4898.6 4904.5 3657.5 3680.5 3689.5 3695.2 3709.9 4974.0 5163.8 5170.1 5215.6 5252.2 4977.9 4988.7 4988.7 4993.7 5001.3 4939.9 4947.4 4980.2 4996.0 5027.6 4654.5 4917.8 4942.8 4943.5 4956.6 4779.7 4860.4 4949.4 4982.6 5010.7 4885.6 4887.5 4894.6 4908.7 4919.9 07:46:11 INFO - PROCESS | 18336 | 07:46:11 INFO - PROCESS | 18336 | [#5] yui.html Cycles:180 Average:13137.53 Median:46884.42 stddev:15434.52 (32.9%) stddev-sans-first:15449.50 07:46:11 INFO - PROCESS | 18336 | Values: 686.3 692.8 704.5 733.5 767.1 12074.5 12323.0 12447.0 12478.1 12478.7 12038.8 12061.6 12067.7 12070.4 12077.1 611.4 754.7 769.7 783.3 790.3 750.0 763.2 764.0 764.9 765.2 785.0 786.8 787.4 787.6 788.2 478.6 785.7 819.7 845.1 845.2 586.9 597.6 598.0 599.2 599.6 12147.9 12166.9 12187.7 12187.8 12190.3 12746.2 13253.4 13281.0 13494.8 13586.3 10057.1 10124.7 10416.0 10451.8 10458.1 3292.2 3368.2 3388.5 3460.2 3464.6 45626.0 45889.0 46020.0 47220.0 47323.5 9775.8 9785.3 9827.2 10347.8 10375.5 18324.7 18410.2 18538.8 18612.0 18672.3 6893.8 6956.2 7081.6 7141.6 7184.7 3806.8 3827.3 3867.9 3877.0 3936.8 2815.1 2904.1 2915.3 2929.7 2931.4 487.9 552.2 587.9 589.7 605.1 528.4 607.4 609.9 610.2 611.0 7403.9 7861.3 7865.3 7876.8 8065.6 606.2 618.1 623.8 624.9 631.8 3879.6 3885.5 4075.9 4150.2 4194.0 54966.7 55450.0 55774.0 55988.2 56020.0 49005.0 49465.0 50214.2 50893.0 51601.7 46313.5 46375.0 46694.1 47074.8 47498.0 7457.2 7468.7 7508.7 7575.1 7727.8 31353.5 31501.0 31738.2 32246.7 33184.8 38706.2 39676.8 41473.2 41744.4 41847.6 10132.6 10262.1 10312.1 10332.9 10441.8 10508.7 10556.3 10637.3 10925.5 11193.6 9300.5 10140.8 10461.1 10472.7 10557.2 9643.0 10229.3 10505.3 10725.9 11025.7 10381.8 10486.2 10533.6 10539.7 10697.9 8303.7 8401.0 8406.6 8648.4 9246.0 8668.4 8900.2 8958.1 9020.3 9053.3 07:46:11 INFO - PROCESS | 18336 | -------- Summary: end -------- 07:46:11 INFO - PROCESS | 18336 | 07:46:12 INFO - TEST-INFO | 18336: exit 0 07:46:12 INFO - TEST-OK | dromaeo_css | took 1118838ms 07:46:12 INFO - TEST-START | kraken 07:46:12 INFO - operating with platform_type : linux_ 07:46:12 INFO - Initialising browser for kraken test... 07:46:12 INFO - TEST-INFO | started process 18516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWMURbO/profile http://localhost:48049/getInfo.html) 07:46:17 INFO - PROCESS | 18516 | __metrics Screen width/height:1600/1200 07:46:17 INFO - PROCESS | 18516 | colorDepth:24 07:46:17 INFO - PROCESS | 18516 | Browser inner width/height: 1024/697 07:46:17 INFO - PROCESS | 18516 | __metrics 07:46:18 ERROR - PROCESS | 18516 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:46:19 INFO - TEST-INFO | 18516: exit 0 07:46:19 INFO - Browser initialized. 07:46:19 INFO - Running cycle 1/1 for kraken test... 07:46:19 INFO - TEST-INFO | started process 18599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWMURbO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:31 INFO - PROCESS | 18599 | RSS: Main: 154869760 07:46:31 INFO - PROCESS | 18599 | 07:46:33 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48049/tests/kraken/driver.html?testName=audio-beat-detection) 07:46:34 INFO - PROCESS | 18599 | RSS: Main: 210767872 07:46:34 INFO - PROCESS | 18599 | 07:46:37 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48049/tests/kraken/driver.html?testName=audio-dft) 07:46:38 INFO - PROCESS | 18599 | RSS: Main: 198725632 07:46:38 INFO - PROCESS | 18599 | 07:46:41 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48049/tests/kraken/driver.html?testName=audio-fft) 07:46:42 INFO - PROCESS | 18599 | RSS: Main: 267055104 07:46:42 INFO - PROCESS | 18599 | 07:46:44 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48049/tests/kraken/driver.html?testName=audio-oscillator) 07:46:44 INFO - PROCESS | 18599 | RSS: Main: 176074752 07:46:44 INFO - PROCESS | 18599 | 07:46:47 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:46:47 INFO - PROCESS | 18599 | RSS: Main: 180293632 07:46:47 INFO - PROCESS | 18599 | 07:46:50 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48049/tests/kraken/driver.html?testName=imaging-darkroom) 07:46:51 INFO - PROCESS | 18599 | RSS: Main: 216276992 07:46:51 INFO - PROCESS | 18599 | 07:46:54 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48049/tests/kraken/driver.html?testName=imaging-desaturate) 07:46:55 INFO - PROCESS | 18599 | RSS: Main: 216322048 07:46:55 INFO - PROCESS | 18599 | 07:46:58 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48049/tests/kraken/driver.html?testName=json-parse-financial) 07:46:59 INFO - PROCESS | 18599 | RSS: Main: 217214976 07:46:59 INFO - PROCESS | 18599 | 07:47:00 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:01 INFO - PROCESS | 18599 | RSS: Main: 206352384 07:47:01 INFO - PROCESS | 18599 | 07:47:03 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:03 INFO - PROCESS | 18599 | RSS: Main: 207929344 07:47:03 INFO - PROCESS | 18599 | 07:47:06 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:06 INFO - PROCESS | 18599 | RSS: Main: 218923008 07:47:06 INFO - PROCESS | 18599 | 07:47:09 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:10 INFO - PROCESS | 18599 | RSS: Main: 225259520 07:47:10 INFO - PROCESS | 18599 | 07:47:13 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:13 INFO - PROCESS | 18599 | RSS: Main: 221327360 07:47:13 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | Cycle 1(1): loaded http://localhost:48049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48049/tests/kraken/driver.html?testName=ai-astar) 07:47:15 INFO - PROCESS | 18599 | RSS: Main: 266842112 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | __start_tp_report 07:47:15 INFO - PROCESS | 18599 | _x_x_mozilla_page_load 07:47:15 INFO - PROCESS | 18599 | _x_x_mozilla_page_load_details 07:47:15 INFO - PROCESS | 18599 | |i|pagename|runs| 07:47:15 INFO - PROCESS | 18599 | |0;ai-astar;112;109;112;114;112;113;113;112;112;112 07:47:15 INFO - PROCESS | 18599 | |1;audio-beat-detection;167;128;131;198;138;140;157;137;169;136 07:47:15 INFO - PROCESS | 18599 | |2;audio-dft;161;160;161;161;163;160;161;160;161;159 07:47:15 INFO - PROCESS | 18599 | |3;audio-fft;75;77;76;106;75;78;76;76;103;75 07:47:15 INFO - PROCESS | 18599 | |4;audio-oscillator;84;83;114;83;84;84;120;83;84;126 07:47:15 INFO - PROCESS | 18599 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 07:47:15 INFO - PROCESS | 18599 | |6;imaging-darkroom;146;147;147;146;146;147;146;146;146;146 07:47:15 INFO - PROCESS | 18599 | |7;imaging-desaturate;94;94;95;96;94;94;95;95;94;95 07:47:15 INFO - PROCESS | 18599 | |8;json-parse-financial;70;64;64;63;64;65;64;78;63;62 07:47:15 INFO - PROCESS | 18599 | |9;json-stringify-tinderbox;66;65;65;65;64;64;66;65;65;66 07:47:15 INFO - PROCESS | 18599 | |10;stanford-crypto-aes;83;81;88;82;83;84;84;83;83;83 07:47:15 INFO - PROCESS | 18599 | |11;stanford-crypto-ccm;150;132;139;148;130;132;138;129;162;141 07:47:15 INFO - PROCESS | 18599 | |12;stanford-crypto-pbkdf2;168;171;167;171;168;166;172;176;167;168 07:47:15 INFO - PROCESS | 18599 | |13;stanford-crypto-sha256-iterative;67;67;67;67;65;68;66;66;66;66 07:47:15 INFO - PROCESS | 18599 | __end_tp_report 07:47:15 INFO - PROCESS | 18599 | __start_cc_report 07:47:15 INFO - PROCESS | 18599 | _x_x_mozilla_cycle_collect,1898 07:47:15 INFO - PROCESS | 18599 | __end_cc_report 07:47:15 INFO - PROCESS | 18599 | __startTimestamp1464101235698__endTimestamp 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | ------- Summary: start ------- 07:47:15 INFO - PROCESS | 18599 | Number of tests: 14 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 07:47:15 INFO - PROCESS | 18599 | Values: 112.0 109.0 112.0 114.0 112.0 113.0 113.0 112.0 112.0 112.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:148.50 stddev:22.25 (15.0%) stddev-sans-first:22.75 07:47:15 INFO - PROCESS | 18599 | Values: 167.0 128.0 131.0 198.0 138.0 140.0 157.0 137.0 169.0 136.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 07:47:15 INFO - PROCESS | 18599 | Values: 161.0 160.0 161.0 161.0 163.0 160.0 161.0 160.0 161.0 159.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.07 (15.9%) stddev-sans-first:12.56 07:47:15 INFO - PROCESS | 18599 | Values: 75.0 77.0 76.0 106.0 75.0 78.0 76.0 76.0 103.0 75.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.50 stddev:17.83 (21.4%) stddev-sans-first:18.50 07:47:15 INFO - PROCESS | 18599 | Values: 84.0 83.0 114.0 83.0 84.0 84.0 120.0 83.0 84.0 126.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:47:15 INFO - PROCESS | 18599 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:47:15 INFO - PROCESS | 18599 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:47:15 INFO - PROCESS | 18599 | Values: 94.0 94.0 95.0 96.0 94.0 94.0 95.0 95.0 94.0 95.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:64.00 stddev:4.83 (7.5%) stddev-sans-first:4.87 07:47:15 INFO - PROCESS | 18599 | Values: 70.0 64.0 64.0 63.0 64.0 65.0 64.0 78.0 63.0 62.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 07:47:15 INFO - PROCESS | 18599 | Values: 66.0 65.0 65.0 65.0 64.0 64.0 66.0 65.0 65.0 66.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.84 (2.2%) stddev-sans-first:1.94 07:47:15 INFO - PROCESS | 18599 | Values: 83.0 81.0 88.0 82.0 83.0 84.0 84.0 83.0 83.0 83.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:140.00 stddev:10.56 (7.5%) stddev-sans-first:10.57 07:47:15 INFO - PROCESS | 18599 | Values: 150.0 132.0 139.0 148.0 130.0 132.0 138.0 129.0 162.0 141.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:3.06 (1.8%) stddev-sans-first:3.21 07:47:15 INFO - PROCESS | 18599 | Values: 168.0 171.0 167.0 171.0 168.0 166.0 172.0 176.0 167.0 168.0 07:47:15 INFO - PROCESS | 18599 | 07:47:15 INFO - PROCESS | 18599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 07:47:15 INFO - PROCESS | 18599 | Values: 67.0 67.0 67.0 67.0 65.0 68.0 66.0 66.0 66.0 66.0 07:47:15 INFO - PROCESS | 18599 | -------- Summary: end -------- 07:47:15 INFO - PROCESS | 18599 | 07:47:16 INFO - TEST-INFO | 18599: exit 0 07:47:16 INFO - TEST-OK | kraken | took 64282ms 07:47:16 INFO - SUITE-END | took 1183s 07:47:16 INFO - Completed test suite (00:19:43) 07:47:16 INFO - javascript benchmark 07:47:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2684.382592003839, 2694.676638803344, 2729.1266794625703, 2729.686086100098, 2749.766269867061, 4579.450465944092, 4643.466001409839, 4723.0, 4802.807887684493, 4812.181929072058, 4713.410823647044, 4720.268358404444, 4735.076660051292, 4778.3549220855175, 4778.784954677039, 4317.33081372387, 4318.07161460286, 4387.824487020515, 4420.97789511052, 4553.066621342633, 4483.260262056757, 4510.278355463127, 4516.345129956155, 4541.205289074399, 4570.725756454607, 4237.894052648678, 4298.204832106039, 4300.763458009808, 4387.692861499696, 4450.243458612027, 4340.7178533395545, 4341.261985462479, 4346.0655958968655, 4401.5818497243035, 4480.686351955332, 4362.411074504933, 4369.519352871182, 4395.4725432947935, 4405.295152775572, 4411.117776444692, 4456.019675671347, 4655.650826188049, 4731.810727570893, 4769.880752981168, 4781.904361912742, 5082.110630639623, 5109.080365534202, 5153.6907785532985, 5154.793808247666, 5162.845114646529, 5135.6918584885025, 5185.844424667228, 5202.557782588485, 5206.0368831766245, 5210.296609957645, 4650.302454631832, 4790.161721698689, 4831.130396528623, 4837.080954618611, 4840.782164802592, 5324.148136298251, 5327.920081198785, 5351.224072509464, 5361.142217245222, 5377.596680248997, 5094.363204599425, 5125.718085505258, 5135.948640513547, 5142.51146141116, 5143.434222235551, 4913.828016019494, 5018.799248030111, 5051.318072060299, 5063.772130254148, 5219.1388420910125, 4993.800247990112, 5000.874978125576, 5013.373328333958, 5015.82444614444, 5065.39215294167, 5015.773496557587, 5018.222175562793, 5018.2974383586325, 5021.121303771898, 5025.698458092526, 4258.53156152823, 4293.592108749664, 4295.033617436052, 4336.3278691802825, 4339.7830108494445, 3788.886333410002, 3810.237952409529, 3815.1988082502985, 3824.6366595173413, 3829.5021647185686, 4420.58004489573, 4427.579379958899, 4435.756033418193, 4437.33439984005, 4439.0234148487925, 5140.254663073833, 5166.0, 5170.431252562215, 5174.482551744795, 5207.817726379634, 4456.242438785414, 4458.420405347284, 4464.419625448736, 4468.173387923244, 4512.638988880882, 4476.082403107355, 4653.325267836145, 4679.040796636681, 4692.319613656001, 4715.221988371949, 4892.357240183327, 4896.2410826321975, 4903.583195428429, 4904.2643603459765, 4940.456549779521, 5168.276441298296, 5207.661502002357, 5215.608829337739, 5217.321748172713, 5228.816991405435, 4674.298855171752, 4848.951510484992, 4855.1988921828915, 4891.755412229445, 4899.804007839646, 5101.744912754421, 5121.231815227746, 5123.205903085028, 5123.974380128225, 5176.4047134578495, 5177.7670004849115, 5184.066867963803, 5188.377394712658, 5191.195364718475, 5193.896122077462, 4782.402199725035, 4935.407751069894, 4942.654014219114, 4978.975105124451, 4990.051890140861, 4966.950330496793, 4995.750212489288, 4996.650234483696, 5002.424721156968, 5055.469175736494, 4754.976225118852, 4914.5822605078965, 4930.433000205022, 4934.259861020875, 4978.975105124596, 4965.230389289666, 5009.924851127309, 5021.84934451967, 5026.120428924851, 5034.144195486703, 4916.311716359641, 4929.926051109164, 4930.630202734881, 4936.407631084293, 4988.4263309719845], "value": 4709.435600971428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.439347013807, 612.9693515324234, 613.408061220922, 627.5952010952939, 633.2211380002594, 28068.719312806865, 41480.0, 42466.787666061624, 42723.57276427235, 46774.53225467753, 44523.3321500177, 45004.0, 45065.7746711266, 45074.549254507445, 45108.77445612767, 7760.146383897767, 7940.841183176333, 7942.960285198595, 7944.563049032301, 7952.483088599222, 7729.574873381962, 7867.252611001974, 7887.526748395086, 7889.526628402315, 7896.0, 7878.330341920943, 7883.526988380716, 7921.089074756419, 7931.325837303836, 7953.403494737918, 7846.176151504095, 7922.088959769642, 7925.286724194792, 7926.365890728728, 7926.405519586026, 7840.0591928968315, 7843.803904902366, 7909.288164065204, 7930.405219608552, 7935.920640793576, 40164.59835401638, 40693.389599156035, 41099.589004109876, 41144.97137571555, 41155.176896461904, 3145.370925814846, 3230.48312270038, 3231.4021905947475, 3302.9009129725905, 3424.520567120605, 30572.54141187884, 30603.081907542808, 30726.231844204074, 31155.0, 31746.841265793755, 3546.148924258185, 3553.008023726668, 3557.804320762357, 3596.6942809861193, 3620.6198349173483, 273184.0, 273359.0, 273772.999999998, 274594.0, 275657.0, 58497.415025850045, 58506.0, 58966.57750668717, 59056.0, 59182.40817591769, 49499.752501237985, 58116.70941645265, 59060.409395906354, 62064.0, 62207.0, 15439.768403473958, 15650.843491565167, 15655.138967356677, 15666.216689165496, 15684.607884802743, 11547.942260288644, 11673.533058677558, 11686.94156529212, 11691.064714822794, 11697.532098716127, 15944.123073231083, 17830.732539011926, 18505.81494185041, 18521.259149634134, 18810.43568692914, 6451.903221451682, 6453.386928241809, 6503.902441463382, 6535.477161827042, 6642.634655094016, 866.6966561703354, 938.2072149034192, 963.8313295173317, 1007.1690855044471, 1062.2245760594808, 27898.442031159262, 28844.278893027844, 29422.264443389085, 29494.410111797642, 29800.552991705143, 978.5449765858909, 981.2346369831542, 993.8956409577034, 998.9650362237287, 1002.7192386131894, 14998.775018374734, 15425.84574154244, 15511.612209694622, 15713.764293535605, 15724.135172565619, 387831.0, 390465.0, 391100.0, 392085.0, 394279.0, 50885.49114508882, 51078.744606277476, 51187.488125118274, 51226.487735122915, 51385.0, 1095.7205912492263, 1207.1610230889623, 1251.8122281657825, 1289.9677508062373, 1412.3644360038024, 28579.714202857704, 30890.0, 30911.845440772653, 30982.69017309798, 31463.0, 45302.0, 46068.53931460776, 46174.076518470116, 46242.53757462382, 46268.768656156506, 354820.0, 362178.0, 362700.0, 364203.0, 364602.0, 33715.325693486484, 39526.60473395229, 39936.40095398513, 40173.0, 43466.565334346255, 44651.55348446474, 44773.32840007468, 45421.31868022049, 45503.772481137385, 45960.54039459563, 37781.0, 38096.0, 38128.0, 39118.41322380109, 39655.206895862495, 37627.81186094052, 37763.04238931518, 38086.0, 38286.0, 38299.617003829604, 37770.62229377781, 37854.43218351672, 37903.24193516169, 38269.0, 38321.42517862179, 33648.0, 34980.0, 35622.465663015595, 35801.28397432089, 36065.098372540895, 25882.35294117662, 26007.479850403266, 26015.479690405708, 26234.21297361082, 26554.336141596614], "value": 18606.637288536836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.5442451360313, 367.95584529856416, 369.5140889730003, 381.572638644718, 386.1389102301865, 16056.0, 17589.82410175898, 17703.203355848986, 17894.463166105004, 18049.097545122724, 15971.281292341844, 16676.0, 16728.581785455368, 16740.748888766648, 17403.12984350784, 4502.999999999992, 4632.930506042412, 4635.629149668035, 4806.735629540374, 4822.469528351879, 3506.105942984548, 3671.4125739881624, 5231.084560201968, 5543.0, 5556.083246264361, 5575.191597218401, 5577.749001294951, 5578.219049333076, 5591.217229587861, 5606.775728970836, 5229.2156176573435, 5538.363088244863, 5540.252065971083, 5561.416051314594, 5571.721413929328, 3384.8815291464925, 5076.705440112784, 5360.812371567015, 5365.839024829262, 5400.270963419927, 11692.883071169264, 12016.279023258632, 12029.699257518545, 12039.63881083569, 12308.569200078044, 1780.777402824647, 1846.1784505894882, 1870.8503319734389, 1889.3198448558508, 1977.7033444983224, 8938.597763100675, 9153.582529688354, 9638.662646807328, 9807.06832850878, 9958.352707074017, 1691.805442374118, 1748.0997286397514, 1764.1884733022825, 1784.9379619126598, 1791.9462416127537, 65464.67267663631, 65852.3414765851, 67944.0, 69643.65178174077, 69947.65026174938, 10290.228232882564, 10337.896621033844, 10416.635417760343, 10431.113355364727, 10478.738031549272, 14411.42354305837, 14433.711325773636, 14440.566782996317, 14452.494162704255, 14463.1322120671, 7123.0, 7245.89131163033, 7249.601271930094, 7359.963200183965, 7416.666250018654, 6504.577202481823, 6535.150430444012, 6646.136002319668, 6678.5307232408795, 6681.799546013627, 4186.706930514834, 4197.91604167921, 4467.128909862546, 4468.374427580141, 4541.84103556374, 1731.5411415974777, 1748.5978225008319, 1777.4934143768965, 1840.1081712178914, 1870.1303893689228, 798.0423491809852, 839.3159574946399, 892.3218354050838, 895.1048951048951, 910.2263076385152, 16307.347706091623, 16616.0, 16819.663606727798, 16881.91559042197, 17150.0, 833.9624716887755, 850.6980022092192, 862.7584276402617, 872.6858331000834, 905.1627244798535, 9075.364724469357, 9636.855447168298, 9668.951655241679, 9671.806563868824, 9808.950955245178, 378693.0, 395352.0, 397011.0, 397309.0, 399895.0, 69944.0, 70029.29970700228, 71434.64282678554, 72127.6393618039, 72871.63564182252, 926.6710317837205, 928.7445952363154, 929.2194556572512, 930.8929473110679, 941.5621735892843, 14737.336819842918, 15057.698846023237, 15097.0, 15234.0, 15484.303206355517, 35121.82439087788, 35257.64742352646, 35493.82253088821, 35726.10684732799, 36405.81797090998, 45465.0, 47841.760791197215, 49374.50625493699, 50115.24827127669, 50185.74907125441, 7399.741009064657, 7405.666744996381, 7512.887306690294, 7518.323350898446, 7633.0, 7804.453688241996, 10554.472276386303, 10718.0, 10831.51258193399, 11009.83485247738, 8653.221210091122, 9469.66856160031, 9831.95084024604, 9846.064623860722, 9973.252006099427, 9251.67619133327, 9489.95255023748, 9499.38254013487, 9575.952120239634, 9617.807643846943, 9696.272779541421, 9902.207823373968, 9929.553170107507, 9965.651202207888, 9970.55132519024, 6605.867882642417, 6689.866202676017, 6907.827304317432, 7048.506604537838, 7379.077615298088, 7543.547387156788, 8926.955365223132, 9727.513624318897, 9939.751506212402, 10054.89945100569], "value": 7880.972453910335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.4774720743683, 1376.4081444978656, 1413.455819509489, 1526.6183454136467, 1756.4203812741805, 6967.442604591633, 7810.218978102194, 7958.0, 7960.681572737083, 8267.91732082679, 7991.840163196747, 8194.590270486482, 8196.42625016249, 8197.467164634294, 8199.057108432533, 2191.5288213034196, 2221.533477969628, 2222.5221577360944, 2224.088123869214, 2224.5773303072447, 2126.13891373993, 2144.2602302205714, 2147.3235930681863, 2147.398728356055, 2166.458385403649, 2116.7565729941025, 2132.0299263834995, 2169.2624507667388, 2185.672149177628, 2188.4419473034354, 2133.4133113393864, 2139.9251026214088, 2140.7538133114736, 2143.239150101715, 2144.7533533643673, 2074.7406574178226, 2099.88450635215, 2102.5059111108876, 2103.2323202031303, 2104.389726979174, 7987.840243195162, 8050.235227653422, 8112.472689275178, 8119.75640730779, 8124.106348301682, 4641.744704041276, 4801.591864691471, 4807.42310922688, 4808.927866082012, 4812.230043193073, 2916.6208392908998, 2938.8824447022307, 2982.9701702983125, 3010.909672709822, 3017.2758537950954, 917.5504003038529, 926.1803304075942, 927.5640448988964, 929.8423462788803, 951.0774548687762, 11197.16021298406, 11295.096392288679, 11314.038306743936, 11319.830202546967, 11323.43382830855, 4022.1754540319166, 4127.360259159835, 4183.288840897055, 4200.054987627759, 4208.431861698693, 8843.159899809507, 8905.376623636283, 8932.285417166611, 8933.642654293755, 8933.821323573493, 4670.626349892001, 4679.508651591602, 4680.531946805292, 4686.133065382915, 4686.320483529869, 3766.227923275777, 4106.07613287008, 4232.132412855357, 4248.915021699549, 4344.695871288979, 3431.1936694876686, 3482.9825850870584, 3512.034190597555, 3553.218291975761, 3578.570571531433, 999.1066928171075, 1023.053675350298, 1027.50679673757, 1043.0456132638703, 1058.8464672622426, 843.1526316052328, 859.0679113162164, 871.0940621753306, 876.7501262140387, 880.4321212817824, 5143.562797162208, 5582.0, 5694.914576281359, 5791.739371728282, 5798.623089499169, 933.73855320509, 935.3911272611098, 994.4878387630376, 1001.7395477175987, 1011.7217765114652, 3805.2199299144163, 3863.092173339263, 3915.138669492707, 3962.6829853611644, 4019.0756126090578, 9835.508224588742, 10048.246381521416, 10148.543315550818, 10234.59061637541, 10236.027577380137, 9980.101790838715, 9988.900110998797, 10069.69790906274, 10074.74813129663, 10104.393736375841, 7562.848743025109, 7600.1639819619795, 7796.298333150044, 7832.255935686101, 7882.881756773539, 5622.353429355677, 5711.361106694281, 5789.797357092481, 5810.477057064715, 5871.911921321098, 9279.582418791035, 9504.572294246636, 9626.759331016781, 9640.614375425184, 9659.806803864023, 9406.717798466058, 9669.70990870275, 9677.661281855102, 9889.554970026222, 9926.900730992598, 5908.940910590839, 6314.6842657866, 6470.158879345655, 6565.343465653396, 6667.599944003376, 7992.760217193493, 8000.479968802009, 8077.636506357346, 8077.7576672699915, 8087.8786818196595, 7105.964470177616, 7246.492745507975, 7293.890591641236, 7382.224866388952, 7440.181580026301, 6744.69648865812, 6981.825454363681, 7152.640998210323, 7161.104861892263, 7265.636718164176, 6055.394460553909, 6247.375262473716, 6249.593776404519, 6262.15460912771, 6327.145835312174, 4739.123262196505, 4793.832215872567, 4803.255495398219, 4838.395200599925, 4906.313116163811, 4925.507449255046, 4981.227909674007, 4989.176785830297, 5049.6465247432325, 5071.290019397214], "value": 4248.346046522903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7654691067512, 299.08927316321797, 303.64928507573745, 308.03584779639726, 310.77468835094544, 4707.482176960531, 4715.764211789409, 4737.170995075857, 4743.217369134093, 4798.032806549316, 4672.299155126732, 4696.319033740106, 4723.669343145981, 4725.149473094842, 4726.7400292983875, 3540.0972751948216, 3640.290143422034, 3661.8535258589623, 3739.420389839566, 3783.716221283401, 3715.940956827305, 3735.682466990309, 3741.812909354535, 3754.1177823211524, 3758.3422900992355, 3548.6451354864435, 3722.7207959403154, 3726.8322925468283, 3733.1600389912323, 3764.4353346997896, 3604.711623070148, 3741.906452338686, 3746.232022435408, 3751.624837516254, 3766.4915236443276, 3328.4341661917533, 3333.300006998509, 3345.1637090727318, 3346.6486018967903, 3352.0, 4498.820047198108, 4544.386507821435, 4554.2485489894125, 4559.407277053995, 4569.588737013684, 4005.2990726622725, 4202.3696445533415, 4234.640055595278, 4237.7669228192435, 4253.787310634487, 4922.630802689777, 4949.727764972925, 4957.801687932479, 4959.7024178549045, 4976.5023497649945, 3421.760476766627, 3525.453554699026, 3543.6102028776813, 3557.4130268505664, 3559.2169722660974, 5139.743012849342, 5179.663321884065, 5195.895662256792, 5197.8440646780655, 5206.271122042879, 3591.5510561179854, 3623.1123374772824, 3623.1304486923477, 3633.8546458141377, 3639.1811842335264, 3665.90022993101, 3666.7066634669163, 3691.2248427830455, 3691.5602914863225, 3694.8152592370275, 4086.938695919504, 4114.979425102855, 4175.394567787654, 4176.665866730655, 4226.260404429274, 4923.926141107886, 4948.455669876311, 4951.0, 4951.282064100686, 4965.652404331734, 1265.4938024790158, 1276.0238417610535, 1276.6553030681664, 1277.8913792327571, 1278.2075113429732, 808.2321794295443, 817.7178873288825, 847.809242920338, 870.5473153959905, 874.191372979991, 4378.605925466723, 4407.581279778416, 4410.69125161242, 4421.646268298528, 4426.44669416323, 5000.67495612784, 5033.748312584356, 5038.697678139323, 5077.822276220315, 5081.74591270435, 4264.850730224427, 4393.253146965024, 4398.604125628644, 4401.427814384109, 4402.273624851928, 2648.2717252755647, 2675.451532435846, 2677.2771351735314, 2679.3033811209225, 2698.595210718408, 4781.0, 4796.664233503621, 4819.204831202883, 4822.781520500609, 4844.75776211188, 4923.679960802537, 5157.277981082651, 5170.638055336166, 5171.612129090258, 5216.400113986864, 4837.201861692782, 4849.830255941025, 4852.660313778002, 4858.246971719389, 4884.655365424545, 5086.465921078234, 5143.897122057613, 5147.9227811583605, 5166.328377310925, 5172.5344718975475, 4805.711657300573, 5019.247112933089, 5030.320906677552, 5041.974790126173, 5052.393712754493, 4837.540433658797, 4861.538153875376, 4881.170201065756, 4898.559129678346, 4904.5095490452095, 3657.5062366580173, 3680.5215322007966, 3689.538807649044, 3695.2240029594086, 3709.888703338904, 4974.0, 5163.845084647316, 5170.095233334227, 5215.556677682288, 5252.212168174804, 4977.875553111201, 4988.650794444354, 4988.725620090785, 4993.700377977188, 5001.299818025406, 4939.901201976012, 4947.381577302837, 4980.153373926513, 4996.000799840119, 5027.572656324107, 4654.48800631937, 4917.803287868445, 4942.75286235694, 4943.480934501969, 4956.553910148104, 4779.737114458738, 4860.392450943632, 4949.406071271326, 4982.576480999156, 5010.720122344397, 4885.633577481632, 4887.462379138363, 4894.583960363267, 4908.656394052382, 4919.852404427873], "value": 3752.516971572717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.3376841348098, 692.750609780479, 704.471646265301, 733.5122143774389, 767.0641816983281, 12074.517019319228, 12323.0, 12447.0, 12478.064145189102, 12478.688032799184, 12038.81941770874, 12061.638150855488, 12067.698307542316, 12070.396480175978, 12077.094217933647, 611.3916652930341, 754.6754895394978, 769.6651956398985, 783.3145997252404, 790.2847922630029, 749.9887501687479, 763.2177018555969, 764.0487592946789, 764.8623247815391, 765.2003656179306, 785.0, 786.7757689058619, 787.4173111897184, 787.6376866641352, 788.1645455816824, 478.5501628469228, 785.6896525872277, 819.7049062337584, 845.1295165979052, 845.2392846438194, 586.920765696634, 597.5936363272973, 598.0371601721225, 599.2000679093416, 599.5743022454063, 12147.878521214763, 12166.878331216663, 12187.695307617292, 12187.756244875141, 12190.268583884996, 12746.171498852545, 13253.403596838165, 13281.003924705588, 13494.797578036338, 13586.25275609841, 10057.145142662883, 10124.69625911224, 10416.0, 10451.79096418075, 10458.111060559862, 3292.193412613901, 3368.208471009311, 3388.5086662434055, 3460.1522626956307, 3464.6015708193377, 45626.0, 45889.0, 46020.0, 47220.0, 47323.526764732254, 9775.755606109904, 9785.26610504215, 9827.164691001202, 10347.844782328271, 10375.533101010473, 18324.725129123075, 18410.17154228063, 18538.814611853977, 18612.0, 18672.34646787383, 6893.827654308582, 6956.200036995709, 7081.610511421921, 7141.607211603412, 7184.712611495586, 3806.7906265155684, 3827.2919509890203, 3867.903302417406, 3877.006673210995, 3936.8228429720157, 2815.0710265612297, 2904.085213157891, 2915.2566095645475, 2929.6923822998706, 2931.4430258250864, 487.91461494238365, 552.1772558887229, 587.9470847623735, 589.6727316339473, 605.0832988023149, 528.3738769558086, 607.3804719186494, 609.8749756299948, 610.1975901689265, 610.9755609775559, 7403.897470684125, 7861.292483676497, 7865.331446826969, 7876.842463150705, 8065.637046332812, 606.2452246952572, 618.0543768034913, 623.8159742875863, 624.8812725582125, 631.7946667333135, 3879.6287054595928, 3885.494885664902, 4075.89810254746, 4150.169966006811, 4194.0, 54966.725166374716, 55450.0, 55774.0, 55988.16017759737, 56020.0, 49005.0, 49465.0, 50214.24678629824, 50893.0, 51601.74199129055, 46313.53686463092, 46375.0, 46694.066118678114, 47074.764626175966, 47498.0, 7457.179710231979, 7468.738594149178, 7508.699652013858, 7575.090989081125, 7727.768166955, 31353.52969705502, 31501.0, 31738.20654483564, 32246.677533224367, 33184.834075829465, 38706.225875482894, 39676.80161599174, 41473.1705365897, 41744.37383439312, 41847.58152418437, 10132.645357412455, 10262.076413122557, 10312.071913527818, 10332.896671033493, 10441.791164176826, 10508.684739457829, 10556.261061725605, 10637.308574942605, 10925.508352124014, 11193.552257909592, 9300.488473134043, 10140.847887281549, 10461.110805581611, 10472.68581942543, 10557.15542756593, 9642.974975254994, 10229.34889208614, 10505.264631475724, 10725.946370268099, 11025.669229923114, 10381.84427233577, 10486.213533984828, 10533.578656853946, 10539.682539682539, 10697.946510267398, 8303.667853286042, 8400.957995210229, 8406.621702023545, 8648.394612377326, 9246.0, 8668.393212475066, 8900.243479304332, 8958.10418958099, 9020.323475739215, 9053.275737940818], "value": 5927.563588652104, "unit": "score"}], "name": "dromaeo_css", "value": 6345.23568572871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 114.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 128.0, 131.0, 198.0, 138.0, 140.0, 157.0, 137.0, 169.0, 136.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 160.0, 161.0, 160.0, 161.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 106.0, 75.0, 78.0, 76.0, 76.0, 103.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 83.0, 84.0, 84.0, 120.0, 83.0, 84.0, 126.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 78.0, 63.0, 62.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 88.0, 82.0, 83.0, 84.0, 84.0, 83.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 139.0, 148.0, 130.0, 132.0, 138.0, 129.0, 162.0, 141.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 167.0, 171.0, 168.0, 166.0, 172.0, 176.0, 167.0, 168.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 65.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 07:47:16 INFO - Return code: 0 07:47:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:47:16 ERROR - # TBPL SUCCESS # 07:47:16 INFO - Running post-action listener: _resource_record_post_action 07:47:16 INFO - ##### 07:47:16 INFO - ##### Finished run-tests step (success) 07:47:16 INFO - ##### 07:47:16 INFO - Running post-run listener: _resource_record_post_run 07:47:17 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524140544; Read time: 16; Write time: 673008 07:47:17 INFO - TinderboxPrint: CPU usage
13.1% 07:47:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:47:17 INFO - TinderboxPrint: I/O write bytes / time
524,140,544 / 673,008 07:47:17 INFO - TinderboxPrint: CPU idle
8,323.8 (86.9%) 07:47:17 INFO - TinderboxPrint: CPU user
1,209.4 (12.6%) 07:47:17 INFO - TinderboxPrint: Swap in / out
0 / 0 07:47:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236838912; Read time: 0; Write time: 284188 07:47:17 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287301632; Read time: 16; Write time: 388820 07:47:17 INFO - Running post-run listener: _upload_blobber_files 07:47:17 INFO - Blob upload gear active. 07:47:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:17 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 07:47:17 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'] 07:47:17 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 07:47:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:47:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:23 INFO - (blobuploader) - INFO - Done attempting. 07:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:47:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:24 INFO - (blobuploader) - INFO - Done attempting. 07:47:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:47:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:25 INFO - (blobuploader) - INFO - Done attempting. 07:47:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:25 INFO - Return code: 0 07:47:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/379456f18c8a54b7d85fdca059dfd84fb10ca8c112a5356b6fadd8facce106b689f4e354178b9f32adbac9b28357b39e80e15c7c64a39f20d5d582c88b9e7337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27cc30a5e453c2e9e64f6dedd0defdeff3f8bcf6c50ab6672d140e5958ba4a4272148419516536e6ad1cc2998acf42d1ee89e9c0ba9d1a1303b983d6a2512071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/280b97dcda1f591199b2c579717d348db26007e73739f5a178e927731209f96193ffbe32ba331082bb33d3a8ff428a8fa052ec0876f73551fe0173d2268696fd"} 07:47:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:25 INFO - Contents: 07:47:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/379456f18c8a54b7d85fdca059dfd84fb10ca8c112a5356b6fadd8facce106b689f4e354178b9f32adbac9b28357b39e80e15c7c64a39f20d5d582c88b9e7337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27cc30a5e453c2e9e64f6dedd0defdeff3f8bcf6c50ab6672d140e5958ba4a4272148419516536e6ad1cc2998acf42d1ee89e9c0ba9d1a1303b983d6a2512071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/280b97dcda1f591199b2c579717d348db26007e73739f5a178e927731209f96193ffbe32ba331082bb33d3a8ff428a8fa052ec0876f73551fe0173d2268696fd"} 07:47:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:25 INFO - Copying logs to upload dir... 07:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.322391 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-24 07:47:24.769237) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 07:47:24.776859) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 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/379456f18c8a54b7d85fdca059dfd84fb10ca8c112a5356b6fadd8facce106b689f4e354178b9f32adbac9b28357b39e80e15c7c64a39f20d5d582c88b9e7337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27cc30a5e453c2e9e64f6dedd0defdeff3f8bcf6c50ab6672d140e5958ba4a4272148419516536e6ad1cc2998acf42d1ee89e9c0ba9d1a1303b983d6a2512071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/280b97dcda1f591199b2c579717d348db26007e73739f5a178e927731209f96193ffbe32ba331082bb33d3a8ff428a8fa052ec0876f73551fe0173d2268696fd"} build_url:https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/COf1ZKh_SBmY7TnnCTpzAw/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/379456f18c8a54b7d85fdca059dfd84fb10ca8c112a5356b6fadd8facce106b689f4e354178b9f32adbac9b28357b39e80e15c7c64a39f20d5d582c88b9e7337", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27cc30a5e453c2e9e64f6dedd0defdeff3f8bcf6c50ab6672d140e5958ba4a4272148419516536e6ad1cc2998acf42d1ee89e9c0ba9d1a1303b983d6a2512071", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/280b97dcda1f591199b2c579717d348db26007e73739f5a178e927731209f96193ffbe32ba331082bb33d3a8ff428a8fa052ec0876f73551fe0173d2268696fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 07:47:24.803986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:47:24.804313) ========= 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=5bd038846534b2fdfa68eeae000001e2-1464099589.662901-1076379987 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 07:47:24.886201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 07:47:24.889564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 07:47:24.889861) ========= ========= Total master_lag: 0.18 =========