builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1461872492.8 results: success (0) buildid: 20160428112703 builduid: c551b074b4bb47ada0e34bdaac768409 revision: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.802817) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.803334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.803624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.828076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.828356) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 12:41:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.4M=0s 2016-04-28 12:41:32 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105065 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.948087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.948411) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018014 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.997622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:32.997970) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6adc822f5e27a55551faeb6c47a9bd8b0859a23b --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 6adc822f5e27a55551faeb6c47a9bd8b0859a23b --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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 12:41:33,086 truncating revision to first 12 chars 2016-04-28 12:41:33,086 Setting DEBUG logging. 2016-04-28 12:41:33,086 attempt 1/10 2016-04-28 12:41:33,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6adc822f5e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 12:41:33,494 unpacking tar archive at: mozilla-central-6adc822f5e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:33.721115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:33.721457) ========= script_repo_revision: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:33.721865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:33.722157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 12:41:33.730811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-04-28 12:41:33.731097) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:41:33 INFO - MultiFileLogger online at 20160428 12:41:33 in /builds/slave/test 12:41:33 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 12:41:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:33 INFO - {'append_to_log': False, 12:41:33 INFO - 'base_work_dir': '/builds/slave/test', 12:41:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:41:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:33 INFO - 'branch': 'Firefox-Non-PGO', 12:41:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:33 INFO - 'config_files': ('talos/linux_config.py',), 12:41:33 INFO - 'default_actions': ('clobber', 12:41:33 INFO - 'read-buildbot-config', 12:41:33 INFO - 'download-and-extract', 12:41:33 INFO - 'populate-webroot', 12:41:33 INFO - 'create-virtualenv', 12:41:33 INFO - 'install', 12:41:33 INFO - 'run-tests'), 12:41:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:33 INFO - 'download_minidump_stackwalk': True, 12:41:33 INFO - 'download_symbols': 'ondemand', 12:41:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:41:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:41:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:41:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:41:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:33 INFO - 'installer_path': 'installer.exe', 12:41:33 INFO - 'log_level': 'info', 12:41:33 INFO - 'log_name': 'talos', 12:41:33 INFO - 'log_to_console': True, 12:41:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:41:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:41:33 INFO - 'opt_config_files': (), 12:41:33 INFO - 'pip_index': False, 12:41:33 INFO - 'sps_profile': False, 12:41:33 INFO - 'sps_profile_interval': 0, 12:41:33 INFO - 'suite': 'dromaeojs', 12:41:33 INFO - 'system_bits': '32', 12:41:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:33 INFO - 'title': 'talos-linux64-ix-034', 12:41:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:33 INFO - 'use_talos_json': True, 12:41:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:33 INFO - 'work_dir': 'build'} 12:41:33 INFO - ##### 12:41:33 INFO - ##### Running clobber step. 12:41:33 INFO - ##### 12:41:33 INFO - Running pre-action listener: _resource_record_pre_action 12:41:33 INFO - Running main action method: clobber 12:41:33 INFO - rmtree: /builds/slave/test/build 12:41:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:41:34 INFO - Running post-action listener: _resource_record_post_action 12:41:34 INFO - ##### 12:41:34 INFO - ##### Running read-buildbot-config step. 12:41:34 INFO - ##### 12:41:34 INFO - Running pre-action listener: _resource_record_pre_action 12:41:34 INFO - Running main action method: read_buildbot_config 12:41:34 INFO - Using buildbot properties: 12:41:34 INFO - { 12:41:34 INFO - "project": "", 12:41:34 INFO - "product": "firefox", 12:41:34 INFO - "script_repo_revision": "production", 12:41:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:41:34 INFO - "repository": "", 12:41:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:41:34 INFO - "buildid": "20160428112703", 12:41:34 INFO - "pgo_build": "False", 12:41:34 INFO - "basedir": "/builds/slave/test", 12:41:34 INFO - "buildnumber": 490, 12:41:34 INFO - "slavename": "talos-linux64-ix-034", 12:41:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:41:34 INFO - "platform": "ubuntu64_hw", 12:41:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:41:34 INFO - "branch": "mozilla-central", 12:41:34 INFO - "repo_path": "mozilla-central", 12:41:34 INFO - "revision": "6adc822f5e27a55551faeb6c47a9bd8b0859a23b", 12:41:34 INFO - "stage_platform": "linux64", 12:41:34 INFO - "builduid": "c551b074b4bb47ada0e34bdaac768409", 12:41:34 INFO - "slavebuilddir": "test" 12:41:34 INFO - } 12:41:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:41:34 INFO - Running post-action listener: _resource_record_post_action 12:41:34 INFO - ##### 12:41:34 INFO - ##### Running download-and-extract step. 12:41:34 INFO - ##### 12:41:34 INFO - Running pre-action listener: _resource_record_pre_action 12:41:34 INFO - Running main action method: download_and_extract 12:41:34 INFO - mkdir: /builds/slave/test/build/tests 12:41:34 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')]} 12:41:34 INFO - https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:36 INFO - Downloaded 1361 bytes. 12:41:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:41:36 INFO - Using the following test package requirements: 12:41:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:41:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:41:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'jsshell-linux-x86_64.zip'], 12:41:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:41:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:41:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:41:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:41:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:41:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:41:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:41:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:41:36 INFO - https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:38 INFO - Downloaded 22300738 bytes. 12:41:38 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'] 12:41:38 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 12:41:39 INFO - Return code: 0 12:41:39 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 12:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:41:39 INFO - https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:40 INFO - Downloaded 22300738 bytes. 12:41:40 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'] 12:41:40 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 12:41:42 INFO - Return code: 0 12:41: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')]} 12:41:42 INFO - https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:42:55 INFO - Downloaded 10840145 bytes. 12:42:55 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'] 12:42:55 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 12:42:55 INFO - Return code: 0 12:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:55 INFO - https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:42:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:42:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:42:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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 12:42:58 INFO - Downloaded 54843937 bytes. 12:42:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:42:58 INFO - mkdir: /builds/slave/test/properties 12:42:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:58 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:58 INFO - Contents: 12:42:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:42:58 INFO - Running post-action listener: _resource_record_post_action 12:42:58 INFO - Running post-action listener: set_extra_try_arguments 12:42:58 INFO - ##### 12:42:58 INFO - ##### Running populate-webroot step. 12:42:58 INFO - ##### 12:42:58 INFO - Running pre-action listener: _resource_record_pre_action 12:42:58 INFO - Running main action method: populate_webroot 12:42:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:58 INFO - '--tppagecycles', 12:42:58 INFO - '7'], 12:42:58 INFO - 'tests': ['tsvgm']}}, 12:42:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['damp', 'tps']}, 12:42:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['damp', 'tps']}, 12:42:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['dromaeo_dom']}, 12:42:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['a11yr', 12:42:58 INFO - 'ts_paint', 12:42:58 INFO - 'tpaint', 12:42:58 INFO - 'sessionrestore', 12:42:58 INFO - 'sessionrestore_no_auto_restore', 12:42:58 INFO - 'tabpaint']}, 12:42:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['tsvgx', 12:42:58 INFO - 'tsvgr_opacity', 12:42:58 INFO - 'tart', 12:42:58 INFO - 'tscrollx', 12:42:58 INFO - 'cart']}, 12:42:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:58 INFO - 'tsvgr_opacity', 12:42:58 INFO - 'tart', 12:42:58 INFO - 'tscrollx', 12:42:58 INFO - 'cart']}, 12:42:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--disable-e10s'], 12:42:58 INFO - 'tests': ['tp5o']}, 12:42:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'tests': ['tp5o']}, 12:42:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--disable-e10s', 12:42:58 INFO - '--xperf_path', 12:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:58 INFO - 'tests': ['tp5n']}, 12:42:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:58 INFO - 'talos_options': ['--xperf_path', 12:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:58 INFO - 'tests': ['tp5n']}}, 12:42:58 INFO - 'talos.zip': {'path': '', 12:42:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:58 INFO - Running post-action listener: _resource_record_post_action 12:42:58 INFO - ##### 12:42:58 INFO - ##### Running create-virtualenv step. 12:42:58 INFO - ##### 12:42:58 INFO - Running pre-action listener: _resource_record_pre_action 12:42:58 INFO - Running main action method: create_virtualenv 12:42:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:58 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 12:42:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:58 INFO - Using real prefix '/usr' 12:42:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:42:59 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:01 INFO - Installing pip.................done. 12:43:01 INFO - Return code: 0 12:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:01 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 12:43:01 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 12:43:01 INFO - Using env: {'DISPLAY': ':0', 12:43:01 INFO - 'HOME': '/home/cltbld', 12:43:01 INFO - 'LANG': 'en_US.UTF-8', 12:43:01 INFO - 'LANGUAGE': 'en_US:en', 12:43:01 INFO - 'LOGNAME': 'cltbld', 12:43:01 INFO - 'MAIL': '/var/mail/cltbld', 12:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:01 INFO - 'MOZ_NO_REMOTE': '1', 12:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:01 INFO - 'NO_EM_RESTART': '1', 12:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:01 INFO - 'PWD': '/builds/slave/test', 12:43:01 INFO - 'SHELL': '/bin/bash', 12:43:01 INFO - 'SHLVL': '1', 12:43:01 INFO - 'TERM': 'linux', 12:43:01 INFO - 'TMOUT': '86400', 12:43:01 INFO - 'USER': 'cltbld', 12:43:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:01 INFO - '_': '/tools/buildbot/bin/python'} 12:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:01 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 12:43:01 INFO - Cleaning up... 12:43:01 INFO - Return code: 0 12:43:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:01 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:01 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>=0.7.1'] in /builds/slave/test/build 12:43:01 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>=0.7.1 12:43:01 INFO - Using env: {'DISPLAY': ':0', 12:43:01 INFO - 'HOME': '/home/cltbld', 12:43:01 INFO - 'LANG': 'en_US.UTF-8', 12:43:01 INFO - 'LANGUAGE': 'en_US:en', 12:43:01 INFO - 'LOGNAME': 'cltbld', 12:43:01 INFO - 'MAIL': '/var/mail/cltbld', 12:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:01 INFO - 'MOZ_NO_REMOTE': '1', 12:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:01 INFO - 'NO_EM_RESTART': '1', 12:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:01 INFO - 'PWD': '/builds/slave/test', 12:43:01 INFO - 'SHELL': '/bin/bash', 12:43:01 INFO - 'SHLVL': '1', 12:43:01 INFO - 'TERM': 'linux', 12:43:01 INFO - 'TMOUT': '86400', 12:43:01 INFO - 'USER': 'cltbld', 12:43:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:01 INFO - '_': '/tools/buildbot/bin/python'} 12:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:01 INFO - Downloading/unpacking psutil>=0.7.1 12:43:01 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 12:43:01 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 12:43:01 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 12:43:01 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 12:43:01 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 12:43:01 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 12:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:03 INFO - Installing collected packages: psutil 12:43:03 INFO - Running setup.py install for psutil 12:43:03 INFO - building 'psutil._psutil_linux' extension 12:43:03 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 12:43:04 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 12:43:04 INFO - building 'psutil._psutil_posix' extension 12:43:04 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 12:43:04 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 12:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:04 INFO - Successfully installed psutil 12:43:04 INFO - Cleaning up... 12:43:04 INFO - Return code: 0 12:43:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:43:04 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')]} 12:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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')]} 12:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:04 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:04 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.0.0'] in /builds/slave/test/build 12:43:04 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.0.0 12:43:04 INFO - Using env: {'DISPLAY': ':0', 12:43:04 INFO - 'HOME': '/home/cltbld', 12:43:04 INFO - 'LANG': 'en_US.UTF-8', 12:43:04 INFO - 'LANGUAGE': 'en_US:en', 12:43:04 INFO - 'LOGNAME': 'cltbld', 12:43:04 INFO - 'MAIL': '/var/mail/cltbld', 12:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:04 INFO - 'MOZ_NO_REMOTE': '1', 12:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:04 INFO - 'NO_EM_RESTART': '1', 12:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:04 INFO - 'PWD': '/builds/slave/test', 12:43:04 INFO - 'SHELL': '/bin/bash', 12:43:04 INFO - 'SHLVL': '1', 12:43:04 INFO - 'TERM': 'linux', 12:43:04 INFO - 'TMOUT': '86400', 12:43:04 INFO - 'USER': 'cltbld', 12:43:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:04 INFO - '_': '/tools/buildbot/bin/python'} 12:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:06 INFO - Installing collected packages: mozsystemmonitor 12:43:06 INFO - Running setup.py install for mozsystemmonitor 12:43:06 INFO - Successfully installed mozsystemmonitor 12:43:06 INFO - Cleaning up... 12:43:06 INFO - Return code: 0 12:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:06 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:06 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 12:43:06 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 12:43:06 INFO - Using env: {'DISPLAY': ':0', 12:43:06 INFO - 'HOME': '/home/cltbld', 12:43:06 INFO - 'LANG': 'en_US.UTF-8', 12:43:06 INFO - 'LANGUAGE': 'en_US:en', 12:43:06 INFO - 'LOGNAME': 'cltbld', 12:43:06 INFO - 'MAIL': '/var/mail/cltbld', 12:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:06 INFO - 'MOZ_NO_REMOTE': '1', 12:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:06 INFO - 'NO_EM_RESTART': '1', 12:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:06 INFO - 'PWD': '/builds/slave/test', 12:43:06 INFO - 'SHELL': '/bin/bash', 12:43:06 INFO - 'SHLVL': '1', 12:43:06 INFO - 'TERM': 'linux', 12:43:06 INFO - 'TMOUT': '86400', 12:43:06 INFO - 'USER': 'cltbld', 12:43:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:06 INFO - '_': '/tools/buildbot/bin/python'} 12:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:06 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:08 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - Downloading docopt-0.6.1.tar.gz 12:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:09 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:09 INFO - Running setup.py install for blobuploader 12:43:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:09 INFO - Running setup.py install for requests 12:43:09 INFO - Running setup.py install for docopt 12:43:10 INFO - Successfully installed blobuploader requests docopt 12:43:10 INFO - Cleaning up... 12:43:10 INFO - Return code: 0 12:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:10 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:10 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 12:43:10 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 12:43:10 INFO - Using env: {'DISPLAY': ':0', 12:43:10 INFO - 'HOME': '/home/cltbld', 12:43:10 INFO - 'LANG': 'en_US.UTF-8', 12:43:10 INFO - 'LANGUAGE': 'en_US:en', 12:43:10 INFO - 'LOGNAME': 'cltbld', 12:43:10 INFO - 'MAIL': '/var/mail/cltbld', 12:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:10 INFO - 'MOZ_NO_REMOTE': '1', 12:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:10 INFO - 'NO_EM_RESTART': '1', 12:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:10 INFO - 'PWD': '/builds/slave/test', 12:43:10 INFO - 'SHELL': '/bin/bash', 12:43:10 INFO - 'SHLVL': '1', 12:43:10 INFO - 'TERM': 'linux', 12:43:10 INFO - 'TMOUT': '86400', 12:43:10 INFO - 'USER': 'cltbld', 12:43:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:10 INFO - '_': '/tools/buildbot/bin/python'} 12:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:10 INFO - Running setup.py (path:/tmp/pip-VN4yBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:10 INFO - Running setup.py (path:/tmp/pip-El_kCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:10 INFO - Running setup.py (path:/tmp/pip-biDioF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:10 INFO - Running setup.py (path:/tmp/pip-ygre1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:10 INFO - Running setup.py (path:/tmp/pip-JlxAYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:10 INFO - Running setup.py (path:/tmp/pip-Mg5XwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:10 INFO - Running setup.py (path:/tmp/pip-aVjcJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:10 INFO - Running setup.py (path:/tmp/pip-_j3OTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:10 INFO - Running setup.py (path:/tmp/pip-JgJ6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:10 INFO - Running setup.py (path:/tmp/pip-dYiC5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:11 INFO - Running setup.py (path:/tmp/pip-3cpX_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:11 INFO - Running setup.py (path:/tmp/pip-zX3MpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:11 INFO - Running setup.py (path:/tmp/pip-0UYQIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:11 INFO - Running setup.py (path:/tmp/pip-oY2dNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:11 INFO - Running setup.py (path:/tmp/pip-mPUXkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:11 INFO - Running setup.py (path:/tmp/pip-V4VCuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:11 INFO - Running setup.py (path:/tmp/pip-6qoQNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:11 INFO - Running setup.py install for manifestparser 12:43:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:11 INFO - Running setup.py install for mozcrash 12:43:11 INFO - Running setup.py install for mozdebug 12:43:11 INFO - Running setup.py install for mozdevice 12:43:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:11 INFO - Running setup.py install for mozfile 12:43:12 INFO - Running setup.py install for mozhttpd 12:43:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozinfo 12:43:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozInstall 12:43:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozleak 12:43:12 INFO - Running setup.py install for mozlog 12:43:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for moznetwork 12:43:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozprocess 12:43:12 INFO - Running setup.py install for mozprofile 12:43:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozrunner 12:43:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for mozscreenshot 12:43:13 INFO - Running setup.py install for moztest 12:43:13 INFO - Running setup.py install for mozversion 12:43:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:13 INFO - Cleaning up... 12:43:13 INFO - Return code: 0 12:43:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:13 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:13 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 12:43:13 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 12:43:13 INFO - Using env: {'DISPLAY': ':0', 12:43:13 INFO - 'HOME': '/home/cltbld', 12:43:13 INFO - 'LANG': 'en_US.UTF-8', 12:43:13 INFO - 'LANGUAGE': 'en_US:en', 12:43:13 INFO - 'LOGNAME': 'cltbld', 12:43:13 INFO - 'MAIL': '/var/mail/cltbld', 12:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:13 INFO - 'MOZ_NO_REMOTE': '1', 12:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:13 INFO - 'NO_EM_RESTART': '1', 12:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:13 INFO - 'PWD': '/builds/slave/test', 12:43:13 INFO - 'SHELL': '/bin/bash', 12:43:13 INFO - 'SHLVL': '1', 12:43:13 INFO - 'TERM': 'linux', 12:43:13 INFO - 'TMOUT': '86400', 12:43:13 INFO - 'USER': 'cltbld', 12:43:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:13 INFO - '_': '/tools/buildbot/bin/python'} 12:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:13 INFO - Running setup.py (path:/tmp/pip-E9gKBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:13 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)) 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:13 INFO - Running setup.py (path:/tmp/pip-mlkGo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:13 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)) 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:13 INFO - Running setup.py (path:/tmp/pip-hzjj9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:13 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)) 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:13 INFO - Running setup.py (path:/tmp/pip-VBLDGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:13 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)) 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:13 INFO - Running setup.py (path:/tmp/pip-u_GYWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:13 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)) 12:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:13 INFO - Running setup.py (path:/tmp/pip-fE2cQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 INFO - Running setup.py (path:/tmp/pip-Bm2JiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 INFO - Running setup.py (path:/tmp/pip-UNJBGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:14 INFO - Running setup.py (path:/tmp/pip-1ms1sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:14 INFO - Running setup.py (path:/tmp/pip-s2d8EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:14 INFO - Running setup.py (path:/tmp/pip-kEOSAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:14 INFO - Running setup.py (path:/tmp/pip-ofYvMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:14 INFO - Running setup.py (path:/tmp/pip-2780E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:14 INFO - Running setup.py (path:/tmp/pip-wdLDqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:14 INFO - Running setup.py (path:/tmp/pip-azWAZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:14 INFO - Running setup.py (path:/tmp/pip-rA2Tht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:14 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)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:14 INFO - Running setup.py (path:/tmp/pip-3yZ9MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:14 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)) 12:43:14 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)) 12:43:14 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)) 12:43:14 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)) 12:43:14 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)) 12:43:14 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)) 12:43:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:14 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 12:43:14 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 12:43:14 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 12:43:14 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 12:43:14 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 12:43:14 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 12:43:16 INFO - Downloading blessings-1.6.tar.gz 12:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:16 INFO - Installing collected packages: blessings 12:43:16 INFO - Running setup.py install for blessings 12:43:16 INFO - Successfully installed blessings 12:43:16 INFO - Cleaning up... 12:43:16 INFO - Return code: 0 12:43:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:17 INFO - Reading from file tmpfile_stdout 12:43:17 INFO - Current package versions: 12:43:17 INFO - argparse == 1.2.1 12:43:17 INFO - blessings == 1.6 12:43:17 INFO - blobuploader == 1.2.4 12:43:17 INFO - docopt == 0.6.1 12:43:17 INFO - manifestparser == 1.1 12:43:17 INFO - mozInstall == 1.12 12:43:17 INFO - mozcrash == 0.17 12:43:17 INFO - mozdebug == 0.1 12:43:17 INFO - mozdevice == 0.48 12:43:17 INFO - mozfile == 1.2 12:43:17 INFO - mozhttpd == 0.7 12:43:17 INFO - mozinfo == 0.9 12:43:17 INFO - mozleak == 0.1 12:43:17 INFO - mozlog == 3.1 12:43:17 INFO - moznetwork == 0.27 12:43:17 INFO - mozprocess == 0.22 12:43:17 INFO - mozprofile == 0.28 12:43:17 INFO - mozrunner == 6.11 12:43:17 INFO - mozscreenshot == 0.1 12:43:17 INFO - mozsystemmonitor == 0.0 12:43:17 INFO - moztest == 0.7 12:43:17 INFO - mozversion == 1.4 12:43:17 INFO - psutil == 3.1.1 12:43:17 INFO - requests == 1.2.3 12:43:17 INFO - wsgiref == 0.1.2 12:43:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:17 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')]} 12:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:17 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')]} 12:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:17 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:17 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 12:43:17 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 12:43:17 INFO - Using env: {'DISPLAY': ':0', 12:43:17 INFO - 'HOME': '/home/cltbld', 12:43:17 INFO - 'LANG': 'en_US.UTF-8', 12:43:17 INFO - 'LANGUAGE': 'en_US:en', 12:43:17 INFO - 'LOGNAME': 'cltbld', 12:43:17 INFO - 'MAIL': '/var/mail/cltbld', 12:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:17 INFO - 'MOZ_NO_REMOTE': '1', 12:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:17 INFO - 'NO_EM_RESTART': '1', 12:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:17 INFO - 'PWD': '/builds/slave/test', 12:43:17 INFO - 'SHELL': '/bin/bash', 12:43:17 INFO - 'SHLVL': '1', 12:43:17 INFO - 'TERM': 'linux', 12:43:17 INFO - 'TMOUT': '86400', 12:43:17 INFO - 'USER': 'cltbld', 12:43:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:17 INFO - '_': '/tools/buildbot/bin/python'} 12:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 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)) 12:43:17 INFO - Cleaning up... 12:43:17 INFO - Return code: 0 12:43:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:17 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')]} 12:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:17 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')]} 12:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:17 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:17 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 12:43:17 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 12:43:17 INFO - Using env: {'DISPLAY': ':0', 12:43:17 INFO - 'HOME': '/home/cltbld', 12:43:17 INFO - 'LANG': 'en_US.UTF-8', 12:43:17 INFO - 'LANGUAGE': 'en_US:en', 12:43:17 INFO - 'LOGNAME': 'cltbld', 12:43:17 INFO - 'MAIL': '/var/mail/cltbld', 12:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:17 INFO - 'MOZ_NO_REMOTE': '1', 12:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:17 INFO - 'NO_EM_RESTART': '1', 12:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:17 INFO - 'PWD': '/builds/slave/test', 12:43:17 INFO - 'SHELL': '/bin/bash', 12:43:17 INFO - 'SHLVL': '1', 12:43:17 INFO - 'TERM': 'linux', 12:43:17 INFO - 'TMOUT': '86400', 12:43:17 INFO - 'USER': 'cltbld', 12:43:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:17 INFO - '_': '/tools/buildbot/bin/python'} 12:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:17 INFO - Downloading/unpacking jsonschema 12:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:19 INFO - Downloading/unpacking functools32 (from jsonschema) 12:43:19 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 12:43:19 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 12:43:19 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 12:43:19 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 12:43:19 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 12:43:19 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 12:43:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:19 INFO - warning: no files found matching '*.txt' 12:43:19 INFO - no previously-included directories found matching 'build' 12:43:19 INFO - no previously-included directories found matching 'dist' 12:43:19 INFO - no previously-included directories found matching '.git*' 12:43:19 INFO - Installing collected packages: jsonschema, functools32 12:43:19 INFO - Running setup.py install for functools32 12:43:19 INFO - warning: no files found matching '*.txt' 12:43:19 INFO - no previously-included directories found matching 'build' 12:43:19 INFO - no previously-included directories found matching 'dist' 12:43:19 INFO - no previously-included directories found matching '.git*' 12:43:19 INFO - Successfully installed jsonschema functools32 12:43:19 INFO - Cleaning up... 12:43:19 INFO - Return code: 0 12:43:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:43:19 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')]} 12:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:19 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')]} 12:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:19 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 0x7fcd9b861f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', '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 12:43:19 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 12:43:19 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 12:43:19 INFO - Using env: {'DISPLAY': ':0', 12:43:19 INFO - 'HOME': '/home/cltbld', 12:43:19 INFO - 'LANG': 'en_US.UTF-8', 12:43:19 INFO - 'LANGUAGE': 'en_US:en', 12:43:19 INFO - 'LOGNAME': 'cltbld', 12:43:19 INFO - 'MAIL': '/var/mail/cltbld', 12:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:19 INFO - 'MOZ_NO_REMOTE': '1', 12:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:19 INFO - 'NO_EM_RESTART': '1', 12:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:19 INFO - 'PWD': '/builds/slave/test', 12:43:19 INFO - 'SHELL': '/bin/bash', 12:43:19 INFO - 'SHLVL': '1', 12:43:19 INFO - 'TERM': 'linux', 12:43:19 INFO - 'TMOUT': '86400', 12:43:19 INFO - 'USER': 'cltbld', 12:43:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:19 INFO - '_': '/tools/buildbot/bin/python'} 12:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:20 INFO - Downloading/unpacking flake8 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:43:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:43:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:43:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:22 INFO - no previously-included directories found matching 'docs/_build' 12:43:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:43:22 INFO - Running setup.py install for pep8 12:43:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:22 INFO - no previously-included directories found matching 'docs/_build' 12:43:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:43:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:43:22 INFO - Cleaning up... 12:43:22 INFO - Return code: 0 12:43:22 INFO - Running post-action listener: _resource_record_post_action 12:43:22 INFO - Running post-action listener: _start_resource_monitoring 12:43:22 INFO - Starting resource monitoring. 12:43:22 INFO - ##### 12:43:22 INFO - ##### Running install step. 12:43:22 INFO - ##### 12:43:22 INFO - Running pre-action listener: _resource_record_pre_action 12:43:22 INFO - Running main action method: install 12:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:23 INFO - Reading from file tmpfile_stdout 12:43:23 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:23 INFO - Reading from file tmpfile_stdout 12:43:23 INFO - Output received: 12:43:23 INFO - Usage: mozinstall [options] installer 12:43:23 INFO - Options: 12:43:23 INFO - -h, --help show this help message and exit 12:43:23 INFO - -d DEST, --destination=DEST 12:43:23 INFO - Directory to install application into. [default: 12:43:23 INFO - "/builds/slave/test"] 12:43:23 INFO - --app=APP Application being installed. [default: firefox] 12:43:23 INFO - mkdir: /builds/slave/test/build/application 12:43:23 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'] 12:43:23 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 12:43:39 INFO - Reading from file tmpfile_stdout 12:43:39 INFO - Output received: 12:43:39 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:39 INFO - Running post-action listener: _resource_record_post_action 12:43:39 INFO - ##### 12:43:39 INFO - ##### Running run-tests step. 12:43:39 INFO - ##### 12:43:39 INFO - Running pre-action listener: _resource_record_pre_action 12:43:39 INFO - Running main action method: run_tests 12:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:39 INFO - Python 2.7.3 12:43:39 INFO - Return code: 0 12:43:39 INFO - grabbing minidump binary from tooltool 12:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252b410>, '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 0x252c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:39 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 12:43:39 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 12:43:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:39 INFO - Return code: 0 12:43:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:43:40 INFO - Return code: 0 12:43:40 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/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 12:43:40 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/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 12:43:40 INFO - Using env: {'DISPLAY': ':0', 12:43:40 INFO - 'HOME': '/home/cltbld', 12:43:40 INFO - 'LANG': 'en_US.UTF-8', 12:43:40 INFO - 'LANGUAGE': 'en_US:en', 12:43:40 INFO - 'LOGNAME': 'cltbld', 12:43:40 INFO - 'MAIL': '/var/mail/cltbld', 12:43:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:40 INFO - 'MOZ_NO_REMOTE': '1', 12:43:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:40 INFO - 'NO_EM_RESTART': '1', 12:43:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:40 INFO - 'PWD': '/builds/slave/test', 12:43:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:40 INFO - 'SHELL': '/bin/bash', 12:43:40 INFO - 'SHLVL': '1', 12:43:40 INFO - 'TERM': 'linux', 12:43:40 INFO - 'TMOUT': '86400', 12:43:40 INFO - 'USER': 'cltbld', 12:43:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290', 12:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:40 INFO - '_': '/tools/buildbot/bin/python'} 12:43:40 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/Fq_0ZSj8RVGB_YYY9f-WzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 12:43:40 INFO - mozversion application_buildid: 20160428112703 12:43:40 INFO - mozversion application_changeset: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b 12:43:40 INFO - mozversion application_display_name: Nightly 12:43:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:40 INFO - mozversion application_name: Firefox 12:43:40 INFO - mozversion application_remotingname: firefox 12:43:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:43:40 INFO - mozversion application_vendor: Mozilla 12:43:40 INFO - mozversion application_version: 49.0a1 12:43:40 INFO - mozversion platform_buildid: 20160428112703 12:43:40 INFO - mozversion platform_changeset: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b 12:43:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:43:40 INFO - mozversion platform_version: 49.0a1 12:43:40 INFO - using testdate: 1461872620 12:43:40 INFO - actual date: 1461872620 12:43:40 INFO - starting webserver on 'localhost:57079' 12:43:40 INFO - SUITE-START | Running 2 tests 12:43:40 INFO - TEST-START | dromaeo_css 12:43:40 INFO - operating with platform_type : linux_ 12:43:40 INFO - Initialising browser for dromaeo_css test... 12:43:40 INFO - TEST-INFO | started process 10735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLnp6G/profile http://localhost:57079/getInfo.html) 12:43:44 INFO - PROCESS | 10735 | __metrics Screen width/height:1600/1200 12:43:44 INFO - PROCESS | 10735 | colorDepth:24 12:43:44 INFO - PROCESS | 10735 | Browser inner width/height: 1024/697 12:43:44 INFO - PROCESS | 10735 | __metrics 12:43:45 ERROR - PROCESS | 10735 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:43:46 INFO - TEST-INFO | 10735: exit 0 12:43:46 INFO - Browser initialized. 12:43:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:46 INFO - TEST-INFO | started process 10815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbLnp6G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:58 INFO - PROCESS | 10815 | RSS: Main: 155295744 12:43:58 INFO - PROCESS | 10815 | 12:44:49 INFO - PROCESS | 10815 | 1461872689943 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] 12:47:02 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57079/tests/dromaeo/cssquery-ext.html) 12:47:03 INFO - PROCESS | 10815 | RSS: Main: 251383808 12:47:03 INFO - PROCESS | 10815 | 12:50:06 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-ext.html (next: http://localhost:57079/tests/dromaeo/cssquery-jquery.html) 12:50:07 INFO - PROCESS | 10815 | RSS: Main: 238600192 12:50:07 INFO - PROCESS | 10815 | 12:53:09 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57079/tests/dromaeo/cssquery-mootools.html) 12:53:09 INFO - PROCESS | 10815 | RSS: Main: 240099328 12:53:09 INFO - PROCESS | 10815 | 12:56:11 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57079/tests/dromaeo/cssquery-prototype.html) 12:56:12 INFO - PROCESS | 10815 | RSS: Main: 237920256 12:56:12 INFO - PROCESS | 10815 | 12:59:15 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57079/tests/dromaeo/cssquery-yui.html) 12:59:16 INFO - PROCESS | 10815 | RSS: Main: 207945728 12:59:16 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | Cycle 1(1): loaded http://localhost:57079/tests/dromaeo/cssquery-yui.html (next: http://localhost:57079/tests/dromaeo/cssquery-dojo.html) 13:02:19 INFO - PROCESS | 10815 | RSS: Main: 267472896 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | __start_tp_report 13:02:19 INFO - PROCESS | 10815 | _x_x_mozilla_page_load 13:02:19 INFO - PROCESS | 10815 | _x_x_mozilla_page_load_details 13:02:19 INFO - PROCESS | 10815 | |i|pagename|runs| 13:02:19 INFO - PROCESS | 10815 | |0;dojo.html;2559.80801439892;2622.095377094902;2634.183403145026;2647.232302632237;2663.3341664583854;4478.753668548236;4547.36336912832;4585.839495617654;4595.241785105453;4598.057398233363;4602;4614.46933602635;4649.0701859628125;4663.487016428198;4668.603168730662;4172.144710334374;4197.811098500567;4202.495700515942;4260.659147268211;4339.41417908583;4309.138172365524;4314.676399270052;4319.071399649075;4362.1275744851;4371.519132895379;4156.709030367875;4233.682473814476;4243.787810609457;4244.851430199959;4271.9359209611885;4164.646005089571;4168.937465938014;4169.353750168699;4169.91660166798;4173.5409104998425;4153.7507749535125;4191.664666826647;4216.536181020116;4262.275413179736;4277.337012763027;4462.442194725627;4490.59584637381;4496.2805951048;4498.3252512123445;4513.480949690795;4785.282207668843;4889.07107649549;4896.216605343128;4901.754912254373;4939.876503087416;4864.878378040542;4911.950880491221;4915.213565829486;4926.926096108561;4979.1784355581285;4626.30605409188;4632.72203667781;4633.745144017112;4635.304704294383;4635.768211589407;4933.605311575066;5046.697198168122;5047.722375269395;5048.495150484922;5050.823221187241;4820.3492528508905;4840.15297322967;4867.70793752376;4882.389701287339;4883.243097319921;4916.007046971567;4918.729469879191;4921.311016457699;4922;4968;4748.453927798348;4820.734859582757;4878.609711223094;4893.699961018387;4926.6551341406475;4799;4806.663533552618;4838.540338667821;4868.464468908417;4872.6589138760655;4088.9182216356103;4092.202020606013;4102.015516276132;4123.546409894909;4135.028268356934;3568.5360903082433;3646.6717995380545;3648.7628304160144;3658;3672.3022625701033;4298.763568003727;4318.632916202095;4329.134173165379;4360.324149756792;4366.978165109218;4900.313956046157;4908.3619129513645;4911.582515486152;4912.901741965141;4941.308216849644;4208.579142085767;4272.978635106804;4283.336082907154;4316.201502722007;4324;4358.564143585616;4359.782010899442;4381.38660587518;4408.6913916026215;4409.096135292258;4615.607673347803;4626.953730462787;4633.907321853477;4636.60588849938;4687.859364219079;4790.257510085942;4862.6839255448285;4892.90214195707;4902.264660300983;4921.966387058757;4647.790849411717;4662.650301227353;4667.579917807414;4688.132695451352;4696.342512048384;4799.28010798383;4817.566419022305;4820.25286080658;4834.299026641188;4869.074875773592;4763.190257656276;4889.975550122226;4893.461719210955;4934.259861020875;4974.552290293746;4732.432108147044;4757.976210118927;4761.738104404291;4765.285207218806;4800.711957282435;4711.982081754419;4738.455077666113;4744;4755.144074066701;4802;4554.362389265571;4638.6752927294765;4671.789769460451;4733.313669517832;4733.881652958704;4800.303955926441;4821.228603423436;4824.396950381202;4847.781849816696;4878.536539028786;4577.473590537131;4725.36207611968;4735.17134501454;4738.810447582058;4742.620590352694 13:02:19 INFO - PROCESS | 10815 | |1;ext.html;576.9192313076168;598.9401059894011;616.2389449030446;619.4889216396474;625.6683957502526;27295.727042729566;35010.474842877375;35703.64296357042;35751.82124089383;35787.64212357876;37918.24163516728;38623.42064869022;38672;38688.41967370492;38796.41805372922;7187.568745875238;7569.735059272926;7771.883421748678;9498.33511654181;9742.318037737361;9792.657256996006;10059.346142500714;10061.245406594498;10075.093241608254;10083.344582602143;10022.699319020405;10087.64693235737;10105.646302379419;10123.240756943222;10131.544080516358;7257.310555497245;9472.336936414455;9782.315237933348;9782.923878373444;9793.706188814347;9835.655752048644;9976.251781116373;9997.350172238854;9999.550065240572;10004.449755263458;37765;38453.807730961445;38544.80727596372;38573;38582.42126368107;3184.5223216517707;3346.0798280472823;3404.3872103021445;3451.930961380758;3761;29700;29802.55296170559;29827.850860745773;30092.699073009426;30134;3284.9835750821094;3371.157210697326;3380.881669141568;3384.0355498683;3462.809545474998;235718;236217;237012;237976.99999999828;238110;30834.383312333626;31537.369252615277;53554.46445535573;53681;53936.46063539393;32613;32768.67231327704;32776.836115819744;32811.343773124405;32872.671273286964;11928.642140735792;12500;12728.61814145577;12728.74542509163;12735.044871634664;9857.852132218022;10089.848652270222;10095;10104.191664666809;10118.797624047478;8097.109317975018;8110.31062359706;8153;8223.301019413297;8230.09468958414;3154.1010811918495;3179.6979286967703;3186.235303527183;3205.134613654347;3256.706896379337;889.9377043606885;917;946.1248345280588;970.335320305593;984.4585477987079;27603.86198068997;28790.856045719636;28877.27806804847;29116.854415727787;29188.708112919023;998.1366118307611;1016.7834121614803;1020.7652239984845;1020.9591616335412;1069.1660504806264;13515.729685406237;13682.863171368357;13830.101043432345;13924.51264205748;14039.438422462987;286440;291997;292784;293045;293636;49268.26097608539;50074.749626252364;50171.74914125479;50256.497435025914;50285.24572131421;1091.841682955967;1237.1834589171103;1251.055453132879;1275.4133098774482;1281.1160299393202;24434;25978.870105649352;26469;26554.203373898814;26653;41225;42048.369274460296;42166.789166053975;42293.36559951542;42298.36552451777;275765;276469;276566;277296;278056;21050;21188.576228475653;23654.763452365944;23711.881440592686;23838;35691.107722306115;36080.45879311865;36082.09794755152;36504.81747591245;36864.26271474609;33620.495692564145;34195.31609367749;34341.484877726354;34790.65209347975;34806.65193348034;34458.655413445544;34512.65487345094;34624.134396640286;34867.4769878447;35112.297754044266;34190.31619367649;34200.14499637429;34283.14292142716;34451.483227752105;34612.82693586516;29423.411531768816;31236.687633123376;31513.52729709102;31515.21211969719;31647;23995.64006539938;24024.27927162188;24051.51896962016;24515.509689805745;24581.87709061443 13:02:19 INFO - PROCESS | 10815 | |2;jquery.html;375.7388614912635;381.4430930840972;385.97491163074415;391.43046866808794;392.5368065682497;15714.685706285882;16567.254473548688;16955.152242387878;17121.914390428046;17123.22945467454;15934.52196434106;16321.673566528692;16721.080340581262;16729.330826766945;16742.66514669709;4572.382728331674;4779.832705855296;4804.543568361;4811.663183577151;4815.783289751969;3459.619441861393;5204.505571970657;5489.286392768934;5512.228288039678;5525.060739674265;5444.134604888395;5494.230807686927;5500.614956953015;5511.476409741068;5513.283273174502;5323.387810401815;5499.340079190522;5503.587230957674;5503.807366742185;5511.4213007634025;3380.797152170853;6158.168647232611;6688.63212523311;6698.129243198353;6698.631575263358;22239.666405003936;22416.32751017472;22754.814325994208;23061.19285824988;23876.64185037226;2051.8974051297378;2121.6075026120216;2154.515234072321;2364.645303204516;2405.494846082325;13803.309834508234;13865.168089914536;14480.565583032527;14518.346674399678;14563.781543276858;1883.990580047091;1963.3717210492648;1993.362124120282;2017.4149496645955;2050.7436570428695;79140.20859791386;81195.59402202952;82686.58656706738;82865;84368.15631843664;16437.83562164387;16626.6674666506;17085.402010929556;17603.11984400775;17763.20065597051;30030.849845750632;30086;30600.69399306023;30618.693813061585;30643.38713225723;8485.915140848636;8870.73387798367;8917.821643567222;9005.14451127142;9143.49710765901;7248.420126389876;7288.9271107289305;7377.6311184440565;7450.105987281561;7460.0674915635545;8194.180581941877;8278.503289802631;8312.916870831214;8479.406441549032;8492.575371231538;2677.6251324814543;3303.752218583616;3428.3828910796296;3496.2205046987706;3544.7341449391397;797.8563858505524;850.141357229203;864.2308345572445;873.5806812729925;881.0836729801064;16183.271752770917;16595.83404165967;16605.169741512876;16758.664826703396;17302.307907683804;892.1479986612899;904.1275169461501;924.0436148586181;929.6560272699145;952.2810278239884;9290.349675522784;9300.255979521622;9537.523123843781;9567.952160239154;9668.70993870185;365690;366298;368676;398415;402407;71534.99999999895;74034.25965740382;75069.6246518764;75424;75916;952.2857856607544;953.756792018031;991.1476130527741;1004.1113614451264;1009.3641006166215;14952.626184345478;14998.625034374229;15108.093514389171;15285.388584456941;15432.691346173238;33335;33623.32753344969;33890.49164262489;34915.4762678555;35027;43867.341989869536;46406.30390544077;48390;48452.273215902496;48597.757011214715;7832.921670783219;7866.685332586632;7871.173526779835;7912.643931023233;8044.959775201321;10377.584896604052;11086.22396432242;11246.875312468688;11337.319760814378;11564.306141631529;9087.864016997875;9710.077542633438;9828.705138845846;9943.65197218123;10050.899491004997;9776.951115244377;9838.508074596099;9866.358686685342;9887.505624718879;10104.646337378157;9809.411435313905;9918.206543476648;10069.345492542961;10100.89899101029;10115.291929564859;7731.7680469586;7844.646990885538;7852.60736963161;7958.482698624571;8053.154418786177;8950.955245223733;9560.952195238979;9658.75853103678;9825.066618671215;10007.672317782453 13:02:19 INFO - PROCESS | 10815 | |3;mootools.html;1270.8856202941733;1409.8942579306552;1458.9927050364747;1580.9209539523022;1770.1680210301154;6615.834604134899;7658.92341076589;7831.216878312166;7847.1368149503505;7859.056913170413;7591.810204744884;7743.2643898829665;7756.340711039555;7758.728444504443;7762.573058481781;1909.7326374307609;1967.527793329605;1976.495993521657;2198.681191227275;2227.5433536125056;2141.379000089972;2219.04581030157;2221.0116498158327;2221.577900198957;2224.555088982202;2194.1113848891223;2201.504661451169;2220.012094617896;2224.1214720185517;2255.672927425522;1915.3583549510931;2167.3389616167065;2208.657658062995;2241.05875532276;2242.0135140538273;2131.8294536437047;2153.332466935255;2157.4282815054025;2158.201465457775;2158.7625361210253;7498.4376171787335;7541.509801862916;7549.245075492462;7558.093028836574;7565.773026809205;4561.931571026437;4743.976280118612;4760.809567617292;4768.165571025092;4769.856904292877;2815.6058151858756;2905.0994191800396;2957.6746557878832;2960.674325824179;2961.096865456035;939.1313035442257;971.5530855806267;974.181687382595;977.946212958287;987.782687808681;10560.683179504627;10737.83893241602;10848.566057357775;10860.837087443695;10873.782524349548;4250.3199488081755;4392.582704643054;4398.516163222043;4400.141972315368;4401.405810215644;9274.350795444388;9322.906770932204;9325;9349.111834375723;9349.485778282124;4651.720896746138;4707.2468405055715;4720.763961801897;4725.456572494207;4732.408448943882;3674.5590529136675;4037.192561487714;4129.215449064668;4131.400946862748;4211.536730959592;3570.3037907608286;3640.5995340512522;3737.663610275088;3745.606711295329;3748.55017397914;1186.4067966016992;1224.1981502116128;1235.4934476864441;1242.5278394210143;1261.3251910227984;642.4474951541671;725.9510008038334;853.176684499461;865.3726048614704;900.8873890763655;5378.2470454136455;5445.992491389105;5447.782088716407;5468.671879687232;5515.503604675599;428.63351834181947;436.65067945643995;437.98467053653604;438.6074463355279;439.5977680422442;3629.1834337273904;3648.325059863934;3670.119171398845;3682.760620559655;3826.579076301605;9310.255179585616;9603.37578057424;9724.902750972542;9787.265955053399;9795.85306220393;9264.814703706023;9556.713298601053;9557.569909354095;9636.614535418505;9665.565049572786;7220.891686624705;7288.635568221568;7385.449055698256;7386.298301661333;7421.703131874772;5017.347744793299;5037.949620503748;5135.512126347991;5190.662606930538;5192.896142077213;8884.466931984101;8893.555322233991;8996.415233009833;9021.278297736035;9049.954750226207;8637.740867773726;8898.11018898105;8964.3276754245;8990.505522196081;9105.681301154427;6073.180120683828;6325.746970121144;6327;6477.805665830033;6598.670066496752;6749.223839258351;7140.892886606601;7320.267973202637;7340.669669864762;7355.77932662021;6716.462682985447;6801.489888258301;6836.965815170893;6916.481263905328;6929.376356127771;6639.900401494078;6733.461323094043;6758.459323254227;6794.626295553792;6842.384185423137;6134;6154.107654390178;6311.053341998737;6314.968425157845;6324.873502530016;4571.497135315046;4662.2074247378705;4746.620270378292;4799.064182484382;4949.802007919643;4601.562851529099;4774.737389443614;4814.975925120352;4841.612670986383;4900 13:02:19 INFO - PROCESS | 10815 | |4;prototype.html;308.84094691234003;311.60581863942116;314.6365947330832;315.61652592100603;318.1854452601342;4656.859069527966;4746.905061898764;4747.3353730477675;4751.548602882721;4773.236282194849;4683.765811709418;4698.45967713713;4706.152892479352;4728.314394412808;4743.288506723985;3583.1221350769033;3693.095191678029;3707.202951365456;3757.830897609614;3841.5774264830848;3755.9061023474496;3797;3797.2405518896194;3803.2583646189005;3812.599677033913;3763.4919285896326;3773.9811300943456;3777.8677746278886;3783.5811570661003;3810.923781524382;3576.4814101955203;3638.5269914911023;3759.454879042551;3770.3024940386117;3797.2785170817456;3366.8148251846383;3378.510116033186;3383.661633836621;3385.356782211372;3396.1849156202334;4519.638428925678;4537.9773101134615;4538.841140560065;4546.090781843612;4561.566651168134;4220.662347012262;4249.150169965988;4295.699301048928;4314.913701725948;4329.398122694592;4938.580220681247;4988.5260900214425;5003.399592048978;5021.648484606079;5023.296738456619;3705.314516814398;3712.87004954828;3720.7023438124884;3721.7766933983776;3729.2914346274392;4954.554090131869;5195.077821206178;5268.789248430096;5275.103232450492;5276.34045744282;3647.124690074363;3684.4841722158917;3706.870259540903;3715.5727091384297;3716;3724.981375093161;3736.3648179808956;3738.3084129436143;3762.454444105644;3770.5286839145106;4261.10516791471;4269.807858646368;4271.231178387858;4278.935815962763;4286.5284818669925;4662.95337046632;5015.774290156952;5026.648134630541;5035.62232832539;5035.647504674637;1378.30395650198;1387.1607677355055;1387.3271463340272;1387.5975966969668;1387.9097858639157;882.1531329923346;941.5245301123026;947.15229869268;968.7287559483356;971.504532688334;4364.75993820343;4412.448443944507;4487.461504619467;4502.189605870974;4521.728696278234;5110.182370820651;5153.768080436389;5156.097682905476;5158.3552055993005;5187.584993200535;4434.889127771831;4462.553744625511;4464.776761161929;4472.932906006413;4482.596566308983;2756.4349308391734;2942.4556457055087;2956.6895475975143;2969.287371030937;2972.18264977133;5222.869428264248;5228.686278823283;5230.241614965808;5233.5551478124025;5234.528892399626;5023.769176551695;5253.632245742838;5665.575081868877;5681.715914204273;5682.801101961411;4921.926171107365;4941.851744447672;4942.5304596063315;4943.2585112233455;4946.3817022872145;5190.728271573337;5219.660722053054;5234.345706786652;5237.738113094254;5258.737063146904;4764;5065.214891691794;5075.695458272516;5077.92383114261;5098.1842905135;4871.95128048715;4878.9512104878495;4881.438634557071;4895.412550493964;4935;3640.690541304019;3646.924157373528;3681.963180368269;3691.98154009239;3717.2565486902186;5091;5160.406553246425;5170.844874653766;5180.715060671549;5199.610029247746;4999.500049994971;5002.674826136289;5005.724685142352;5032.798688052437;5040;5023.2214006829;5050.898982020412;5054.671446355975;5077.593792496517;5079.746012699276;4747.83382581608;4935.654504184673;4964.379452568429;5003.599712023102;5007.69953802773;4796.112719146969;4898.583620392306;5009.972955544032;5037.823676171316;5045.142325804549;4944.134776414185;4974;4984.40187177541;4985.426675932169;4985.426675932169 13:02:19 INFO - PROCESS | 10815 | |5;yui.html;612.966286854223;678.27763431945;724.7535837815142;738.0958326050585;756.7880993321871;10958.12335013199;11985.640430787069;12101.213421127632;12231.266124032565;12378.319192444413;12036.398180091004;12088.153829231935;12122.75754484912;12126.45430955607;12127.757444851097;638.2213699286863;780.773575663057;784.803799050236;805.2229598437507;806.0448368683129;794.7099308752292;802.2458888644655;802.502448481942;802.8153524689325;803.2289002557552;836.3225787112458;838.5136620759945;841.7390608911227;843.995780021099;845.4377838737232;667.552739664426;805.5327909812354;833.5457175839122;837.5895811052571;838.3419016072385;608.9360617135181;609.0164384519014;609.0863704443335;609.5915736456585;609.8048624440181;12117.818232726517;12267.754644907141;12269;12291.078169137261;12312.384380781015;11452.541898324058;11750.435524851113;11755.529778808837;11904.868902636888;12160.635180944586;9859.605615775361;9912.55393507294;9917.157041651468;9976.401415914996;10050.798984020279;3142.874285028596;3185.8088514689193;3236.482162853932;3252.1544398456335;3325.035739635503;40573.594264056985;44415.77792111019;44486.555134448565;44554.10891782146;44669.32996005063;9477.099675530813;9484.383515071499;9657.275704322205;9741.464219467998;9864.161546268504;16323.755143672854;16359.427420040241;16363.42728004538;16369.135401304962;16398.83601163973;6315.273743519462;6372.394622510947;6381.968090159519;6383.96808015957;6402.263739669905;3742.004424093811;3815.275097731422;3820.789856557916;3886.941695874564;3899.1616802387057;2811.9297017574722;2863.9427211455654;2869.2826793301674;2873.798834081594;2874.798764086536;510.18879980829917;513.278843225269;513.4583014919295;521.2103662950633;521.9112750832368;535.7133933345641;562.8461653610165;565.1184152721768;584.95612829038;587.5152998776027;7113.679884405215;7169.247229040876;7522.435817313614;7541.472096953161;7643.388528917673;497.59943245686844;543.6602123672704;563.1271529129914;567.6792612174108;600.7747094839435;3391.5251864738957;3491.650834916488;3520.14821676703;3523.594786599574;3571.1250743567994;54116.45883541114;54732.452675473534;57454.138187927216;57547;57574.424255757745;47268.527314726416;48392;48893.266601001014;49661.50338496569;49791.25313120306;44307.77846110813;44514.554854451686;44898.77550612226;45546;45937.770311148895;7115.5730656160795;7147.606881621561;7260.927390726025;7297.63511824396;7343.816404589928;29421.85289073541;29559.704402955696;30432.239194020327;30831.845840770653;31310.217244569067;40789;40931.59068409278;41375;43437;43974.12051758883;11115.610953616584;11233.775324493301;11306.604268850551;11330.320180789178;11465.36940468249;11814.881851181379;11859.52561897549;11952.64142075739;12724;12736.426860791473;10998.560057597606;11151.944240278746;11194.888051119711;11722.70693232676;11724.41377931083;10805.759206784545;10833.566657333618;11272.436378180893;11565.710857228636;11570.710732231762;10260.993743540163;10565;10614.8407773885;10883.619073332395;10924.50839712199;9711.223102151669;9799.706008819747;9821.705348839547;10186.796264074825;10281.640142594973;9208.3093767969;9661.227101831977;9701.272404569545;9792.80414391694;9954.42695377041 13:02:19 INFO - PROCESS | 10815 | __end_tp_report 13:02:19 INFO - PROCESS | 10815 | __start_cc_report 13:02:19 INFO - PROCESS | 10815 | _x_x_mozilla_cycle_collect,886 13:02:19 INFO - PROCESS | 10815 | __end_cc_report 13:02:19 INFO - PROCESS | 10815 | __startTimestamp1461873739290__endTimestamp 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | ------- Summary: start ------- 13:02:19 INFO - PROCESS | 10815 | Number of tests: 6 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#0] dojo.html Cycles:165 Average:4537.35 Median:4663.49 stddev:461.45 (9.9%) stddev-sans-first:436.01 13:02:19 INFO - PROCESS | 10815 | Values: 2559.8 2622.1 2634.2 2647.2 2663.3 4478.8 4547.4 4585.8 4595.2 4598.1 4602.0 4614.5 4649.1 4663.5 4668.6 4172.1 4197.8 4202.5 4260.7 4339.4 4309.1 4314.7 4319.1 4362.1 4371.5 4156.7 4233.7 4243.8 4244.9 4271.9 4164.6 4168.9 4169.4 4169.9 4173.5 4153.8 4191.7 4216.5 4262.3 4277.3 4462.4 4490.6 4496.3 4498.3 4513.5 4785.3 4889.1 4896.2 4901.8 4939.9 4864.9 4912.0 4915.2 4926.9 4979.2 4626.3 4632.7 4633.7 4635.3 4635.8 4933.6 5046.7 5047.7 5048.5 5050.8 4820.3 4840.2 4867.7 4882.4 4883.2 4916.0 4918.7 4921.3 4922.0 4968.0 4748.5 4820.7 4878.6 4893.7 4926.7 4799.0 4806.7 4838.5 4868.5 4872.7 4088.9 4092.2 4102.0 4123.5 4135.0 3568.5 3646.7 3648.8 3658.0 3672.3 4298.8 4318.6 4329.1 4360.3 4367.0 4900.3 4908.4 4911.6 4912.9 4941.3 4208.6 4273.0 4283.3 4316.2 4324.0 4358.6 4359.8 4381.4 4408.7 4409.1 4615.6 4627.0 4633.9 4636.6 4687.9 4790.3 4862.7 4892.9 4902.3 4922.0 4647.8 4662.7 4667.6 4688.1 4696.3 4799.3 4817.6 4820.3 4834.3 4869.1 4763.2 4890.0 4893.5 4934.3 4974.6 4732.4 4758.0 4761.7 4765.3 4800.7 4712.0 4738.5 4744.0 4755.1 4802.0 4554.4 4638.7 4671.8 4733.3 4733.9 4800.3 4821.2 4824.4 4847.8 4878.5 4577.5 4725.4 4735.2 4738.8 4742.6 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#1] ext.html Cycles:180 Average:41500.67 Median:18048.16 stddev:70467.04 (390.4%) stddev-sans-first:70597.73 13:02:19 INFO - PROCESS | 10815 | Values: 576.9 598.9 616.2 619.5 625.7 27295.7 35010.5 35703.6 35751.8 35787.6 37918.2 38623.4 38672.0 38688.4 38796.4 7187.6 7569.7 7771.9 9498.3 9742.3 9792.7 10059.3 10061.2 10075.1 10083.3 10022.7 10087.6 10105.6 10123.2 10131.5 7257.3 9472.3 9782.3 9782.9 9793.7 9835.7 9976.3 9997.4 9999.6 10004.4 37765.0 38453.8 38544.8 38573.0 38582.4 3184.5 3346.1 3404.4 3451.9 3761.0 29700.0 29802.6 29827.9 30092.7 30134.0 3285.0 3371.2 3380.9 3384.0 3462.8 235718.0 236217.0 237012.0 237977.0 238110.0 30834.4 31537.4 53554.5 53681.0 53936.5 32613.0 32768.7 32776.8 32811.3 32872.7 11928.6 12500.0 12728.6 12728.7 12735.0 9857.9 10089.8 10095.0 10104.2 10118.8 8097.1 8110.3 8153.0 8223.3 8230.1 3154.1 3179.7 3186.2 3205.1 3256.7 889.9 917.0 946.1 970.3 984.5 27603.9 28790.9 28877.3 29116.9 29188.7 998.1 1016.8 1020.8 1021.0 1069.2 13515.7 13682.9 13830.1 13924.5 14039.4 286440.0 291997.0 292784.0 293045.0 293636.0 49268.3 50074.7 50171.7 50256.5 50285.2 1091.8 1237.2 1251.1 1275.4 1281.1 24434.0 25978.9 26469.0 26554.2 26653.0 41225.0 42048.4 42166.8 42293.4 42298.4 275765.0 276469.0 276566.0 277296.0 278056.0 21050.0 21188.6 23654.8 23711.9 23838.0 35691.1 36080.5 36082.1 36504.8 36864.3 33620.5 34195.3 34341.5 34790.7 34806.7 34458.7 34512.7 34624.1 34867.5 35112.3 34190.3 34200.1 34283.1 34451.5 34612.8 29423.4 31236.7 31513.5 31515.2 31647.0 23995.6 24024.3 24051.5 24515.5 24581.9 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#2] jquery.html Cycles:180 Average:25144.93 Median:4813.72 stddev:62957.67 (1307.9%) stddev-sans-first:63106.81 13:02:19 INFO - PROCESS | 10815 | Values: 375.7 381.4 386.0 391.4 392.5 15714.7 16567.3 16955.2 17121.9 17123.2 15934.5 16321.7 16721.1 16729.3 16742.7 4572.4 4779.8 4804.5 4811.7 4815.8 3459.6 5204.5 5489.3 5512.2 5525.1 5444.1 5494.2 5500.6 5511.5 5513.3 5323.4 5499.3 5503.6 5503.8 5511.4 3380.8 6158.2 6688.6 6698.1 6698.6 22239.7 22416.3 22754.8 23061.2 23876.6 2051.9 2121.6 2154.5 2364.6 2405.5 13803.3 13865.2 14480.6 14518.3 14563.8 1884.0 1963.4 1993.4 2017.4 2050.7 79140.2 81195.6 82686.6 82865.0 84368.2 16437.8 16626.7 17085.4 17603.1 17763.2 30030.8 30086.0 30600.7 30618.7 30643.4 8485.9 8870.7 8917.8 9005.1 9143.5 7248.4 7288.9 7377.6 7450.1 7460.1 8194.2 8278.5 8312.9 8479.4 8492.6 2677.6 3303.8 3428.4 3496.2 3544.7 797.9 850.1 864.2 873.6 881.1 16183.3 16595.8 16605.2 16758.7 17302.3 892.1 904.1 924.0 929.7 952.3 9290.3 9300.3 9537.5 9568.0 9668.7 365690.0 366298.0 368676.0 398415.0 402407.0 71535.0 74034.3 75069.6 75424.0 75916.0 952.3 953.8 991.1 1004.1 1009.4 14952.6 14998.6 15108.1 15285.4 15432.7 33335.0 33623.3 33890.5 34915.5 35027.0 43867.3 46406.3 48390.0 48452.3 48597.8 7832.9 7866.7 7871.2 7912.6 8045.0 10377.6 11086.2 11246.9 11337.3 11564.3 9087.9 9710.1 9828.7 9943.7 10050.9 9777.0 9838.5 9866.4 9887.5 10104.6 9809.4 9918.2 10069.3 10100.9 10115.3 7731.8 7844.6 7852.6 7958.5 8053.2 8951.0 9561.0 9658.8 9825.1 10007.7 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#3] mootools.html Cycles:180 Average:5129.81 Median:5027.65 stddev:2880.63 (57.3%) stddev-sans-first:2874.11 13:02:19 INFO - PROCESS | 10815 | Values: 1270.9 1409.9 1459.0 1580.9 1770.2 6615.8 7658.9 7831.2 7847.1 7859.1 7591.8 7743.3 7756.3 7758.7 7762.6 1909.7 1967.5 1976.5 2198.7 2227.5 2141.4 2219.0 2221.0 2221.6 2224.6 2194.1 2201.5 2220.0 2224.1 2255.7 1915.4 2167.3 2208.7 2241.1 2242.0 2131.8 2153.3 2157.4 2158.2 2158.8 7498.4 7541.5 7549.2 7558.1 7565.8 4561.9 4744.0 4760.8 4768.2 4769.9 2815.6 2905.1 2957.7 2960.7 2961.1 939.1 971.6 974.2 977.9 987.8 10560.7 10737.8 10848.6 10860.8 10873.8 4250.3 4392.6 4398.5 4400.1 4401.4 9274.4 9322.9 9325.0 9349.1 9349.5 4651.7 4707.2 4720.8 4725.5 4732.4 3674.6 4037.2 4129.2 4131.4 4211.5 3570.3 3640.6 3737.7 3745.6 3748.6 1186.4 1224.2 1235.5 1242.5 1261.3 642.4 726.0 853.2 865.4 900.9 5378.2 5446.0 5447.8 5468.7 5515.5 428.6 436.7 438.0 438.6 439.6 3629.2 3648.3 3670.1 3682.8 3826.6 9310.3 9603.4 9724.9 9787.3 9795.9 9264.8 9556.7 9557.6 9636.6 9665.6 7220.9 7288.6 7385.4 7386.3 7421.7 5017.3 5037.9 5135.5 5190.7 5192.9 8884.5 8893.6 8996.4 9021.3 9050.0 8637.7 8898.1 8964.3 8990.5 9105.7 6073.2 6325.7 6327.0 6477.8 6598.7 6749.2 7140.9 7320.3 7340.7 7355.8 6716.5 6801.5 6837.0 6916.5 6929.4 6639.9 6733.5 6758.5 6794.6 6842.4 6134.0 6154.1 6311.1 6315.0 6324.9 4571.5 4662.2 4746.6 4799.1 4949.8 4601.6 4774.7 4815.0 4841.6 4900.0 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#4] prototype.html Cycles:180 Average:4205.71 Median:4735.80 stddev:1196.58 (25.3%) stddev-sans-first:1163.64 13:02:19 INFO - PROCESS | 10815 | Values: 308.8 311.6 314.6 315.6 318.2 4656.9 4746.9 4747.3 4751.5 4773.2 4683.8 4698.5 4706.2 4728.3 4743.3 3583.1 3693.1 3707.2 3757.8 3841.6 3755.9 3797.0 3797.2 3803.3 3812.6 3763.5 3774.0 3777.9 3783.6 3810.9 3576.5 3638.5 3759.5 3770.3 3797.3 3366.8 3378.5 3383.7 3385.4 3396.2 4519.6 4538.0 4538.8 4546.1 4561.6 4220.7 4249.2 4295.7 4314.9 4329.4 4938.6 4988.5 5003.4 5021.6 5023.3 3705.3 3712.9 3720.7 3721.8 3729.3 4954.6 5195.1 5268.8 5275.1 5276.3 3647.1 3684.5 3706.9 3715.6 3716.0 3725.0 3736.4 3738.3 3762.5 3770.5 4261.1 4269.8 4271.2 4278.9 4286.5 4663.0 5015.8 5026.6 5035.6 5035.6 1378.3 1387.2 1387.3 1387.6 1387.9 882.2 941.5 947.2 968.7 971.5 4364.8 4412.4 4487.5 4502.2 4521.7 5110.2 5153.8 5156.1 5158.4 5187.6 4434.9 4462.6 4464.8 4472.9 4482.6 2756.4 2942.5 2956.7 2969.3 2972.2 5222.9 5228.7 5230.2 5233.6 5234.5 5023.8 5253.6 5665.6 5681.7 5682.8 4921.9 4941.9 4942.5 4943.3 4946.4 5190.7 5219.7 5234.3 5237.7 5258.7 4764.0 5065.2 5075.7 5077.9 5098.2 4872.0 4879.0 4881.4 4895.4 4935.0 3640.7 3646.9 3682.0 3692.0 3717.3 5091.0 5160.4 5170.8 5180.7 5199.6 4999.5 5002.7 5005.7 5032.8 5040.0 5023.2 5050.9 5054.7 5077.6 5079.7 4747.8 4935.7 4964.4 5003.6 5007.7 4796.1 4898.6 5010.0 5037.8 5045.1 4944.1 4974.0 4984.4 4985.4 4985.4 13:02:19 INFO - PROCESS | 10815 | 13:02:19 INFO - PROCESS | 10815 | [#5] yui.html Cycles:180 Average:12978.92 Median:45222.39 stddev:15134.96 (33.5%) stddev-sans-first:15148.92 13:02:19 INFO - PROCESS | 10815 | Values: 613.0 678.3 724.8 738.1 756.8 10958.1 11985.6 12101.2 12231.3 12378.3 12036.4 12088.2 12122.8 12126.5 12127.8 638.2 780.8 784.8 805.2 806.0 794.7 802.2 802.5 802.8 803.2 836.3 838.5 841.7 844.0 845.4 667.6 805.5 833.5 837.6 838.3 608.9 609.0 609.1 609.6 609.8 12117.8 12267.8 12269.0 12291.1 12312.4 11452.5 11750.4 11755.5 11904.9 12160.6 9859.6 9912.6 9917.2 9976.4 10050.8 3142.9 3185.8 3236.5 3252.2 3325.0 40573.6 44415.8 44486.6 44554.1 44669.3 9477.1 9484.4 9657.3 9741.5 9864.2 16323.8 16359.4 16363.4 16369.1 16398.8 6315.3 6372.4 6382.0 6384.0 6402.3 3742.0 3815.3 3820.8 3886.9 3899.2 2811.9 2863.9 2869.3 2873.8 2874.8 510.2 513.3 513.5 521.2 521.9 535.7 562.8 565.1 585.0 587.5 7113.7 7169.2 7522.4 7541.5 7643.4 497.6 543.7 563.1 567.7 600.8 3391.5 3491.7 3520.1 3523.6 3571.1 54116.5 54732.5 57454.1 57547.0 57574.4 47268.5 48392.0 48893.3 49661.5 49791.3 44307.8 44514.6 44898.8 45546.0 45937.8 7115.6 7147.6 7260.9 7297.6 7343.8 29421.9 29559.7 30432.2 30831.8 31310.2 40789.0 40931.6 41375.0 43437.0 43974.1 11115.6 11233.8 11306.6 11330.3 11465.4 11814.9 11859.5 11952.6 12724.0 12736.4 10998.6 11151.9 11194.9 11722.7 11724.4 10805.8 10833.6 11272.4 11565.7 11570.7 10261.0 10565.0 10614.8 10883.6 10924.5 9711.2 9799.7 9821.7 10186.8 10281.6 9208.3 9661.2 9701.3 9792.8 9954.4 13:02:19 INFO - PROCESS | 10815 | -------- Summary: end -------- 13:02:19 INFO - PROCESS | 10815 | 13:02:20 INFO - TEST-INFO | 10815: exit 0 13:02:20 INFO - TEST-OK | dromaeo_css | took 1119860ms 13:02:20 INFO - TEST-START | kraken 13:02:20 INFO - operating with platform_type : linux_ 13:02:20 INFO - Initialising browser for kraken test... 13:02:20 INFO - TEST-INFO | started process 10990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCaR3oU/profile http://localhost:57079/getInfo.html) 13:02:24 INFO - PROCESS | 10990 | __metrics Screen width/height:1600/1200 13:02:24 INFO - PROCESS | 10990 | colorDepth:24 13:02:24 INFO - PROCESS | 10990 | Browser inner width/height: 1024/697 13:02:24 INFO - PROCESS | 10990 | __metrics 13:02:25 ERROR - PROCESS | 10990 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:02:26 INFO - TEST-INFO | 10990: exit 0 13:02:26 INFO - Browser initialized. 13:02:26 INFO - Running cycle 1/1 for kraken test... 13:02:26 INFO - TEST-INFO | started process 11070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCaR3oU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:38 INFO - PROCESS | 11070 | RSS: Main: 155799552 13:02:38 INFO - PROCESS | 11070 | 13:02:40 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57079/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:41 INFO - PROCESS | 11070 | RSS: Main: 211075072 13:02:41 INFO - PROCESS | 11070 | 13:02:44 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57079/tests/kraken/driver.html?testName=audio-dft) 13:02:45 INFO - PROCESS | 11070 | RSS: Main: 196505600 13:02:45 INFO - PROCESS | 11070 | 13:02:48 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57079/tests/kraken/driver.html?testName=audio-fft) 13:02:49 INFO - PROCESS | 11070 | RSS: Main: 267460608 13:02:49 INFO - PROCESS | 11070 | 13:02:51 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57079/tests/kraken/driver.html?testName=audio-oscillator) 13:02:51 INFO - PROCESS | 11070 | RSS: Main: 175874048 13:02:51 INFO - PROCESS | 11070 | 13:02:54 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:02:54 INFO - PROCESS | 11070 | RSS: Main: 179666944 13:02:54 INFO - PROCESS | 11070 | 13:02:57 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57079/tests/kraken/driver.html?testName=imaging-darkroom) 13:02:58 INFO - PROCESS | 11070 | RSS: Main: 215908352 13:02:58 INFO - PROCESS | 11070 | 13:03:01 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57079/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:02 INFO - PROCESS | 11070 | RSS: Main: 216481792 13:03:02 INFO - PROCESS | 11070 | 13:03:05 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57079/tests/kraken/driver.html?testName=json-parse-financial) 13:03:06 INFO - PROCESS | 11070 | RSS: Main: 216522752 13:03:06 INFO - PROCESS | 11070 | 13:03:07 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:08 INFO - PROCESS | 11070 | RSS: Main: 201895936 13:03:08 INFO - PROCESS | 11070 | 13:03:10 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:10 INFO - PROCESS | 11070 | RSS: Main: 204595200 13:03:10 INFO - PROCESS | 11070 | 13:03:12 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:13 INFO - PROCESS | 11070 | RSS: Main: 216662016 13:03:13 INFO - PROCESS | 11070 | 13:03:16 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:17 INFO - PROCESS | 11070 | RSS: Main: 224882688 13:03:17 INFO - PROCESS | 11070 | 13:03:19 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:20 INFO - PROCESS | 11070 | RSS: Main: 221700096 13:03:20 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | Cycle 1(1): loaded http://localhost:57079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57079/tests/kraken/driver.html?testName=ai-astar) 13:03:22 INFO - PROCESS | 11070 | RSS: Main: 285782016 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | __start_tp_report 13:03:22 INFO - PROCESS | 11070 | _x_x_mozilla_page_load 13:03:22 INFO - PROCESS | 11070 | _x_x_mozilla_page_load_details 13:03:22 INFO - PROCESS | 11070 | |i|pagename|runs| 13:03:22 INFO - PROCESS | 11070 | |0;ai-astar;112;113;109;120;112;112;102;112;113;112 13:03:22 INFO - PROCESS | 11070 | |1;audio-beat-detection;156;135;162;180;133;158;160;133;189;131 13:03:22 INFO - PROCESS | 11070 | |2;audio-dft;160;161;159;160;161;162;161;162;163;167 13:03:22 INFO - PROCESS | 11070 | |3;audio-fft;73;79;130;111;75;76;73;110;108;73 13:03:22 INFO - PROCESS | 11070 | |4;audio-oscillator;93;93;150;94;94;96;145;94;94;144 13:03:22 INFO - PROCESS | 11070 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:03:22 INFO - PROCESS | 11070 | |6;imaging-darkroom;146;146;147;145;146;148;148;146;146;146 13:03:22 INFO - PROCESS | 11070 | |7;imaging-desaturate;96;96;96;95;95;96;94;96;95;95 13:03:22 INFO - PROCESS | 11070 | |8;json-parse-financial;65;66;66;64;65;66;75;81;64;63 13:03:22 INFO - PROCESS | 11070 | |9;json-stringify-tinderbox;64;65;65;64;64;64;65;64;64;65 13:03:22 INFO - PROCESS | 11070 | |10;stanford-crypto-aes;77;78;78;79;89;78;80;80;79;80 13:03:22 INFO - PROCESS | 11070 | |11;stanford-crypto-ccm;128;135;128;131;127;127;127;132;161;134 13:03:22 INFO - PROCESS | 11070 | |12;stanford-crypto-pbkdf2;178;169;172;173;174;174;180;176;173;171 13:03:22 INFO - PROCESS | 11070 | |13;stanford-crypto-sha256-iterative;75;73;72;72;78;73;73;74;74;70 13:03:22 INFO - PROCESS | 11070 | __end_tp_report 13:03:22 INFO - PROCESS | 11070 | __start_cc_report 13:03:22 INFO - PROCESS | 11070 | _x_x_mozilla_cycle_collect,1898 13:03:22 INFO - PROCESS | 11070 | __end_cc_report 13:03:22 INFO - PROCESS | 11070 | __startTimestamp1461873802618__endTimestamp 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | ------- Summary: start ------- 13:03:22 INFO - PROCESS | 11070 | Number of tests: 14 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:4.40 (3.9%) stddev-sans-first:4.66 13:03:22 INFO - PROCESS | 11070 | Values: 112.0 113.0 109.0 120.0 112.0 112.0 102.0 112.0 113.0 112.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:159.00 stddev:20.53 (12.9%) stddev-sans-first:21.75 13:03:22 INFO - PROCESS | 11070 | Values: 156.0 135.0 162.0 180.0 133.0 158.0 160.0 133.0 189.0 131.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.22 (1.4%) stddev-sans-first:2.28 13:03:22 INFO - PROCESS | 11070 | Values: 160.0 161.0 159.0 160.0 161.0 162.0 161.0 162.0 163.0 167.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#3] audio-fft Cycles:10 Average:90.80 Median:73.00 stddev:21.52 (29.5%) stddev-sans-first:21.84 13:03:22 INFO - PROCESS | 11070 | Values: 73.0 79.0 130.0 111.0 75.0 76.0 73.0 110.0 108.0 73.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:25.34 (27.0%) stddev-sans-first:26.14 13:03:22 INFO - PROCESS | 11070 | Values: 93.0 93.0 150.0 94.0 94.0 96.0 145.0 94.0 94.0 144.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:03:22 INFO - PROCESS | 11070 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 13:03:22 INFO - PROCESS | 11070 | Values: 146.0 146.0 147.0 145.0 146.0 148.0 148.0 146.0 146.0 146.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 13:03:22 INFO - PROCESS | 11070 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 94.0 96.0 95.0 95.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:66.00 stddev:5.80 (8.8%) stddev-sans-first:6.08 13:03:22 INFO - PROCESS | 11070 | Values: 65.0 66.0 66.0 64.0 65.0 66.0 75.0 81.0 64.0 63.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:03:22 INFO - PROCESS | 11070 | Values: 64.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:3.39 (4.3%) stddev-sans-first:3.44 13:03:22 INFO - PROCESS | 11070 | Values: 77.0 78.0 78.0 79.0 89.0 78.0 80.0 80.0 79.0 80.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:131.50 stddev:10.28 (7.8%) stddev-sans-first:10.75 13:03:22 INFO - PROCESS | 11070 | Values: 128.0 135.0 128.0 131.0 127.0 127.0 127.0 132.0 161.0 134.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.00 stddev:3.27 (1.9%) stddev-sans-first:3.13 13:03:22 INFO - PROCESS | 11070 | Values: 178.0 169.0 172.0 173.0 174.0 174.0 180.0 176.0 173.0 171.0 13:03:22 INFO - PROCESS | 11070 | 13:03:22 INFO - PROCESS | 11070 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:2.12 (2.9%) stddev-sans-first:2.17 13:03:22 INFO - PROCESS | 11070 | Values: 75.0 73.0 72.0 72.0 78.0 73.0 73.0 74.0 74.0 70.0 13:03:22 INFO - PROCESS | 11070 | -------- Summary: end -------- 13:03:22 INFO - PROCESS | 11070 | 13:03:23 INFO - TEST-INFO | 11070: exit 0 13:03:23 INFO - TEST-OK | kraken | took 63564ms 13:03:23 INFO - SUITE-END | took 1183s 13:03:23 INFO - Completed test suite (00:19:43) 13:03:23 INFO - javascript benchmark 13:03:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2559.80801439892, 2622.095377094902, 2634.183403145026, 2647.232302632237, 2663.3341664583854, 4478.753668548236, 4547.36336912832, 4585.839495617654, 4595.241785105453, 4598.057398233363, 4602.0, 4614.46933602635, 4649.0701859628125, 4663.487016428198, 4668.603168730662, 4172.144710334374, 4197.811098500567, 4202.495700515942, 4260.659147268211, 4339.41417908583, 4309.138172365524, 4314.676399270052, 4319.071399649075, 4362.1275744851, 4371.519132895379, 4156.709030367875, 4233.682473814476, 4243.787810609457, 4244.851430199959, 4271.9359209611885, 4164.646005089571, 4168.937465938014, 4169.353750168699, 4169.91660166798, 4173.5409104998425, 4153.7507749535125, 4191.664666826647, 4216.536181020116, 4262.275413179736, 4277.337012763027, 4462.442194725627, 4490.59584637381, 4496.2805951048, 4498.3252512123445, 4513.480949690795, 4785.282207668843, 4889.07107649549, 4896.216605343128, 4901.754912254373, 4939.876503087416, 4864.878378040542, 4911.950880491221, 4915.213565829486, 4926.926096108561, 4979.1784355581285, 4626.30605409188, 4632.72203667781, 4633.745144017112, 4635.304704294383, 4635.768211589407, 4933.605311575066, 5046.697198168122, 5047.722375269395, 5048.495150484922, 5050.823221187241, 4820.3492528508905, 4840.15297322967, 4867.70793752376, 4882.389701287339, 4883.243097319921, 4916.007046971567, 4918.729469879191, 4921.311016457699, 4922.0, 4968.0, 4748.453927798348, 4820.734859582757, 4878.609711223094, 4893.699961018387, 4926.6551341406475, 4799.0, 4806.663533552618, 4838.540338667821, 4868.464468908417, 4872.6589138760655, 4088.9182216356103, 4092.202020606013, 4102.015516276132, 4123.546409894909, 4135.028268356934, 3568.5360903082433, 3646.6717995380545, 3648.7628304160144, 3658.0, 3672.3022625701033, 4298.763568003727, 4318.632916202095, 4329.134173165379, 4360.324149756792, 4366.978165109218, 4900.313956046157, 4908.3619129513645, 4911.582515486152, 4912.901741965141, 4941.308216849644, 4208.579142085767, 4272.978635106804, 4283.336082907154, 4316.201502722007, 4324.0, 4358.564143585616, 4359.782010899442, 4381.38660587518, 4408.6913916026215, 4409.096135292258, 4615.607673347803, 4626.953730462787, 4633.907321853477, 4636.60588849938, 4687.859364219079, 4790.257510085942, 4862.6839255448285, 4892.90214195707, 4902.264660300983, 4921.966387058757, 4647.790849411717, 4662.650301227353, 4667.579917807414, 4688.132695451352, 4696.342512048384, 4799.28010798383, 4817.566419022305, 4820.25286080658, 4834.299026641188, 4869.074875773592, 4763.190257656276, 4889.975550122226, 4893.461719210955, 4934.259861020875, 4974.552290293746, 4732.432108147044, 4757.976210118927, 4761.738104404291, 4765.285207218806, 4800.711957282435, 4711.982081754419, 4738.455077666113, 4744.0, 4755.144074066701, 4802.0, 4554.362389265571, 4638.6752927294765, 4671.789769460451, 4733.313669517832, 4733.881652958704, 4800.303955926441, 4821.228603423436, 4824.396950381202, 4847.781849816696, 4878.536539028786, 4577.473590537131, 4725.36207611968, 4735.17134501454, 4738.810447582058, 4742.620590352694], "value": 4508.92700441521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.9192313076168, 598.9401059894011, 616.2389449030446, 619.4889216396474, 625.6683957502526, 27295.727042729566, 35010.474842877375, 35703.64296357042, 35751.82124089383, 35787.64212357876, 37918.24163516728, 38623.42064869022, 38672.0, 38688.41967370492, 38796.41805372922, 7187.568745875238, 7569.735059272926, 7771.883421748678, 9498.33511654181, 9742.318037737361, 9792.657256996006, 10059.346142500714, 10061.245406594498, 10075.093241608254, 10083.344582602143, 10022.699319020405, 10087.64693235737, 10105.646302379419, 10123.240756943222, 10131.544080516358, 7257.310555497245, 9472.336936414455, 9782.315237933348, 9782.923878373444, 9793.706188814347, 9835.655752048644, 9976.251781116373, 9997.350172238854, 9999.550065240572, 10004.449755263458, 37765.0, 38453.807730961445, 38544.80727596372, 38573.0, 38582.42126368107, 3184.5223216517707, 3346.0798280472823, 3404.3872103021445, 3451.930961380758, 3761.0, 29700.0, 29802.55296170559, 29827.850860745773, 30092.699073009426, 30134.0, 3284.9835750821094, 3371.157210697326, 3380.881669141568, 3384.0355498683, 3462.809545474998, 235718.0, 236217.0, 237012.0, 237976.99999999828, 238110.0, 30834.383312333626, 31537.369252615277, 53554.46445535573, 53681.0, 53936.46063539393, 32613.0, 32768.67231327704, 32776.836115819744, 32811.343773124405, 32872.671273286964, 11928.642140735792, 12500.0, 12728.61814145577, 12728.74542509163, 12735.044871634664, 9857.852132218022, 10089.848652270222, 10095.0, 10104.191664666809, 10118.797624047478, 8097.109317975018, 8110.31062359706, 8153.0, 8223.301019413297, 8230.09468958414, 3154.1010811918495, 3179.6979286967703, 3186.235303527183, 3205.134613654347, 3256.706896379337, 889.9377043606885, 917.0, 946.1248345280588, 970.335320305593, 984.4585477987079, 27603.86198068997, 28790.856045719636, 28877.27806804847, 29116.854415727787, 29188.708112919023, 998.1366118307611, 1016.7834121614803, 1020.7652239984845, 1020.9591616335412, 1069.1660504806264, 13515.729685406237, 13682.863171368357, 13830.101043432345, 13924.51264205748, 14039.438422462987, 286440.0, 291997.0, 292784.0, 293045.0, 293636.0, 49268.26097608539, 50074.749626252364, 50171.74914125479, 50256.497435025914, 50285.24572131421, 1091.841682955967, 1237.1834589171103, 1251.055453132879, 1275.4133098774482, 1281.1160299393202, 24434.0, 25978.870105649352, 26469.0, 26554.203373898814, 26653.0, 41225.0, 42048.369274460296, 42166.789166053975, 42293.36559951542, 42298.36552451777, 275765.0, 276469.0, 276566.0, 277296.0, 278056.0, 21050.0, 21188.576228475653, 23654.763452365944, 23711.881440592686, 23838.0, 35691.107722306115, 36080.45879311865, 36082.09794755152, 36504.81747591245, 36864.26271474609, 33620.495692564145, 34195.31609367749, 34341.484877726354, 34790.65209347975, 34806.65193348034, 34458.655413445544, 34512.65487345094, 34624.134396640286, 34867.4769878447, 35112.297754044266, 34190.31619367649, 34200.14499637429, 34283.14292142716, 34451.483227752105, 34612.82693586516, 29423.411531768816, 31236.687633123376, 31513.52729709102, 31515.21211969719, 31647.0, 23995.64006539938, 24024.27927162188, 24051.51896962016, 24515.509689805745, 24581.87709061443], "value": 16356.160447876635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7388614912635, 381.4430930840972, 385.97491163074415, 391.43046866808794, 392.5368065682497, 15714.685706285882, 16567.254473548688, 16955.152242387878, 17121.914390428046, 17123.22945467454, 15934.52196434106, 16321.673566528692, 16721.080340581262, 16729.330826766945, 16742.66514669709, 4572.382728331674, 4779.832705855296, 4804.543568361, 4811.663183577151, 4815.783289751969, 3459.619441861393, 5204.505571970657, 5489.286392768934, 5512.228288039678, 5525.060739674265, 5444.134604888395, 5494.230807686927, 5500.614956953015, 5511.476409741068, 5513.283273174502, 5323.387810401815, 5499.340079190522, 5503.587230957674, 5503.807366742185, 5511.4213007634025, 3380.797152170853, 6158.168647232611, 6688.63212523311, 6698.129243198353, 6698.631575263358, 22239.666405003936, 22416.32751017472, 22754.814325994208, 23061.19285824988, 23876.64185037226, 2051.8974051297378, 2121.6075026120216, 2154.515234072321, 2364.645303204516, 2405.494846082325, 13803.309834508234, 13865.168089914536, 14480.565583032527, 14518.346674399678, 14563.781543276858, 1883.990580047091, 1963.3717210492648, 1993.362124120282, 2017.4149496645955, 2050.7436570428695, 79140.20859791386, 81195.59402202952, 82686.58656706738, 82865.0, 84368.15631843664, 16437.83562164387, 16626.6674666506, 17085.402010929556, 17603.11984400775, 17763.20065597051, 30030.849845750632, 30086.0, 30600.69399306023, 30618.693813061585, 30643.38713225723, 8485.915140848636, 8870.73387798367, 8917.821643567222, 9005.14451127142, 9143.49710765901, 7248.420126389876, 7288.9271107289305, 7377.6311184440565, 7450.105987281561, 7460.0674915635545, 8194.180581941877, 8278.503289802631, 8312.916870831214, 8479.406441549032, 8492.575371231538, 2677.6251324814543, 3303.752218583616, 3428.3828910796296, 3496.2205046987706, 3544.7341449391397, 797.8563858505524, 850.141357229203, 864.2308345572445, 873.5806812729925, 881.0836729801064, 16183.271752770917, 16595.83404165967, 16605.169741512876, 16758.664826703396, 17302.307907683804, 892.1479986612899, 904.1275169461501, 924.0436148586181, 929.6560272699145, 952.2810278239884, 9290.349675522784, 9300.255979521622, 9537.523123843781, 9567.952160239154, 9668.70993870185, 365690.0, 366298.0, 368676.0, 398415.0, 402407.0, 71534.99999999895, 74034.25965740382, 75069.6246518764, 75424.0, 75916.0, 952.2857856607544, 953.756792018031, 991.1476130527741, 1004.1113614451264, 1009.3641006166215, 14952.626184345478, 14998.625034374229, 15108.093514389171, 15285.388584456941, 15432.691346173238, 33335.0, 33623.32753344969, 33890.49164262489, 34915.4762678555, 35027.0, 43867.341989869536, 46406.30390544077, 48390.0, 48452.273215902496, 48597.757011214715, 7832.921670783219, 7866.685332586632, 7871.173526779835, 7912.643931023233, 8044.959775201321, 10377.584896604052, 11086.22396432242, 11246.875312468688, 11337.319760814378, 11564.306141631529, 9087.864016997875, 9710.077542633438, 9828.705138845846, 9943.65197218123, 10050.899491004997, 9776.951115244377, 9838.508074596099, 9866.358686685342, 9887.505624718879, 10104.646337378157, 9809.411435313905, 9918.206543476648, 10069.345492542961, 10100.89899101029, 10115.291929564859, 7731.7680469586, 7844.646990885538, 7852.60736963161, 7958.482698624571, 8053.154418786177, 8950.955245223733, 9560.952195238979, 9658.75853103678, 9825.066618671215, 10007.672317782453], "value": 9045.4416417796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.8856202941733, 1409.8942579306552, 1458.9927050364747, 1580.9209539523022, 1770.1680210301154, 6615.834604134899, 7658.92341076589, 7831.216878312166, 7847.1368149503505, 7859.056913170413, 7591.810204744884, 7743.2643898829665, 7756.340711039555, 7758.728444504443, 7762.573058481781, 1909.7326374307609, 1967.527793329605, 1976.495993521657, 2198.681191227275, 2227.5433536125056, 2141.379000089972, 2219.04581030157, 2221.0116498158327, 2221.577900198957, 2224.555088982202, 2194.1113848891223, 2201.504661451169, 2220.012094617896, 2224.1214720185517, 2255.672927425522, 1915.3583549510931, 2167.3389616167065, 2208.657658062995, 2241.05875532276, 2242.0135140538273, 2131.8294536437047, 2153.332466935255, 2157.4282815054025, 2158.201465457775, 2158.7625361210253, 7498.4376171787335, 7541.509801862916, 7549.245075492462, 7558.093028836574, 7565.773026809205, 4561.931571026437, 4743.976280118612, 4760.809567617292, 4768.165571025092, 4769.856904292877, 2815.6058151858756, 2905.0994191800396, 2957.6746557878832, 2960.674325824179, 2961.096865456035, 939.1313035442257, 971.5530855806267, 974.181687382595, 977.946212958287, 987.782687808681, 10560.683179504627, 10737.83893241602, 10848.566057357775, 10860.837087443695, 10873.782524349548, 4250.3199488081755, 4392.582704643054, 4398.516163222043, 4400.141972315368, 4401.405810215644, 9274.350795444388, 9322.906770932204, 9325.0, 9349.111834375723, 9349.485778282124, 4651.720896746138, 4707.2468405055715, 4720.763961801897, 4725.456572494207, 4732.408448943882, 3674.5590529136675, 4037.192561487714, 4129.215449064668, 4131.400946862748, 4211.536730959592, 3570.3037907608286, 3640.5995340512522, 3737.663610275088, 3745.606711295329, 3748.55017397914, 1186.4067966016992, 1224.1981502116128, 1235.4934476864441, 1242.5278394210143, 1261.3251910227984, 642.4474951541671, 725.9510008038334, 853.176684499461, 865.3726048614704, 900.8873890763655, 5378.2470454136455, 5445.992491389105, 5447.782088716407, 5468.671879687232, 5515.503604675599, 428.63351834181947, 436.65067945643995, 437.98467053653604, 438.6074463355279, 439.5977680422442, 3629.1834337273904, 3648.325059863934, 3670.119171398845, 3682.760620559655, 3826.579076301605, 9310.255179585616, 9603.37578057424, 9724.902750972542, 9787.265955053399, 9795.85306220393, 9264.814703706023, 9556.713298601053, 9557.569909354095, 9636.614535418505, 9665.565049572786, 7220.891686624705, 7288.635568221568, 7385.449055698256, 7386.298301661333, 7421.703131874772, 5017.347744793299, 5037.949620503748, 5135.512126347991, 5190.662606930538, 5192.896142077213, 8884.466931984101, 8893.555322233991, 8996.415233009833, 9021.278297736035, 9049.954750226207, 8637.740867773726, 8898.11018898105, 8964.3276754245, 8990.505522196081, 9105.681301154427, 6073.180120683828, 6325.746970121144, 6327.0, 6477.805665830033, 6598.670066496752, 6749.223839258351, 7140.892886606601, 7320.267973202637, 7340.669669864762, 7355.77932662021, 6716.462682985447, 6801.489888258301, 6836.965815170893, 6916.481263905328, 6929.376356127771, 6639.900401494078, 6733.461323094043, 6758.459323254227, 6794.626295553792, 6842.384185423137, 6134.0, 6154.107654390178, 6311.053341998737, 6314.968425157845, 6324.873502530016, 4571.497135315046, 4662.2074247378705, 4746.620270378292, 4799.064182484382, 4949.802007919643, 4601.562851529099, 4774.737389443614, 4814.975925120352, 4841.612670986383, 4900.0], "value": 4073.1156030485768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.84094691234003, 311.60581863942116, 314.6365947330832, 315.61652592100603, 318.1854452601342, 4656.859069527966, 4746.905061898764, 4747.3353730477675, 4751.548602882721, 4773.236282194849, 4683.765811709418, 4698.45967713713, 4706.152892479352, 4728.314394412808, 4743.288506723985, 3583.1221350769033, 3693.095191678029, 3707.202951365456, 3757.830897609614, 3841.5774264830848, 3755.9061023474496, 3797.0, 3797.2405518896194, 3803.2583646189005, 3812.599677033913, 3763.4919285896326, 3773.9811300943456, 3777.8677746278886, 3783.5811570661003, 3810.923781524382, 3576.4814101955203, 3638.5269914911023, 3759.454879042551, 3770.3024940386117, 3797.2785170817456, 3366.8148251846383, 3378.510116033186, 3383.661633836621, 3385.356782211372, 3396.1849156202334, 4519.638428925678, 4537.9773101134615, 4538.841140560065, 4546.090781843612, 4561.566651168134, 4220.662347012262, 4249.150169965988, 4295.699301048928, 4314.913701725948, 4329.398122694592, 4938.580220681247, 4988.5260900214425, 5003.399592048978, 5021.648484606079, 5023.296738456619, 3705.314516814398, 3712.87004954828, 3720.7023438124884, 3721.7766933983776, 3729.2914346274392, 4954.554090131869, 5195.077821206178, 5268.789248430096, 5275.103232450492, 5276.34045744282, 3647.124690074363, 3684.4841722158917, 3706.870259540903, 3715.5727091384297, 3716.0, 3724.981375093161, 3736.3648179808956, 3738.3084129436143, 3762.454444105644, 3770.5286839145106, 4261.10516791471, 4269.807858646368, 4271.231178387858, 4278.935815962763, 4286.5284818669925, 4662.95337046632, 5015.774290156952, 5026.648134630541, 5035.62232832539, 5035.647504674637, 1378.30395650198, 1387.1607677355055, 1387.3271463340272, 1387.5975966969668, 1387.9097858639157, 882.1531329923346, 941.5245301123026, 947.15229869268, 968.7287559483356, 971.504532688334, 4364.75993820343, 4412.448443944507, 4487.461504619467, 4502.189605870974, 4521.728696278234, 5110.182370820651, 5153.768080436389, 5156.097682905476, 5158.3552055993005, 5187.584993200535, 4434.889127771831, 4462.553744625511, 4464.776761161929, 4472.932906006413, 4482.596566308983, 2756.4349308391734, 2942.4556457055087, 2956.6895475975143, 2969.287371030937, 2972.18264977133, 5222.869428264248, 5228.686278823283, 5230.241614965808, 5233.5551478124025, 5234.528892399626, 5023.769176551695, 5253.632245742838, 5665.575081868877, 5681.715914204273, 5682.801101961411, 4921.926171107365, 4941.851744447672, 4942.5304596063315, 4943.2585112233455, 4946.3817022872145, 5190.728271573337, 5219.660722053054, 5234.345706786652, 5237.738113094254, 5258.737063146904, 4764.0, 5065.214891691794, 5075.695458272516, 5077.92383114261, 5098.1842905135, 4871.95128048715, 4878.9512104878495, 4881.438634557071, 4895.412550493964, 4935.0, 3640.690541304019, 3646.924157373528, 3681.963180368269, 3691.98154009239, 3717.2565486902186, 5091.0, 5160.406553246425, 5170.844874653766, 5180.715060671549, 5199.610029247746, 4999.500049994971, 5002.674826136289, 5005.724685142352, 5032.798688052437, 5040.0, 5023.2214006829, 5050.898982020412, 5054.671446355975, 5077.593792496517, 5079.746012699276, 4747.83382581608, 4935.654504184673, 4964.379452568429, 5003.599712023102, 5007.69953802773, 4796.112719146969, 4898.583620392306, 5009.972955544032, 5037.823676171316, 5045.142325804549, 4944.134776414185, 4974.0, 4984.40187177541, 4985.426675932169, 4985.426675932169], "value": 3838.280611875015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.966286854223, 678.27763431945, 724.7535837815142, 738.0958326050585, 756.7880993321871, 10958.12335013199, 11985.640430787069, 12101.213421127632, 12231.266124032565, 12378.319192444413, 12036.398180091004, 12088.153829231935, 12122.75754484912, 12126.45430955607, 12127.757444851097, 638.2213699286863, 780.773575663057, 784.803799050236, 805.2229598437507, 806.0448368683129, 794.7099308752292, 802.2458888644655, 802.502448481942, 802.8153524689325, 803.2289002557552, 836.3225787112458, 838.5136620759945, 841.7390608911227, 843.995780021099, 845.4377838737232, 667.552739664426, 805.5327909812354, 833.5457175839122, 837.5895811052571, 838.3419016072385, 608.9360617135181, 609.0164384519014, 609.0863704443335, 609.5915736456585, 609.8048624440181, 12117.818232726517, 12267.754644907141, 12269.0, 12291.078169137261, 12312.384380781015, 11452.541898324058, 11750.435524851113, 11755.529778808837, 11904.868902636888, 12160.635180944586, 9859.605615775361, 9912.55393507294, 9917.157041651468, 9976.401415914996, 10050.798984020279, 3142.874285028596, 3185.8088514689193, 3236.482162853932, 3252.1544398456335, 3325.035739635503, 40573.594264056985, 44415.77792111019, 44486.555134448565, 44554.10891782146, 44669.32996005063, 9477.099675530813, 9484.383515071499, 9657.275704322205, 9741.464219467998, 9864.161546268504, 16323.755143672854, 16359.427420040241, 16363.42728004538, 16369.135401304962, 16398.83601163973, 6315.273743519462, 6372.394622510947, 6381.968090159519, 6383.96808015957, 6402.263739669905, 3742.004424093811, 3815.275097731422, 3820.789856557916, 3886.941695874564, 3899.1616802387057, 2811.9297017574722, 2863.9427211455654, 2869.2826793301674, 2873.798834081594, 2874.798764086536, 510.18879980829917, 513.278843225269, 513.4583014919295, 521.2103662950633, 521.9112750832368, 535.7133933345641, 562.8461653610165, 565.1184152721768, 584.95612829038, 587.5152998776027, 7113.679884405215, 7169.247229040876, 7522.435817313614, 7541.472096953161, 7643.388528917673, 497.59943245686844, 543.6602123672704, 563.1271529129914, 567.6792612174108, 600.7747094839435, 3391.5251864738957, 3491.650834916488, 3520.14821676703, 3523.594786599574, 3571.1250743567994, 54116.45883541114, 54732.452675473534, 57454.138187927216, 57547.0, 57574.424255757745, 47268.527314726416, 48392.0, 48893.266601001014, 49661.50338496569, 49791.25313120306, 44307.77846110813, 44514.554854451686, 44898.77550612226, 45546.0, 45937.770311148895, 7115.5730656160795, 7147.606881621561, 7260.927390726025, 7297.63511824396, 7343.816404589928, 29421.85289073541, 29559.704402955696, 30432.239194020327, 30831.845840770653, 31310.217244569067, 40789.0, 40931.59068409278, 41375.0, 43437.0, 43974.12051758883, 11115.610953616584, 11233.775324493301, 11306.604268850551, 11330.320180789178, 11465.36940468249, 11814.881851181379, 11859.52561897549, 11952.64142075739, 12724.0, 12736.426860791473, 10998.560057597606, 11151.944240278746, 11194.888051119711, 11722.70693232676, 11724.41377931083, 10805.759206784545, 10833.566657333618, 11272.436378180893, 11565.710857228636, 11570.710732231762, 10260.993743540163, 10565.0, 10614.8407773885, 10883.619073332395, 10924.50839712199, 9711.223102151669, 9799.706008819747, 9821.705348839547, 10186.796264074825, 10281.640142594973, 9208.3093767969, 9661.227101831977, 9701.272404569545, 9792.80414391694, 9954.42695377041], "value": 5878.590743679073, "unit": "score"}], "name": "dromaeo_css", "value": 6279.548671874746, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 109.0, 120.0, 112.0, 112.0, 102.0, 112.0, 113.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 162.0, 180.0, 133.0, 158.0, 160.0, 133.0, 189.0, 131.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0, 162.0, 163.0, 167.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 130.0, 111.0, 75.0, 76.0, 73.0, 110.0, 108.0, 73.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 94.0, 94.0, 96.0, 145.0, 94.0, 94.0, 144.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 148.0, 148.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 65.0, 66.0, 75.0, 81.0, 64.0, 63.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 79.0, 89.0, 78.0, 80.0, 80.0, 79.0, 80.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 128.0, 131.0, 127.0, 127.0, 127.0, 132.0, 161.0, 134.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 169.0, 172.0, 173.0, 174.0, 174.0, 180.0, 176.0, 173.0, 171.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 72.0, 78.0, 73.0, 73.0, 74.0, 74.0, 70.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1578.4, "alertThreshold": 2.0}]} 13:03:23 INFO - Return code: 0 13:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:03:23 ERROR - # TBPL SUCCESS # 13:03:23 INFO - Running post-action listener: _resource_record_post_action 13:03:23 INFO - Running post-run listener: _resource_record_post_run 13:03:24 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 139264; Write bytes: 375898112; Read time: 36; Write time: 556048 13:03:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 96849920; Read time: 0; Write time: 154496 13:03:24 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 139264; Write bytes: 278781952; Read time: 36; Write time: 401508 13:03:24 INFO - Running post-run listener: _upload_blobber_files 13:03:24 INFO - Blob upload gear active. 13:03:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:03:24 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 13:03:24 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'] 13:03:24 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 13:03:25 INFO - (blobuploader) - INFO - Open directory for files ... 13:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:26 INFO - (blobuploader) - INFO - Done attempting. 13:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:26 INFO - (blobuploader) - INFO - Done attempting. 13:03:26 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:26 INFO - Return code: 0 13:03:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/745ba575b1641c15ca00890f7ec572a174cf10b7c66d3c705a1ce44503475d3bfa669eb51f0ac28a3ecc4eb4cc744b64f167221d85a93fcfc0b77d84bfe75edb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c234c15a9910d352e2284c324b9a8f2ef6713cebe5300a7956cdffc66777a0e41ccb0b84ff018505405b5a08ef822d1b592692bdf540ba117fc27fcd346944"} 13:03:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:26 INFO - Contents: 13:03:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/745ba575b1641c15ca00890f7ec572a174cf10b7c66d3c705a1ce44503475d3bfa669eb51f0ac28a3ecc4eb4cc744b64f167221d85a93fcfc0b77d84bfe75edb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c234c15a9910d352e2284c324b9a8f2ef6713cebe5300a7956cdffc66777a0e41ccb0b84ff018505405b5a08ef822d1b592692bdf540ba117fc27fcd346944"} 13:03:26 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:26 INFO - Copying logs to upload dir... 13:03:26 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.184314 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-04-28 13:03:26.926912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 13:03:26.930479) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 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/745ba575b1641c15ca00890f7ec572a174cf10b7c66d3c705a1ce44503475d3bfa669eb51f0ac28a3ecc4eb4cc744b64f167221d85a93fcfc0b77d84bfe75edb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c234c15a9910d352e2284c324b9a8f2ef6713cebe5300a7956cdffc66777a0e41ccb0b84ff018505405b5a08ef822d1b592692bdf540ba117fc27fcd346944"} build_url:https://queue.taskcluster.net/v1/task/Fq_0ZSj8RVGB_YYY9f-WzA/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/Fq_0ZSj8RVGB_YYY9f-WzA/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/745ba575b1641c15ca00890f7ec572a174cf10b7c66d3c705a1ce44503475d3bfa669eb51f0ac28a3ecc4eb4cc744b64f167221d85a93fcfc0b77d84bfe75edb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c234c15a9910d352e2284c324b9a8f2ef6713cebe5300a7956cdffc66777a0e41ccb0b84ff018505405b5a08ef822d1b592692bdf540ba117fc27fcd346944"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 13:03:26.955821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:03:26.956210) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461868569.538999-1494034290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:03:27.039161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 13:03:27.039535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 13:03:27.039911) ========= ========= Total master_lag: 0.16 =========