builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1463658272.95 results: success (0) buildid: 20160519020753 builduid: 645d9f387ec84ae0b97b9b613d199be1 revision: ca41d290daa081865b50f2434aabe15c9fd7ae66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:32.950921) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:32.951367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:32.951668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:32.969945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:32.970216) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 04:44:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.4M=0s 2016-05-19 04:44:33 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.102390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.102701) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016349 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.154084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.154505) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ca41d290daa081865b50f2434aabe15c9fd7ae66 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ca41d290daa081865b50f2434aabe15c9fd7ae66 --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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 04:44:33,438 truncating revision to first 12 chars 2016-05-19 04:44:33,438 Setting DEBUG logging. 2016-05-19 04:44:33,438 attempt 1/10 2016-05-19 04:44:33,438 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ca41d290daa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 04:44:33,701 unpacking tar archive at: mozilla-aurora-ca41d290daa0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563231 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.732029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.732522) ========= script_repo_revision: ca41d290daa081865b50f2434aabe15c9fd7ae66 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.733160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.733637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:44:33.742821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-19 04:44:33.743144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:34 INFO - MultiFileLogger online at 20160519 04:44:34 in /builds/slave/test 04:44:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:44:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:34 INFO - {'append_to_log': False, 04:44:34 INFO - 'base_work_dir': '/builds/slave/test', 04:44:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:44:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:34 INFO - 'branch': 'Mozilla-Aurora', 04:44:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:34 INFO - 'config_files': ('talos/linux_config.py',), 04:44:34 INFO - 'default_actions': ('clobber', 04:44:34 INFO - 'read-buildbot-config', 04:44:34 INFO - 'download-and-extract', 04:44:34 INFO - 'populate-webroot', 04:44:34 INFO - 'create-virtualenv', 04:44:34 INFO - 'install', 04:44:34 INFO - 'run-tests'), 04:44:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:34 INFO - 'download_minidump_stackwalk': True, 04:44:34 INFO - 'download_symbols': 'ondemand', 04:44:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:34 INFO - 'installer_path': 'installer.exe', 04:44:34 INFO - 'log_level': 'info', 04:44:34 INFO - 'log_name': 'talos', 04:44:34 INFO - 'log_to_console': True, 04:44:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:34 INFO - 'opt_config_files': (), 04:44:34 INFO - 'pip_index': False, 04:44:34 INFO - 'sps_profile': False, 04:44:34 INFO - 'sps_profile_interval': 0, 04:44:34 INFO - 'suite': 'dromaeojs', 04:44:34 INFO - 'system_bits': '32', 04:44:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:34 INFO - 'title': 'talos-linux64-ix-033', 04:44:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:34 INFO - 'use_talos_json': True, 04:44:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:34 INFO - 'work_dir': 'build'} 04:44:34 INFO - ##### 04:44:34 INFO - ##### Running clobber step. 04:44:34 INFO - ##### 04:44:34 INFO - Running pre-action listener: _resource_record_pre_action 04:44:34 INFO - Running main action method: clobber 04:44:34 INFO - rmtree: /builds/slave/test/build 04:44:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:34 INFO - Running post-action listener: _resource_record_post_action 04:44:34 INFO - ##### 04:44:34 INFO - ##### Running read-buildbot-config step. 04:44:34 INFO - ##### 04:44:34 INFO - Running pre-action listener: _resource_record_pre_action 04:44:34 INFO - Running main action method: read_buildbot_config 04:44:34 INFO - Using buildbot properties: 04:44:34 INFO - { 04:44:34 INFO - "project": "", 04:44:34 INFO - "product": "firefox", 04:44:34 INFO - "script_repo_revision": "production", 04:44:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:44:34 INFO - "repository": "", 04:44:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:44:34 INFO - "buildid": "20160519020753", 04:44:34 INFO - "pgo_build": "True", 04:44:34 INFO - "basedir": "/builds/slave/test", 04:44:34 INFO - "buildnumber": 335, 04:44:34 INFO - "slavename": "talos-linux64-ix-033", 04:44:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:44:34 INFO - "platform": "ubuntu64_hw", 04:44:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:44:34 INFO - "branch": "mozilla-aurora", 04:44:34 INFO - "repo_path": "releases/mozilla-aurora", 04:44:34 INFO - "revision": "ca41d290daa081865b50f2434aabe15c9fd7ae66", 04:44:34 INFO - "stage_platform": "linux64-pgo", 04:44:34 INFO - "builduid": "645d9f387ec84ae0b97b9b613d199be1", 04:44:34 INFO - "slavebuilddir": "test" 04:44:34 INFO - } 04:44:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:44:34 INFO - Running post-action listener: _resource_record_post_action 04:44:34 INFO - ##### 04:44:34 INFO - ##### Running download-and-extract step. 04:44:34 INFO - ##### 04:44:34 INFO - Running pre-action listener: _resource_record_pre_action 04:44:34 INFO - Running main action method: download_and_extract 04:44:34 INFO - mkdir: /builds/slave/test/build/tests 04:44: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')]} 04:44:34 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:44:35 INFO - Downloaded 1361 bytes. 04:44:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:44:35 INFO - Using the following test package requirements: 04:44:35 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:44:35 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:35 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:44:35 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'jsshell-linux-x86_64.zip'], 04:44:35 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:35 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:44:35 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:44:35 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:44:35 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:35 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:44:35 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:35 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:35 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:36 INFO - Downloaded 23813106 bytes. 04:44:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:44:38 INFO - Return code: 0 04:44:38 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:44:38 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')]} 04:44:38 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:39 INFO - Downloaded 23813106 bytes. 04:44:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:44:40 INFO - Return code: 0 04:44:40 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')]} 04:44:40 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:44:41 INFO - Downloaded 10840145 bytes. 04:44:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:44:41 INFO - Return code: 0 04:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:41 INFO - https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:44:46 INFO - Downloaded 62716570 bytes. 04:44:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:44:46 INFO - mkdir: /builds/slave/test/properties 04:44:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:46 INFO - Contents: 04:44:46 INFO - build_url:https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:44:46 INFO - Running post-action listener: _resource_record_post_action 04:44:46 INFO - Running post-action listener: set_extra_try_arguments 04:44:46 INFO - ##### 04:44:46 INFO - ##### Running populate-webroot step. 04:44:46 INFO - ##### 04:44:46 INFO - Running pre-action listener: _resource_record_pre_action 04:44:46 INFO - Running main action method: populate_webroot 04:44:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:46 INFO - '--tppagecycles', 04:44:46 INFO - '7'], 04:44:46 INFO - 'tests': ['tsvgm']}}, 04:44:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['damp', 'tps']}, 04:44:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'tests': ['damp', 'tps']}, 04:44:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['dromaeo_dom']}, 04:44:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['a11yr', 04:44:46 INFO - 'ts_paint', 04:44:46 INFO - 'tpaint', 04:44:46 INFO - 'sessionrestore', 04:44:46 INFO - 'sessionrestore_no_auto_restore', 04:44:46 INFO - 'tabpaint']}, 04:44:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['tsvgx', 04:44:46 INFO - 'tsvgr_opacity', 04:44:46 INFO - 'tart', 04:44:46 INFO - 'tscrollx', 04:44:46 INFO - 'cart']}, 04:44:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:46 INFO - 'tsvgr_opacity', 04:44:46 INFO - 'tart', 04:44:46 INFO - 'tscrollx', 04:44:46 INFO - 'cart']}, 04:44:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'talos_options': ['--disable-e10s'], 04:44:46 INFO - 'tests': ['tp5o']}, 04:44:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'tests': ['tp5o']}, 04:44:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'talos_options': ['--disable-e10s', 04:44:46 INFO - '--xperf_path', 04:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:46 INFO - 'tests': ['tp5n']}, 04:44:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:46 INFO - 'talos_options': ['--xperf_path', 04:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:46 INFO - 'tests': ['tp5n']}}, 04:44:46 INFO - 'talos.zip': {'path': '', 04:44:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:46 INFO - Running post-action listener: _resource_record_post_action 04:44:46 INFO - ##### 04:44:46 INFO - ##### Running create-virtualenv step. 04:44:46 INFO - ##### 04:44:46 INFO - Running pre-action listener: _resource_record_pre_action 04:44:46 INFO - Running main action method: create_virtualenv 04:44:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:46 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 04:44:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:46 INFO - Using real prefix '/usr' 04:44:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:49 INFO - Installing pip.................done. 04:44:49 INFO - Return code: 0 04:44:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:49 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')]} 04:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 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')]} 04:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:44:49 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 04:44:49 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 04:44:49 INFO - Using env: {'DISPLAY': ':0', 04:44:49 INFO - 'HOME': '/home/cltbld', 04:44:49 INFO - 'LANG': 'en_US.UTF-8', 04:44:49 INFO - 'LANGUAGE': 'en_US:en', 04:44:49 INFO - 'LOGNAME': 'cltbld', 04:44:49 INFO - 'MAIL': '/var/mail/cltbld', 04:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:49 INFO - 'MOZ_NO_REMOTE': '1', 04:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:49 INFO - 'NO_EM_RESTART': '1', 04:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:49 INFO - 'PWD': '/builds/slave/test', 04:44:49 INFO - 'SHELL': '/bin/bash', 04:44:49 INFO - 'SHLVL': '1', 04:44:49 INFO - 'TERM': 'linux', 04:44:49 INFO - 'TMOUT': '86400', 04:44:49 INFO - 'USER': 'cltbld', 04:44:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:49 INFO - '_': '/tools/buildbot/bin/python'} 04:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:49 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 04:44:49 INFO - Cleaning up... 04:44:49 INFO - Return code: 0 04:44:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:44:49 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')]} 04:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 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')]} 04:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:49 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:44:49 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 04:44:49 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 04:44:49 INFO - Using env: {'DISPLAY': ':0', 04:44:49 INFO - 'HOME': '/home/cltbld', 04:44:49 INFO - 'LANG': 'en_US.UTF-8', 04:44:49 INFO - 'LANGUAGE': 'en_US:en', 04:44:49 INFO - 'LOGNAME': 'cltbld', 04:44:49 INFO - 'MAIL': '/var/mail/cltbld', 04:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:49 INFO - 'MOZ_NO_REMOTE': '1', 04:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:49 INFO - 'NO_EM_RESTART': '1', 04:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:49 INFO - 'PWD': '/builds/slave/test', 04:44:49 INFO - 'SHELL': '/bin/bash', 04:44:49 INFO - 'SHLVL': '1', 04:44:49 INFO - 'TERM': 'linux', 04:44:49 INFO - 'TMOUT': '86400', 04:44:49 INFO - 'USER': 'cltbld', 04:44:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:49 INFO - '_': '/tools/buildbot/bin/python'} 04:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:49 INFO - Downloading/unpacking psutil>=0.7.1 04:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:51 INFO - Installing collected packages: psutil 04:44:51 INFO - Running setup.py install for psutil 04:44:51 INFO - building 'psutil._psutil_linux' extension 04:44:51 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 04:44:52 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 04:44:52 INFO - building 'psutil._psutil_posix' extension 04:44:52 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 04:44:52 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 04:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:52 INFO - Successfully installed psutil 04:44:52 INFO - Cleaning up... 04:44:52 INFO - Return code: 0 04:44:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:44:52 INFO - Using env: {'DISPLAY': ':0', 04:44:52 INFO - 'HOME': '/home/cltbld', 04:44:52 INFO - 'LANG': 'en_US.UTF-8', 04:44:52 INFO - 'LANGUAGE': 'en_US:en', 04:44:52 INFO - 'LOGNAME': 'cltbld', 04:44:52 INFO - 'MAIL': '/var/mail/cltbld', 04:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:52 INFO - 'MOZ_NO_REMOTE': '1', 04:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:52 INFO - 'NO_EM_RESTART': '1', 04:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:52 INFO - 'PWD': '/builds/slave/test', 04:44:52 INFO - 'SHELL': '/bin/bash', 04:44:52 INFO - 'SHLVL': '1', 04:44:52 INFO - 'TERM': 'linux', 04:44:52 INFO - 'TMOUT': '86400', 04:44:52 INFO - 'USER': 'cltbld', 04:44:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:52 INFO - '_': '/tools/buildbot/bin/python'} 04:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:44:54 INFO - Installing collected packages: mozsystemmonitor 04:44:54 INFO - Running setup.py install for mozsystemmonitor 04:44:54 INFO - Successfully installed mozsystemmonitor 04:44:54 INFO - Cleaning up... 04:44:54 INFO - Return code: 0 04:44:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:54 INFO - Using env: {'DISPLAY': ':0', 04:44:54 INFO - 'HOME': '/home/cltbld', 04:44:54 INFO - 'LANG': 'en_US.UTF-8', 04:44:54 INFO - 'LANGUAGE': 'en_US:en', 04:44:54 INFO - 'LOGNAME': 'cltbld', 04:44:54 INFO - 'MAIL': '/var/mail/cltbld', 04:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:54 INFO - 'MOZ_NO_REMOTE': '1', 04:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:54 INFO - 'NO_EM_RESTART': '1', 04:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:54 INFO - 'PWD': '/builds/slave/test', 04:44:54 INFO - 'SHELL': '/bin/bash', 04:44:54 INFO - 'SHLVL': '1', 04:44:54 INFO - 'TERM': 'linux', 04:44:54 INFO - 'TMOUT': '86400', 04:44:54 INFO - 'USER': 'cltbld', 04:44:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:54 INFO - '_': '/tools/buildbot/bin/python'} 04:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:56 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 04:44:56 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 04:44:56 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 04:44:56 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 04:44:56 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 04:44:56 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 04:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:57 INFO - Downloading docopt-0.6.1.tar.gz 04:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:57 INFO - Running setup.py install for blobuploader 04:44:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:57 INFO - Running setup.py install for requests 04:44:57 INFO - Running setup.py install for docopt 04:44:58 INFO - Successfully installed blobuploader requests docopt 04:44:58 INFO - Cleaning up... 04:44:58 INFO - Return code: 0 04:44:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:44:58 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 04:44:58 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 04:44:58 INFO - Using env: {'DISPLAY': ':0', 04:44:58 INFO - 'HOME': '/home/cltbld', 04:44:58 INFO - 'LANG': 'en_US.UTF-8', 04:44:58 INFO - 'LANGUAGE': 'en_US:en', 04:44:58 INFO - 'LOGNAME': 'cltbld', 04:44:58 INFO - 'MAIL': '/var/mail/cltbld', 04:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:58 INFO - 'MOZ_NO_REMOTE': '1', 04:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:58 INFO - 'NO_EM_RESTART': '1', 04:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:58 INFO - 'PWD': '/builds/slave/test', 04:44:58 INFO - 'SHELL': '/bin/bash', 04:44:58 INFO - 'SHLVL': '1', 04:44:58 INFO - 'TERM': 'linux', 04:44:58 INFO - 'TMOUT': '86400', 04:44:58 INFO - 'USER': 'cltbld', 04:44:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:58 INFO - '_': '/tools/buildbot/bin/python'} 04:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:58 INFO - Running setup.py (path:/tmp/pip-jDQaTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:58 INFO - Running setup.py (path:/tmp/pip-cSsLWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:58 INFO - Running setup.py (path:/tmp/pip-PAErh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:58 INFO - Running setup.py (path:/tmp/pip-VXuaW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:58 INFO - Running setup.py (path:/tmp/pip-Kmdeso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:58 INFO - Running setup.py (path:/tmp/pip-Ez3prT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:58 INFO - Running setup.py (path:/tmp/pip-UMOV2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:58 INFO - Running setup.py (path:/tmp/pip-80UkCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:58 INFO - Running setup.py (path:/tmp/pip-meqPR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:58 INFO - Running setup.py (path:/tmp/pip-gt8eGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 INFO - Running setup.py (path:/tmp/pip-AtuHZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:59 INFO - Running setup.py (path:/tmp/pip-8vIdZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:59 INFO - Running setup.py (path:/tmp/pip-bp8A2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:59 INFO - Running setup.py (path:/tmp/pip-LZhGVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:59 INFO - Running setup.py (path:/tmp/pip-JJUbsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:59 INFO - Running setup.py (path:/tmp/pip-3OGqsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:59 INFO - Running setup.py (path:/tmp/pip-Opj6MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:59 INFO - Running setup.py install for manifestparser 04:44:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:59 INFO - Running setup.py install for mozcrash 04:44:59 INFO - Running setup.py install for mozdebug 04:44:59 INFO - Running setup.py install for mozdevice 04:44:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:59 INFO - Running setup.py install for mozfile 04:45:00 INFO - Running setup.py install for mozhttpd 04:45:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozinfo 04:45:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozInstall 04:45:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozleak 04:45:00 INFO - Running setup.py install for mozlog 04:45:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for moznetwork 04:45:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozprocess 04:45:00 INFO - Running setup.py install for mozprofile 04:45:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozrunner 04:45:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Running setup.py install for mozscreenshot 04:45:01 INFO - Running setup.py install for moztest 04:45:01 INFO - Running setup.py install for mozversion 04:45:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:01 INFO - Cleaning up... 04:45:01 INFO - Return code: 0 04:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:01 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:45:01 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 04:45:01 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 04:45:01 INFO - Using env: {'DISPLAY': ':0', 04:45:01 INFO - 'HOME': '/home/cltbld', 04:45:01 INFO - 'LANG': 'en_US.UTF-8', 04:45:01 INFO - 'LANGUAGE': 'en_US:en', 04:45:01 INFO - 'LOGNAME': 'cltbld', 04:45:01 INFO - 'MAIL': '/var/mail/cltbld', 04:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:01 INFO - 'MOZ_NO_REMOTE': '1', 04:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:01 INFO - 'NO_EM_RESTART': '1', 04:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:01 INFO - 'PWD': '/builds/slave/test', 04:45:01 INFO - 'SHELL': '/bin/bash', 04:45:01 INFO - 'SHLVL': '1', 04:45:01 INFO - 'TERM': 'linux', 04:45:01 INFO - 'TMOUT': '86400', 04:45:01 INFO - 'USER': 'cltbld', 04:45:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:01 INFO - '_': '/tools/buildbot/bin/python'} 04:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:01 INFO - Running setup.py (path:/tmp/pip-qJnjs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:01 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)) 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:01 INFO - Running setup.py (path:/tmp/pip-Q2HwDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:01 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)) 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:01 INFO - Running setup.py (path:/tmp/pip-XfC7Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:01 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)) 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:01 INFO - Running setup.py (path:/tmp/pip-QRLKLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:01 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)) 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:01 INFO - Running setup.py (path:/tmp/pip-h2ODYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:01 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)) 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:01 INFO - Running setup.py (path:/tmp/pip-XY779E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:02 INFO - Running setup.py (path:/tmp/pip-iUId4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:02 INFO - Running setup.py (path:/tmp/pip-Eroiad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:02 INFO - Running setup.py (path:/tmp/pip-3Axw9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:02 INFO - Running setup.py (path:/tmp/pip-6qTiud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:02 INFO - Running setup.py (path:/tmp/pip-ldCXUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:02 INFO - Running setup.py (path:/tmp/pip-lA35Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:02 INFO - Running setup.py (path:/tmp/pip-_ImFK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:02 INFO - Running setup.py (path:/tmp/pip-aHav9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:02 INFO - Running setup.py (path:/tmp/pip-dUP2nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:02 INFO - Running setup.py (path:/tmp/pip-9AQL9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:02 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)) 04:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:02 INFO - Running setup.py (path:/tmp/pip-zKGkB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:02 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)) 04:45:02 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)) 04:45:02 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)) 04:45:02 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)) 04:45:02 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)) 04:45:02 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)) 04:45:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:04 INFO - Downloading blessings-1.6.tar.gz 04:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:04 INFO - Installing collected packages: blessings 04:45:04 INFO - Running setup.py install for blessings 04:45:04 INFO - Successfully installed blessings 04:45:04 INFO - Cleaning up... 04:45:04 INFO - Return code: 0 04:45:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:05 INFO - Reading from file tmpfile_stdout 04:45:05 INFO - Current package versions: 04:45:05 INFO - argparse == 1.2.1 04:45:05 INFO - blessings == 1.6 04:45:05 INFO - blobuploader == 1.2.4 04:45:05 INFO - docopt == 0.6.1 04:45:05 INFO - manifestparser == 1.1 04:45:05 INFO - mozInstall == 1.12 04:45:05 INFO - mozcrash == 0.17 04:45:05 INFO - mozdebug == 0.1 04:45:05 INFO - mozdevice == 0.48 04:45:05 INFO - mozfile == 1.2 04:45:05 INFO - mozhttpd == 0.7 04:45:05 INFO - mozinfo == 0.9 04:45:05 INFO - mozleak == 0.1 04:45:05 INFO - mozlog == 3.1 04:45:05 INFO - moznetwork == 0.27 04:45:05 INFO - mozprocess == 0.22 04:45:05 INFO - mozprofile == 0.28 04:45:05 INFO - mozrunner == 6.11 04:45:05 INFO - mozscreenshot == 0.1 04:45:05 INFO - mozsystemmonitor == 0.0 04:45:05 INFO - moztest == 0.7 04:45:05 INFO - mozversion == 1.4 04:45:05 INFO - psutil == 3.1.1 04:45:05 INFO - requests == 1.2.3 04:45:05 INFO - wsgiref == 0.1.2 04:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:05 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')]} 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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')]} 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:45:05 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 04:45:05 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 04:45:05 INFO - Using env: {'DISPLAY': ':0', 04:45:05 INFO - 'HOME': '/home/cltbld', 04:45:05 INFO - 'LANG': 'en_US.UTF-8', 04:45:05 INFO - 'LANGUAGE': 'en_US:en', 04:45:05 INFO - 'LOGNAME': 'cltbld', 04:45:05 INFO - 'MAIL': '/var/mail/cltbld', 04:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:05 INFO - 'MOZ_NO_REMOTE': '1', 04:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:05 INFO - 'NO_EM_RESTART': '1', 04:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:05 INFO - 'PWD': '/builds/slave/test', 04:45:05 INFO - 'SHELL': '/bin/bash', 04:45:05 INFO - 'SHLVL': '1', 04:45:05 INFO - 'TERM': 'linux', 04:45:05 INFO - 'TMOUT': '86400', 04:45:05 INFO - 'USER': 'cltbld', 04:45:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:05 INFO - '_': '/tools/buildbot/bin/python'} 04:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 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)) 04:45:05 INFO - Cleaning up... 04:45:05 INFO - Return code: 0 04:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:05 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')]} 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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')]} 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:45:05 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 04:45:05 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 04:45:05 INFO - Using env: {'DISPLAY': ':0', 04:45:05 INFO - 'HOME': '/home/cltbld', 04:45:05 INFO - 'LANG': 'en_US.UTF-8', 04:45:05 INFO - 'LANGUAGE': 'en_US:en', 04:45:05 INFO - 'LOGNAME': 'cltbld', 04:45:05 INFO - 'MAIL': '/var/mail/cltbld', 04:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:05 INFO - 'MOZ_NO_REMOTE': '1', 04:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:05 INFO - 'NO_EM_RESTART': '1', 04:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:05 INFO - 'PWD': '/builds/slave/test', 04:45:05 INFO - 'SHELL': '/bin/bash', 04:45:05 INFO - 'SHLVL': '1', 04:45:05 INFO - 'TERM': 'linux', 04:45:05 INFO - 'TMOUT': '86400', 04:45:05 INFO - 'USER': 'cltbld', 04:45:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:05 INFO - '_': '/tools/buildbot/bin/python'} 04:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:05 INFO - Downloading/unpacking jsonschema 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:45:07 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 04:45:07 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 04:45:07 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 04:45:07 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 04:45:07 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 04:45:07 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 04:45:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:07 INFO - warning: no files found matching '*.txt' 04:45:07 INFO - no previously-included directories found matching 'build' 04:45:07 INFO - no previously-included directories found matching 'dist' 04:45:07 INFO - no previously-included directories found matching '.git*' 04:45:07 INFO - Installing collected packages: jsonschema, functools32 04:45:07 INFO - Running setup.py install for functools32 04:45:07 INFO - warning: no files found matching '*.txt' 04:45:07 INFO - no previously-included directories found matching 'build' 04:45:07 INFO - no previously-included directories found matching 'dist' 04:45:07 INFO - no previously-included directories found matching '.git*' 04:45:07 INFO - Successfully installed jsonschema functools32 04:45:07 INFO - Cleaning up... 04:45:07 INFO - Return code: 0 04:45:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:45:07 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')]} 04:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:07 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')]} 04:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:07 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 0x7f9f43296f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', '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 04:45:07 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 04:45:07 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 04:45:08 INFO - Using env: {'DISPLAY': ':0', 04:45:08 INFO - 'HOME': '/home/cltbld', 04:45:08 INFO - 'LANG': 'en_US.UTF-8', 04:45:08 INFO - 'LANGUAGE': 'en_US:en', 04:45:08 INFO - 'LOGNAME': 'cltbld', 04:45:08 INFO - 'MAIL': '/var/mail/cltbld', 04:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:08 INFO - 'MOZ_NO_REMOTE': '1', 04:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:08 INFO - 'NO_EM_RESTART': '1', 04:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:08 INFO - 'PWD': '/builds/slave/test', 04:45:08 INFO - 'SHELL': '/bin/bash', 04:45:08 INFO - 'SHLVL': '1', 04:45:08 INFO - 'TERM': 'linux', 04:45:08 INFO - 'TMOUT': '86400', 04:45:08 INFO - 'USER': 'cltbld', 04:45:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:08 INFO - '_': '/tools/buildbot/bin/python'} 04:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:08 INFO - Downloading/unpacking flake8 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:10 INFO - no previously-included directories found matching 'docs/_build' 04:45:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:10 INFO - Running setup.py install for pep8 04:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:10 INFO - no previously-included directories found matching 'docs/_build' 04:45:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:45:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:10 INFO - Cleaning up... 04:45:11 INFO - Return code: 0 04:45:11 INFO - Running post-action listener: _resource_record_post_action 04:45:11 INFO - Running post-action listener: _start_resource_monitoring 04:45:11 INFO - Starting resource monitoring. 04:45:11 INFO - ##### 04:45:11 INFO - ##### Running install step. 04:45:11 INFO - ##### 04:45:11 INFO - Running pre-action listener: _resource_record_pre_action 04:45:11 INFO - Running main action method: install 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:11 INFO - Reading from file tmpfile_stdout 04:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:11 INFO - Reading from file tmpfile_stdout 04:45:11 INFO - Output received: 04:45:11 INFO - Usage: mozinstall [options] installer 04:45:11 INFO - Options: 04:45:11 INFO - -h, --help show this help message and exit 04:45:11 INFO - -d DEST, --destination=DEST 04:45:11 INFO - Directory to install application into. [default: 04:45:11 INFO - "/builds/slave/test"] 04:45:11 INFO - --app=APP Application being installed. [default: firefox] 04:45:11 INFO - mkdir: /builds/slave/test/build/application 04:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:45:27 INFO - Reading from file tmpfile_stdout 04:45:27 INFO - Output received: 04:45:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:27 INFO - Running post-action listener: _resource_record_post_action 04:45:27 INFO - ##### 04:45:27 INFO - ##### Running run-tests step. 04:45:27 INFO - ##### 04:45:27 INFO - Running pre-action listener: _resource_record_pre_action 04:45:27 INFO - Running main action method: run_tests 04:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:27 INFO - Python 2.7.3 04:45:27 INFO - Return code: 0 04:45:27 INFO - grabbing minidump binary from tooltool 04:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:27 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 0x2c60410>, '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 0x2c61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c617a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:27 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 04:45:27 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 04:45:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:27 INFO - Return code: 0 04:45:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:45:28 INFO - Return code: 0 04:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 04:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 04:45:28 INFO - Using env: {'DISPLAY': ':0', 04:45:28 INFO - 'HOME': '/home/cltbld', 04:45:28 INFO - 'LANG': 'en_US.UTF-8', 04:45:28 INFO - 'LANGUAGE': 'en_US:en', 04:45:28 INFO - 'LOGNAME': 'cltbld', 04:45:28 INFO - 'MAIL': '/var/mail/cltbld', 04:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:28 INFO - 'MOZ_NO_REMOTE': '1', 04:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:28 INFO - 'NO_EM_RESTART': '1', 04:45:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:28 INFO - 'PWD': '/builds/slave/test', 04:45:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:28 INFO - 'SHELL': '/bin/bash', 04:45:28 INFO - 'SHLVL': '1', 04:45:28 INFO - 'TERM': 'linux', 04:45:28 INFO - 'TMOUT': '86400', 04:45:28 INFO - 'USER': 'cltbld', 04:45:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581', 04:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:28 INFO - '_': '/tools/buildbot/bin/python'} 04:45:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 04:45:28 INFO - mozversion application_buildid: 20160519020753 04:45:28 INFO - mozversion application_changeset: ca41d290daa081865b50f2434aabe15c9fd7ae66 04:45:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:45:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:28 INFO - mozversion application_name: Firefox 04:45:28 INFO - mozversion application_remotingname: firefox-dev 04:45:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:28 INFO - mozversion application_vendor: Mozilla 04:45:28 INFO - mozversion application_version: 48.0a2 04:45:28 INFO - mozversion platform_buildid: 20160519020753 04:45:28 INFO - mozversion platform_changeset: ca41d290daa081865b50f2434aabe15c9fd7ae66 04:45:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:45:28 INFO - mozversion platform_version: 48.0a2 04:45:28 INFO - using testdate: 1463658328 04:45:28 INFO - actual date: 1463658328 04:45:28 INFO - starting webserver on 'localhost:49300' 04:45:28 INFO - SUITE-START | Running 2 tests 04:45:28 INFO - TEST-START | dromaeo_css 04:45:28 INFO - operating with platform_type : linux_ 04:45:28 INFO - Initialising browser for dromaeo_css test... 04:45:28 INFO - TEST-INFO | started process 7798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5Z7g9/profile http://localhost:49300/getInfo.html) 04:45:33 INFO - PROCESS | 7798 | __metrics Screen width/height:1600/1200 04:45:33 INFO - PROCESS | 7798 | colorDepth:24 04:45:33 INFO - PROCESS | 7798 | Browser inner width/height: 1024/697 04:45:33 INFO - PROCESS | 7798 | __metrics 04:45:34 ERROR - PROCESS | 7798 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:45:35 INFO - TEST-INFO | 7798: exit 0 04:45:35 INFO - Browser initialized. 04:45:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:35 INFO - TEST-INFO | started process 7893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg5Z7g9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:47 INFO - PROCESS | 7893 | RSS: Main: 142749696 04:45:47 INFO - PROCESS | 7893 | 04:46:38 INFO - PROCESS | 7893 | 1463658398710 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] 04:48:46 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49300/tests/dromaeo/cssquery-ext.html) 04:48:47 INFO - PROCESS | 7893 | RSS: Main: 254283776 04:48:47 INFO - PROCESS | 7893 | 04:51:50 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-ext.html (next: http://localhost:49300/tests/dromaeo/cssquery-jquery.html) 04:51:50 INFO - PROCESS | 7893 | RSS: Main: 225361920 04:51:50 INFO - PROCESS | 7893 | 04:54:52 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49300/tests/dromaeo/cssquery-mootools.html) 04:54:52 INFO - PROCESS | 7893 | RSS: Main: 216743936 04:54:52 INFO - PROCESS | 7893 | 04:57:54 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49300/tests/dromaeo/cssquery-prototype.html) 04:57:55 INFO - PROCESS | 7893 | RSS: Main: 218619904 04:57:55 INFO - PROCESS | 7893 | 05:00:57 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49300/tests/dromaeo/cssquery-yui.html) 05:00:58 INFO - PROCESS | 7893 | RSS: Main: 182861824 05:00:58 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | Cycle 1(1): loaded http://localhost:49300/tests/dromaeo/cssquery-yui.html (next: http://localhost:49300/tests/dromaeo/cssquery-dojo.html) 05:04:01 INFO - PROCESS | 7893 | RSS: Main: 252268544 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | __start_tp_report 05:04:01 INFO - PROCESS | 7893 | _x_x_mozilla_page_load 05:04:01 INFO - PROCESS | 7893 | _x_x_mozilla_page_load_details 05:04:01 INFO - PROCESS | 7893 | |i|pagename|runs| 05:04:01 INFO - PROCESS | 7893 | |0;dojo.html;3344.5150453184287;3428.0744199066253;3440.088376580205;3457.429524128519;3473.166440054386;5681.602287839853;5689.833584115257;5694.943050569493;5696.316442026952;5698.629589076712;5681.948839464702;5705.914411283824;5716.056850619653;5716.428357164282;5720.8855822883625;4911.656184067117;5159.509846564571;5268.420473747885;5307.920381194285;5331.093714068617;5088.007838471481;5133.3326667533165;5133.948660513403;5134.178531434971;5134.204198349262;5127.538521533062;5136.409312929005;5183.740812959337;5205.86985325368;5207.088759467097;5206.557442617382;5290.867728306785;5291.603129765283;5300.337457817773;5320.408724111209;4996.050750357457;5027.874303142414;5095.31213286209;5176.5858731301405;5185.896282074337;5469.917951230735;5490.533304669108;5527.447255274481;5537.280153580049;5539.335279766414;5979.252593425822;5982.521398288127;5991.161237426763;5993.61041532299;5999.6700181490005;5964.105384192362;6036.637801731867;6045.969770151165;6060.515158787331;6076.756929722806;5691.06097493913;5736.397678243766;5756.769729210827;5767.452092051249;5775.971120144372;6067.514598832083;6252.624842509464;6267.5299352548745;6270.968645156836;6289.371062893765;5952.5833191676165;6010.2186715726675;6013.428724271187;6014.097885317237;6033.276006879202;6040.09398590215;6041.154238406627;6049.1833602463985;6050.576459647782;6050.576459647782;5817.50551203144;6012.128241404972;6016.69916504173;6027.9095813562835;6038.396160384014;6046.093086037042;6054.969725151346;6056.576039677268;6057.3639767824625;6095.299040610298;4585.060062687141;4589.059242855206;4590;4591.104734576792;4620.330052142488;3965.940510892339;4080.8367665293054;4113.773742444135;4132.152908653718;4134.91730165395;5774.307083150049;5797.217375654317;5799.420057994167;5801.390853960358;5801.82594522165;6067.453929146398;6104.572679912452;6125.479334256549;6130.47890929276;6130.877382452326;5608.383077861432;5640.0693885508435;5764.798232061858;5770.971145144332;5788.565857560699;5022.070916880389;5034.521720436553;5049.671771334852;5050.141475949097;5058.190689489664;6318.4313411793155;6335.809925702236;6339.936600634027;6343.333949935282;6363.713632886531;5876.676782776988;6062.848428789315;6128.228138398679;6133.8855759873895;6143.266246520256;6315.052742088724;6335.303116657256;6359.07793369968;6360.300366959723;6363.109164717036;5770.971145144247;6012.188354572077;6023.096535519532;6032.939670603238;6033.487153591994;6078.90881636767;6144.385561443999;6154.446099851035;6158.599691020069;6159.72281247336;5809.448102430262;5851.765929362778;5859.150423188528;5892.35184129754;5921.14143449206;5689.630174038674;5795.246617939641;5843.678597676999;5856.59003869725;5938.495227905503;5769.221155144001;5773;5774.220480235114;5779.566532510163;5815.592908496534;5846.093855452412;5879.676617786063;5885.293764748258;5906.114082887601;5914.497267732118;5642.2665053544415;5721.8569535761935;5729.197912292199;5745.339285982165;5789.8263052108505 05:04:01 INFO - PROCESS | 7893 | |1;ext.html;678.6267552845936;678.8370791010158;680.3876511139973;742.6583771465127;764.6520833020976;34128.31743365134;42302;42561.148777024515;42568.14863702724;42596.57403425965;45933.31100033502;46656.300155497695;46784.53215467853;46791.29813052807;46827.76586117073;7893.723719669812;7995.520268783892;8900.599473023729;9088.54557272137;10286.7428314292;10360.896391036105;10491.42297173655;10499.895001050007;10501.632442864502;10510.684679459628;10540.736481587945;10584.470776461185;10593.788124237512;10598.417087060208;10601.946990265076;8051.114377418479;10407.739806504822;10552.050315471644;10555.73610659732;10617.57529698811;10617.362958222531;10697.144228461704;10706.625268115578;10727.731806704816;10727.892721072845;40768.38847417291;41121.58878411238;41399.58600413988;41406.585934140574;41410.37884431736;3857.652811246973;3917.849923888914;3927.4501569780255;4003.97998010011;4027.8993025174314;35435.645643543496;35557.288854222774;35581.466278005595;35598.46602300968;35650.28699425997;4694.225452800284;4747.928781068286;4792.353032340624;4795.520447955177;4811.566958973709;340674;343164;345002;345467;346184;71043.2895671047;71146.64426677834;71607;71769.2823071773;71966.28033719701;74933.25066749372;74936;75316.62341688256;75324.72726909173;75560.62219688867;18291.176897039666;19418.320358787376;19641.803581964283;19653.803461965483;19666;14835.703285934436;15018.098914065191;15069.321880515403;15074.623134421727;15074.924625376803;21458.678119828215;21735.804530750644;21759.45601359947;21762.238321658984;21844.344669659935;7822.485147970667;8170.793885650841;8203.138670439637;8257.339412846957;8285.130061343592;1096.0354887698775;1151.1884121694186;1207.082617210926;1285.948562057526;1326.84741254755;34238;34605.82697086549;34816.30367392638;35002.672790987985;35438.82280588581;1219.8475190601175;1233.771752225841;1263.9304838233802;1282.2562913510142;1301.1412467771227;17707.73438398425;18330.816691833177;18403.26386944534;18557.44327670172;18684.53288667767;565949.6810063776;570274;570304;575744;576985;64927.350726493074;65314;65860.67069664621;65967.67016164889;65975.34024659787;1493.4623535526985;1504.4734342979868;1546.2037050918786;1604.3422196899214;1631.6410389714245;30494;30803.229919252197;31884.202894927814;32260.677393225767;32347;47558.762206188745;47931.76034119807;47993.120412775344;48117.75941120272;48169.759151204016;307097;313416;313718;313979;315783;28365.858170709016;31913.840430797696;31923;32234;32470.35059298848;44264.77867610641;45196.54803452055;50083.74958125186;50409.243861341376;50919.236211457595;39908;42247.57752422436;42851.78574107109;43301.35047974346;43880.78059609682;41536.79231603823;41897.581024190586;42134.15731685411;42410;43189.78405107954;42757.35863962105;43412.78293608512;43498.34752478652;43811.12377752491;43814.78092609517;35547.82226088853;37907.62092379151;38007.80996095002;38529.80735096306;38979.61020389873;29191.562126567693;29449;29474.705252948053;29520.066714272056;29969.70030299669 05:04:01 INFO - PROCESS | 7893 | |2;jquery.html;437.4968785896217;439.5867884188861;445.674657500025;446.56236887849906;454.02837926836577;19102.713459298106;19460.902695486522;19774.505637359074;20496.282630107948;21124.683129753026;19767.80232197681;19798.406047818553;20901.1332903413;21206.151753929826;21244.256451024215;5746.339170995337;6020.939790602104;6064.848378790543;6070.57505974582;6071.544634152434;4394.40675508807;5988.31134419543;6033.69831508425;6380.936190638104;6704.061431399584;6642.335766423344;6676.532642715012;6688.163979502562;6688.230853451867;6688.264290927994;6378.394052564999;6511.088447617338;6530.510211734091;6556.14770079889;6628.73485060597;3972.245273398045;5514.6139770216105;5737.995850726148;5822.679752613604;5823.941760582382;20621.793782062286;24395.26814195577;24534.509309813882;24573.38566535833;24907.377315567075;2575.1630720015883;2596.766291033816;2858.9285267868263;3009.3981203759117;3023.2744141406124;14917.850821491755;15129.773053404208;15296.617584560363;15509.689806203813;15799;1974.3188599933;2067.0388269454775;2077.8649387789746;2099.454141923111;2129.542148438093;82256.9999999994;82573.58713206396;85260;85672;85710.57144714298;11155.553777848796;11409;11551.711207219718;11620.418979051014;11651.184417090892;16348.75476867848;16373.754393684105;16476.917615412087;16521.421750238685;16589;9012.81974360509;9099.636014559343;9111.81776364469;9139.131782480654;9297.67458138962;8947.32895032875;9048.728538143867;9059.229965452878;9089.363744537952;9168.8997320322;7207.423406127497;7235.010372147702;7295.088113985752;7305.5981920994855;7314;1823.7473500683418;1963.59746252018;1970.8226259636701;2112.8837913914576;2117.6811391526253;1163.8245372173997;1179.6556761581014;1186.7270527778487;1202.7353982123918;1228.520876858026;18805.905970470332;19010.33463828787;19163.233470661016;19211.903940480486;19504;1090.8309212072143;1146.9483873225724;1155.820847768597;1182.5920057580122;1209.4255228766265;11898;11908.345041022654;11918.165728399103;11926.403679815974;11960.940195298968;539953;567931;580854;583614;592748;87010.56494717486;87088;88713.55643221743;90372.09627903768;91412;1145.5017067575632;1146.18620779246;1150.9539618415338;1154.7748189103213;1165.877582853805;17517.526020456622;17601.471955841345;18057.18742656557;18191;18458.35395761142;37721.81139094287;38252.2349553013;38385.23229535338;40227.19545609013;40683.796581016904;58715;58745.412545873995;58894.4110558906;59958;60318.698406509444;8804.515751633466;8846.071162527842;9142.405743626643;9282.535873206447;9417.670381536613;13071.215727056408;13507.729845403233;13698.246596437291;13718.657033573842;14015.159090454605;11593.884061159617;11808.586699465477;11840;11943.641690749291;11993.460294286604;11875.881241187477;11954.402279886144;12009.35922984637;12274.509019639472;12363.75272494563;12533.498660053861;12686.682832929251;12745.681357966125;12798.360081996048;12841.35793210317;9053.275737941081;9248.61270809384;9389.906100938902;9442.575084121094;9446.29152813528;9285.814283714422;12191.329476878502;12399;12501.499940002299;12647.114701970773 05:04:01 INFO - PROCESS | 7893 | |3;mootools.html;1425.8360288566819;1566.8198157211923;1586.6350739329953;1808.6021075363424;1925.1433112265047;8388.916110838889;8557.101504342048;8595;8606.440581362207;8608.22525972663;8469.872951905727;8626.913730862689;8647.610857511412;8648.394612377137;8675.392722509427;2162.816160626349;2365.9290221293345;2390.689210402645;2465.0386349323776;2528.153068721971;2406.518696260755;2443.51129774045;2445.058652418814;2448.2410452759614;2452.6934133233344;2462.963055554168;2500.6999160100813;2502.4995000999875;2506.636537702041;2508.122157244968;2070.0995067145764;2353.364591560278;2366.6923299971068;2383.570957227707;2393.4614711689906;2361.8346715729904;2366.372911178539;2380.6548050532747;2384.678068460753;2428.550718117154;8614.181652743042;8653.653853845839;8684.392092553524;8687.826243475096;8716.25911797498;5435.83692489222;5558.082916318803;5565.777368905239;5567.805126820583;5602;3775.848966041355;3820.083180036771;3860.1314704191614;3896.4544963705102;3921.5882332355263;1290.9935450322782;1294.3463550906827;1315.7960516120017;1324.2054767139734;1348.4269185596083;12449.377531123499;12495.18781279223;12496.81254781179;12532.624021279376;12620.116591838574;4966.975165124151;4988.152014157602;5037.798488060436;5062.063518249136;5110.642255042111;10674.839877401846;10728.678139655824;10794.892051079545;10814.243002989715;10817.56729730802;4793.32893394925;5672.914906276409;5675.602707810413;5679.290088738908;5691.174779656926;4369.978150109293;4965.255211718199;4980.203167493256;5031.094403007493;5035.345405097387;4184.895377615584;4196.769177695195;4244.257254980428;4279.037216626297;4290.37789520524;1322.8610995845297;1326.476041963419;1361.7548841208677;1373.6977864869712;1387.67389663429;871.8212766382876;931.6971984105193;1003.2926786615419;1069.4706120470416;1083.7399024234128;6281;6313.337099604567;6323.430891219812;6368.5860419072615;6498.772542960974;472.058243803614;483.20030349771184;484.2349088440256;484.4501490807958;506.9847904562869;4143.544210136883;4160.771157586361;4171.83312667496;4177.122804211089;4184.476940382452;10667.946660266649;10989.670309890716;11064.28082174656;11147.665570032912;11148.944255278671;10996.450177491093;10996.780064398827;11001.22991390611;11003.724906877233;11004.174686898514;8178.550179740052;8234.670613175525;8290.419670622998;8315.168483151758;8398.328133749163;6322.36776322364;6355.682215889279;6369.840753981002;6399.840003999937;6545.672716364067;9840;9856.457894815567;10148.13740832008;10153.441560714231;10176;10078.344907580984;10262.538185781508;10302.845457317997;10466.424346661006;10523.473826308807;7851.685932562862;7898.605069746375;7943.205679432242;8018.959905200437;8022.799430014296;8512.276456501268;8548.700795472128;8549.786255343417;8550.82898342042;8588;7711.0746710395115;7806.184392627529;8154.347652187692;8270.875936860832;8271.669133234604;7909.960450197712;7923.484973476706;7927.088384835818;8017.398695098008;8115;7073.82315442118;7118.145822501333;7156.033935418652;7163.140423149047;7289.052423184952;5279.128943724242;5303.74739694905;5537.5569954402745;5580.274564306615;5653.3216014076925;5512.503874651301;5588.273524441796;5621.409751975983;5694.743736531783;5748.913766293425 05:04:01 INFO - PROCESS | 7893 | |4;prototype.html;361.5679263280379;364.6007621654288;369.5177792980161;373.770131369208;377.3848626738416;6333.113364129025;6357.745690172394;6385.90421143682;6386.329435409279;6403.5197360197935;6102.786402475915;6135.417135372132;6248.125262463259;6251.468625166866;6334.176557047589;4906.582940450066;4936.777844996984;4938.432080310757;4941.901161976758;4969.4036715594175;4925.039617274633;4944.258361245806;4946.777395017233;4957.25641153828;4966.652334336598;4683.391159149306;4715.90568188636;4763.928541071887;4838.63710221733;4910.975445122769;4809.975950120262;4812.711237325771;4830.589399901012;4834.806607735686;4844.418669759616;4222.282212023963;4231.386448964914;4231.830726770925;4232.4286221360335;4250.851220207309;6069.848253793646;6073.605215660968;6077.17958075663;6081.209442772455;6082.482988945945;5597.776088956437;5603.3836278009385;5604.215409842625;5605.747741351649;5609.298837645294;6442.581232219891;6677.666116694146;6685.264620891698;6698.095757072831;6737.191537015589;4669.7665116744365;4680.859574212779;4687.20317546018;4689.50760170184;4696.530346965276;6971.372576468142;7048.577085374843;7055.047568578228;7059.647017649097;7063.505554611179;4764.6664733469015;4772.093302272557;4772.093302272557;4773.09311230865;4779.713217206979;4824.059308434821;4832.879178020507;4835.734034628129;4840.056189043103;4846.830360937421;5477.7261136943;5586.86032849182;5588.161775733673;5599.776008959678;5615.550755939515;6714.261431242559;6763.154605674291;6770.119884415093;6771.119754431991;6799.32006799326;1627.8453546913024;1686.65067945643;1701.3194722111255;1708.2483707168806;1709.9059551724774;1111.7832022755485;1131.4625552862324;1135.4095870147642;1139.9316041037564;1141.2182654881433;6448.355164483514;6507.869842603216;6514.739410423625;6528.771492997722;6532.150820393414;6909.930900691029;6964.756233531802;6965.965170174117;6982.755603553851;6984.79045628632;6576.901346479806;6577.934220657828;6582.17722784652;6587.901181482282;6590.5716128451495;3749.081475038633;3776.4146557283666;3787.5076240089165;3787.772733635991;3789.621037896188;7105.182903966007;7141.071660684078;7166.856662866713;7244.637768111574;7245.275472452712;7068.929310706827;7091.468139889529;7092.397146242524;7093.113360829896;7098.467614928798;7209.855802883913;7230.710771569078;7233.132024157135;7237.638118094074;7240.239774823673;6959.19969203548;6962.547434416747;6986;7046.189688185924;7048.400885924549;6738.199976221568;6792.626405547545;6849.794506164823;6850.6574671267235;6867.07294515234;7190.820229494305;7200.783976480714;7215.530990485601;7218.025566548448;7222.458315626454;4760.428748550196;4786.3777708899015;4797.688150270221;4805.038992201644;4805.783739731651;6906.585604863724;6910.101686780687;6910.861782764216;6925.961105834165;6927.134108236471;6545.345465453607;6666.866662666816;6724.025016372696;6743.258241593323;6808.080909077211;6700.363465470772;6721.294264102395;6723.5293529452465;6752.08846805675;6851.212110607344;6718.832029199114;6721.731130754911;6729.0915726376315;6729.192496900403;6737.59574425536;6793.660316984032;6830.726770929107;6897.3447522485285;6899.310068993262;6905.827354316182;6687.699053542505;6700.229473610402;6708.8993665094085;6722.630255336004;6723.831904202239 05:04:01 INFO - PROCESS | 7893 | |5;yui.html;797.1828875402712;815.7022686719346;822.2887202569779;855.7946092937694;902.9638814447421;15409;15667.608309792247;15681.764773528377;15706.685866282682;15717;14702.264886755645;14744.926275368634;14746.115233086022;14759.11445313282;14783.778243326358;730.5105579261894;899.0335389456328;920.6685593186447;922.3451349541833;925.7361651929201;918.1277786103195;923.1322556796623;925.4031149908305;926.666400095965;926.8563372677246;977.7408986618552;979.3487330924927;979.7256768104942;980.2696990741907;980.7204946590223;782.9412794040442;947.3794664494767;965.034965034965;969.2391472693937;970.3450171134526;711.3775446484326;711.8006958051753;712.0423031023265;712.1205311440367;712.4834494991142;15199.392024319013;15205.163715995615;15275.923620381938;15299.464518741903;15304.540863774104;14787.630309242355;15149.772753408708;15233.238338083162;15291.770623440547;15788.526344209693;11880.392740255927;11946;12024.819627705592;12116.575919842851;12253.203541769757;4099.508059032905;4115.464989551339;4165.396017577435;4187.72779769314;4309.267424537836;59021.11468328021;59207.40792592062;59881.700591497196;60692.393076069115;60795.39204607942;11395.373254470918;11399.886001140048;11475.942620287013;11740.119491038036;11742.941285293518;20899.582008359746;20937.26719564808;20948;20981.89509052445;20983.37049888506;8446.915530844735;8472.915270847336;8552.743417697478;8618.698345557876;8871.245944094695;4942.505749425029;5028.421731500851;5097.057044446789;5155.407128180233;5162.1224391853475;3586.605473397924;3641.326354624403;3652;3657.4148136298063;3658.5609726832417;677.5629718831326;681.151965802579;699.566268913277;703.9120109986252;703.9225685174627;653.3466533466534;773.9574323412154;794.2256300107465;800.5556915911725;816.1104396208161;9428.717138485856;9489.478078705599;9500.762480937894;9507.619695212114;9966.596020310362;762.1958833430673;805.5408417202138;807.8909347238165;808.8907997420273;825.3356048381111;4607.124646317189;4682.438107427062;4733.313669517901;4776.331313616097;4838.7338696372035;66153;67333.66333168303;67689.66155169193;69589.30410695828;70169.64915175493;61191;61311.38688613057;62399.6880015597;62556.68721656362;62559.37440625626;53046.469535304925;53857.46142538603;54314.45685543094;54346.72826635841;55229.44770552243;10095.141912937483;10150.390976541432;10190.082892539707;10217.1826253901;10255.435951022766;39145;39636;39769.40345894872;42377.78811105925;42813.785931070146;49998.750006249735;50226.24660630021;53881.46118538921;54710;54865.177022345495;13051.728323499003;13115.08194426381;13150.408231629408;13454.529091482143;13479.595612131652;14205.147691138565;14261.786073208703;14881.47914822976;15321.693566128837;15637.609059773597;13111.67220819449;14048.297585120907;14276.643083922985;14415;14561.053531520418;13908.582742517741;13919.721605567629;13955.372008259856;14180.858191418367;14460.927695361455;13508.729825403634;14016.369263382969;14203.573892783234;14221.786673200117;14279.64300892486;11236.381998989807;11546.42267886619;11735.23720958135;12120.818187727367;12157.69605759863;10959.452027398758;11161.720956975816;11603.361815099914;11704.765904682028;11720.824187637021 05:04:01 INFO - PROCESS | 7893 | __end_tp_report 05:04:01 INFO - PROCESS | 7893 | __start_cc_report 05:04:01 INFO - PROCESS | 7893 | _x_x_mozilla_cycle_collect,913 05:04:01 INFO - PROCESS | 7893 | __end_cc_report 05:04:01 INFO - PROCESS | 7893 | __startTimestamp1463659441280__endTimestamp 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | ------- Summary: start ------- 05:04:01 INFO - PROCESS | 7893 | Number of tests: 6 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#0] dojo.html Cycles:165 Average:5624.54 Median:5795.25 stddev:633.54 (10.9%) stddev-sans-first:609.71 05:04:01 INFO - PROCESS | 7893 | Values: 3344.5 3428.1 3440.1 3457.4 3473.2 5681.6 5689.8 5694.9 5696.3 5698.6 5681.9 5705.9 5716.1 5716.4 5720.9 4911.7 5159.5 5268.4 5307.9 5331.1 5088.0 5133.3 5133.9 5134.2 5134.2 5127.5 5136.4 5183.7 5205.9 5207.1 5206.6 5290.9 5291.6 5300.3 5320.4 4996.1 5027.9 5095.3 5176.6 5185.9 5469.9 5490.5 5527.4 5537.3 5539.3 5979.3 5982.5 5991.2 5993.6 5999.7 5964.1 6036.6 6046.0 6060.5 6076.8 5691.1 5736.4 5756.8 5767.5 5776.0 6067.5 6252.6 6267.5 6271.0 6289.4 5952.6 6010.2 6013.4 6014.1 6033.3 6040.1 6041.2 6049.2 6050.6 6050.6 5817.5 6012.1 6016.7 6027.9 6038.4 6046.1 6055.0 6056.6 6057.4 6095.3 4585.1 4589.1 4590.0 4591.1 4620.3 3965.9 4080.8 4113.8 4132.2 4134.9 5774.3 5797.2 5799.4 5801.4 5801.8 6067.5 6104.6 6125.5 6130.5 6130.9 5608.4 5640.1 5764.8 5771.0 5788.6 5022.1 5034.5 5049.7 5050.1 5058.2 6318.4 6335.8 6339.9 6343.3 6363.7 5876.7 6062.8 6128.2 6133.9 6143.3 6315.1 6335.3 6359.1 6360.3 6363.1 5771.0 6012.2 6023.1 6032.9 6033.5 6078.9 6144.4 6154.4 6158.6 6159.7 5809.4 5851.8 5859.2 5892.4 5921.1 5689.6 5795.2 5843.7 5856.6 5938.5 5769.2 5773.0 5774.2 5779.6 5815.6 5846.1 5879.7 5885.3 5906.1 5914.5 5642.3 5721.9 5729.2 5745.3 5789.8 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#1] ext.html Cycles:180 Average:59479.15 Median:35624.38 stddev:112792.83 (316.6%) stddev-sans-first:113022.84 05:04:01 INFO - PROCESS | 7893 | Values: 678.6 678.8 680.4 742.7 764.7 34128.3 42302.0 42561.1 42568.1 42596.6 45933.3 46656.3 46784.5 46791.3 46827.8 7893.7 7995.5 8900.6 9088.5 10286.7 10360.9 10491.4 10499.9 10501.6 10510.7 10540.7 10584.5 10593.8 10598.4 10601.9 8051.1 10407.7 10552.1 10555.7 10617.6 10617.4 10697.1 10706.6 10727.7 10727.9 40768.4 41121.6 41399.6 41406.6 41410.4 3857.7 3917.8 3927.5 4004.0 4027.9 35435.6 35557.3 35581.5 35598.5 35650.3 4694.2 4747.9 4792.4 4795.5 4811.6 340674.0 343164.0 345002.0 345467.0 346184.0 71043.3 71146.6 71607.0 71769.3 71966.3 74933.3 74936.0 75316.6 75324.7 75560.6 18291.2 19418.3 19641.8 19653.8 19666.0 14835.7 15018.1 15069.3 15074.6 15074.9 21458.7 21735.8 21759.5 21762.2 21844.3 7822.5 8170.8 8203.1 8257.3 8285.1 1096.0 1151.2 1207.1 1285.9 1326.8 34238.0 34605.8 34816.3 35002.7 35438.8 1219.8 1233.8 1263.9 1282.3 1301.1 17707.7 18330.8 18403.3 18557.4 18684.5 565949.7 570274.0 570304.0 575744.0 576985.0 64927.4 65314.0 65860.7 65967.7 65975.3 1493.5 1504.5 1546.2 1604.3 1631.6 30494.0 30803.2 31884.2 32260.7 32347.0 47558.8 47931.8 47993.1 48117.8 48169.8 307097.0 313416.0 313718.0 313979.0 315783.0 28365.9 31913.8 31923.0 32234.0 32470.4 44264.8 45196.5 50083.7 50409.2 50919.2 39908.0 42247.6 42851.8 43301.4 43880.8 41536.8 41897.6 42134.2 42410.0 43189.8 42757.4 43412.8 43498.3 43811.1 43814.8 35547.8 37907.6 38007.8 38529.8 38979.6 29191.6 29449.0 29474.7 29520.1 29969.7 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#2] jquery.html Cycles:180 Average:31903.54 Median:24464.89 stddev:94002.31 (384.2%) stddev-sans-first:94236.32 05:04:01 INFO - PROCESS | 7893 | Values: 437.5 439.6 445.7 446.6 454.0 19102.7 19460.9 19774.5 20496.3 21124.7 19767.8 19798.4 20901.1 21206.2 21244.3 5746.3 6020.9 6064.8 6070.6 6071.5 4394.4 5988.3 6033.7 6380.9 6704.1 6642.3 6676.5 6688.2 6688.2 6688.3 6378.4 6511.1 6530.5 6556.1 6628.7 3972.2 5514.6 5738.0 5822.7 5823.9 20621.8 24395.3 24534.5 24573.4 24907.4 2575.2 2596.8 2858.9 3009.4 3023.3 14917.9 15129.8 15296.6 15509.7 15799.0 1974.3 2067.0 2077.9 2099.5 2129.5 82257.0 82573.6 85260.0 85672.0 85710.6 11155.6 11409.0 11551.7 11620.4 11651.2 16348.8 16373.8 16476.9 16521.4 16589.0 9012.8 9099.6 9111.8 9139.1 9297.7 8947.3 9048.7 9059.2 9089.4 9168.9 7207.4 7235.0 7295.1 7305.6 7314.0 1823.7 1963.6 1970.8 2112.9 2117.7 1163.8 1179.7 1186.7 1202.7 1228.5 18805.9 19010.3 19163.2 19211.9 19504.0 1090.8 1146.9 1155.8 1182.6 1209.4 11898.0 11908.3 11918.2 11926.4 11960.9 539953.0 567931.0 580854.0 583614.0 592748.0 87010.6 87088.0 88713.6 90372.1 91412.0 1145.5 1146.2 1151.0 1154.8 1165.9 17517.5 17601.5 18057.2 18191.0 18458.4 37721.8 38252.2 38385.2 40227.2 40683.8 58715.0 58745.4 58894.4 59958.0 60318.7 8804.5 8846.1 9142.4 9282.5 9417.7 13071.2 13507.7 13698.2 13718.7 14015.2 11593.9 11808.6 11840.0 11943.6 11993.5 11875.9 11954.4 12009.4 12274.5 12363.8 12533.5 12686.7 12745.7 12798.4 12841.4 9053.3 9248.6 9389.9 9442.6 9446.3 9285.8 12191.3 12399.0 12501.5 12647.1 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#3] mootools.html Cycles:180 Average:5954.26 Median:484.34 stddev:3313.38 (684.1%) stddev-sans-first:3305.20 05:04:01 INFO - PROCESS | 7893 | Values: 1425.8 1566.8 1586.6 1808.6 1925.1 8388.9 8557.1 8595.0 8606.4 8608.2 8469.9 8626.9 8647.6 8648.4 8675.4 2162.8 2365.9 2390.7 2465.0 2528.2 2406.5 2443.5 2445.1 2448.2 2452.7 2463.0 2500.7 2502.5 2506.6 2508.1 2070.1 2353.4 2366.7 2383.6 2393.5 2361.8 2366.4 2380.7 2384.7 2428.6 8614.2 8653.7 8684.4 8687.8 8716.3 5435.8 5558.1 5565.8 5567.8 5602.0 3775.8 3820.1 3860.1 3896.5 3921.6 1291.0 1294.3 1315.8 1324.2 1348.4 12449.4 12495.2 12496.8 12532.6 12620.1 4967.0 4988.2 5037.8 5062.1 5110.6 10674.8 10728.7 10794.9 10814.2 10817.6 4793.3 5672.9 5675.6 5679.3 5691.2 4370.0 4965.3 4980.2 5031.1 5035.3 4184.9 4196.8 4244.3 4279.0 4290.4 1322.9 1326.5 1361.8 1373.7 1387.7 871.8 931.7 1003.3 1069.5 1083.7 6281.0 6313.3 6323.4 6368.6 6498.8 472.1 483.2 484.2 484.5 507.0 4143.5 4160.8 4171.8 4177.1 4184.5 10667.9 10989.7 11064.3 11147.7 11148.9 10996.5 10996.8 11001.2 11003.7 11004.2 8178.6 8234.7 8290.4 8315.2 8398.3 6322.4 6355.7 6369.8 6399.8 6545.7 9840.0 9856.5 10148.1 10153.4 10176.0 10078.3 10262.5 10302.8 10466.4 10523.5 7851.7 7898.6 7943.2 8019.0 8022.8 8512.3 8548.7 8549.8 8550.8 8588.0 7711.1 7806.2 8154.3 8270.9 8271.7 7910.0 7923.5 7927.1 8017.4 8115.0 7073.8 7118.1 7156.0 7163.1 7289.1 5279.1 5303.7 5537.6 5580.3 5653.3 5512.5 5588.3 5621.4 5694.7 5748.9 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#4] prototype.html Cycles:180 Average:5647.74 Median:6445.47 stddev:1703.00 (26.4%) stddev-sans-first:1660.91 05:04:01 INFO - PROCESS | 7893 | Values: 361.6 364.6 369.5 373.8 377.4 6333.1 6357.7 6385.9 6386.3 6403.5 6102.8 6135.4 6248.1 6251.5 6334.2 4906.6 4936.8 4938.4 4941.9 4969.4 4925.0 4944.3 4946.8 4957.3 4966.7 4683.4 4715.9 4763.9 4838.6 4911.0 4810.0 4812.7 4830.6 4834.8 4844.4 4222.3 4231.4 4231.8 4232.4 4250.9 6069.8 6073.6 6077.2 6081.2 6082.5 5597.8 5603.4 5604.2 5605.7 5609.3 6442.6 6677.7 6685.3 6698.1 6737.2 4669.8 4680.9 4687.2 4689.5 4696.5 6971.4 7048.6 7055.0 7059.6 7063.5 4764.7 4772.1 4772.1 4773.1 4779.7 4824.1 4832.9 4835.7 4840.1 4846.8 5477.7 5586.9 5588.2 5599.8 5615.6 6714.3 6763.2 6770.1 6771.1 6799.3 1627.8 1686.7 1701.3 1708.2 1709.9 1111.8 1131.5 1135.4 1139.9 1141.2 6448.4 6507.9 6514.7 6528.8 6532.2 6909.9 6964.8 6966.0 6982.8 6984.8 6576.9 6577.9 6582.2 6587.9 6590.6 3749.1 3776.4 3787.5 3787.8 3789.6 7105.2 7141.1 7166.9 7244.6 7245.3 7068.9 7091.5 7092.4 7093.1 7098.5 7209.9 7230.7 7233.1 7237.6 7240.2 6959.2 6962.5 6986.0 7046.2 7048.4 6738.2 6792.6 6849.8 6850.7 6867.1 7190.8 7200.8 7215.5 7218.0 7222.5 4760.4 4786.4 4797.7 4805.0 4805.8 6906.6 6910.1 6910.9 6926.0 6927.1 6545.3 6666.9 6724.0 6743.3 6808.1 6700.4 6721.3 6723.5 6752.1 6851.2 6718.8 6721.7 6729.1 6729.2 6737.6 6793.7 6830.7 6897.3 6899.3 6905.8 6687.7 6700.2 6708.9 6722.6 6723.8 05:04:01 INFO - PROCESS | 7893 | 05:04:01 INFO - PROCESS | 7893 | [#5] yui.html Cycles:180 Average:16394.46 Median:4644.78 stddev:19095.02 (411.1%) stddev-sans-first:19112.66 05:04:01 INFO - PROCESS | 7893 | Values: 797.2 815.7 822.3 855.8 903.0 15409.0 15667.6 15681.8 15706.7 15717.0 14702.3 14744.9 14746.1 14759.1 14783.8 730.5 899.0 920.7 922.3 925.7 918.1 923.1 925.4 926.7 926.9 977.7 979.3 979.7 980.3 980.7 782.9 947.4 965.0 969.2 970.3 711.4 711.8 712.0 712.1 712.5 15199.4 15205.2 15275.9 15299.5 15304.5 14787.6 15149.8 15233.2 15291.8 15788.5 11880.4 11946.0 12024.8 12116.6 12253.2 4099.5 4115.5 4165.4 4187.7 4309.3 59021.1 59207.4 59881.7 60692.4 60795.4 11395.4 11399.9 11475.9 11740.1 11742.9 20899.6 20937.3 20948.0 20981.9 20983.4 8446.9 8472.9 8552.7 8618.7 8871.2 4942.5 5028.4 5097.1 5155.4 5162.1 3586.6 3641.3 3652.0 3657.4 3658.6 677.6 681.2 699.6 703.9 703.9 653.3 774.0 794.2 800.6 816.1 9428.7 9489.5 9500.8 9507.6 9966.6 762.2 805.5 807.9 808.9 825.3 4607.1 4682.4 4733.3 4776.3 4838.7 66153.0 67333.7 67689.7 69589.3 70169.6 61191.0 61311.4 62399.7 62556.7 62559.4 53046.5 53857.5 54314.5 54346.7 55229.4 10095.1 10150.4 10190.1 10217.2 10255.4 39145.0 39636.0 39769.4 42377.8 42813.8 49998.8 50226.2 53881.5 54710.0 54865.2 13051.7 13115.1 13150.4 13454.5 13479.6 14205.1 14261.8 14881.5 15321.7 15637.6 13111.7 14048.3 14276.6 14415.0 14561.1 13908.6 13919.7 13955.4 14180.9 14460.9 13508.7 14016.4 14203.6 14221.8 14279.6 11236.4 11546.4 11735.2 12120.8 12157.7 10959.5 11161.7 11603.4 11704.8 11720.8 05:04:01 INFO - PROCESS | 7893 | -------- Summary: end -------- 05:04:01 INFO - PROCESS | 7893 | 05:04:02 INFO - TEST-INFO | 7893: exit 0 05:04:02 INFO - TEST-OK | dromaeo_css | took 1113816ms 05:04:02 INFO - TEST-START | kraken 05:04:02 INFO - operating with platform_type : linux_ 05:04:02 INFO - Initialising browser for kraken test... 05:04:02 INFO - TEST-INFO | started process 8081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwETM8u/profile http://localhost:49300/getInfo.html) 05:04:07 INFO - PROCESS | 8081 | __metrics Screen width/height:1600/1200 05:04:07 INFO - PROCESS | 8081 | colorDepth:24 05:04:07 INFO - PROCESS | 8081 | Browser inner width/height: 1024/697 05:04:07 INFO - PROCESS | 8081 | __metrics 05:04:08 ERROR - PROCESS | 8081 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:04:09 INFO - TEST-INFO | 8081: exit 0 05:04:09 INFO - Browser initialized. 05:04:09 INFO - Running cycle 1/1 for kraken test... 05:04:09 INFO - TEST-INFO | started process 8172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwETM8u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:21 INFO - PROCESS | 8172 | RSS: Main: 142000128 05:04:21 INFO - PROCESS | 8172 | 05:04:23 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49300/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:24 INFO - PROCESS | 8172 | RSS: Main: 197160960 05:04:24 INFO - PROCESS | 8172 | 05:04:27 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49300/tests/kraken/driver.html?testName=audio-dft) 05:04:27 INFO - PROCESS | 8172 | RSS: Main: 182132736 05:04:27 INFO - PROCESS | 8172 | 05:04:30 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49300/tests/kraken/driver.html?testName=audio-fft) 05:04:31 INFO - PROCESS | 8172 | RSS: Main: 272908288 05:04:31 INFO - PROCESS | 8172 | 05:04:33 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49300/tests/kraken/driver.html?testName=audio-oscillator) 05:04:33 INFO - PROCESS | 8172 | RSS: Main: 179200000 05:04:33 INFO - PROCESS | 8172 | 05:04:36 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:36 INFO - PROCESS | 8172 | RSS: Main: 177246208 05:04:36 INFO - PROCESS | 8172 | 05:04:39 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49300/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:40 INFO - PROCESS | 8172 | RSS: Main: 212504576 05:04:40 INFO - PROCESS | 8172 | 05:04:43 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49300/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:44 INFO - PROCESS | 8172 | RSS: Main: 212885504 05:04:44 INFO - PROCESS | 8172 | 05:04:46 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49300/tests/kraken/driver.html?testName=json-parse-financial) 05:04:47 INFO - PROCESS | 8172 | RSS: Main: 213073920 05:04:47 INFO - PROCESS | 8172 | 05:04:49 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:49 INFO - PROCESS | 8172 | RSS: Main: 190705664 05:04:49 INFO - PROCESS | 8172 | 05:04:51 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:51 INFO - PROCESS | 8172 | RSS: Main: 195424256 05:04:51 INFO - PROCESS | 8172 | 05:04:53 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:54 INFO - PROCESS | 8172 | RSS: Main: 210898944 05:04:54 INFO - PROCESS | 8172 | 05:04:56 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:57 INFO - PROCESS | 8172 | RSS: Main: 214175744 05:04:57 INFO - PROCESS | 8172 | 05:05:00 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:00 INFO - PROCESS | 8172 | RSS: Main: 211734528 05:05:00 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | Cycle 1(1): loaded http://localhost:49300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49300/tests/kraken/driver.html?testName=ai-astar) 05:05:02 INFO - PROCESS | 8172 | RSS: Main: 276156416 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | __start_tp_report 05:05:02 INFO - PROCESS | 8172 | _x_x_mozilla_page_load 05:05:02 INFO - PROCESS | 8172 | _x_x_mozilla_page_load_details 05:05:02 INFO - PROCESS | 8172 | |i|pagename|runs| 05:05:02 INFO - PROCESS | 8172 | |0;ai-astar;111;110;111;109;110;110;105;109;109;109 05:05:02 INFO - PROCESS | 8172 | |1;audio-beat-detection;161;128;152;169;129;151;158;129;187;127 05:05:02 INFO - PROCESS | 8172 | |2;audio-dft;161;161;165;160;161;161;162;160;162;160 05:05:02 INFO - PROCESS | 8172 | |3;audio-fft;76;76;76;186;77;76;76;76;154;79 05:05:02 INFO - PROCESS | 8172 | |4;audio-oscillator;92;93;164;92;92;92;147;92;93;141 05:05:02 INFO - PROCESS | 8172 | |5;imaging-gaussian-blur;116;116;116;117;116;117;117;117;116;117 05:05:02 INFO - PROCESS | 8172 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 05:05:02 INFO - PROCESS | 8172 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 05:05:02 INFO - PROCESS | 8172 | |8;json-parse-financial;53;57;55;52;53;53;54;72;53;52 05:05:02 INFO - PROCESS | 8172 | |9;json-stringify-tinderbox;59;60;59;58;59;58;58;59;58;58 05:05:02 INFO - PROCESS | 8172 | |10;stanford-crypto-aes;72;72;73;73;73;73;74;72;72;74 05:05:02 INFO - PROCESS | 8172 | |11;stanford-crypto-ccm;121;111;113;114;114;113;112;113;127;130 05:05:02 INFO - PROCESS | 8172 | |12;stanford-crypto-pbkdf2;163;174;161;160;173;170;165;166;158;159 05:05:02 INFO - PROCESS | 8172 | |13;stanford-crypto-sha256-iterative;64;66;72;65;65;66;63;66;66;65 05:05:02 INFO - PROCESS | 8172 | __end_tp_report 05:05:02 INFO - PROCESS | 8172 | __start_cc_report 05:05:02 INFO - PROCESS | 8172 | _x_x_mozilla_cycle_collect,1596 05:05:02 INFO - PROCESS | 8172 | __end_cc_report 05:05:02 INFO - PROCESS | 8172 | __startTimestamp1463659502767__endTimestamp 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | ------- Summary: start ------- 05:05:02 INFO - PROCESS | 8172 | Number of tests: 14 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.70 (1.5%) stddev-sans-first:1.69 05:05:02 INFO - PROCESS | 8172 | Values: 111.0 110.0 111.0 109.0 110.0 110.0 105.0 109.0 109.0 109.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:20.57 (13.3%) stddev-sans-first:21.36 05:05:02 INFO - PROCESS | 8172 | Values: 161.0 128.0 152.0 169.0 129.0 151.0 158.0 129.0 187.0 127.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 05:05:02 INFO - PROCESS | 8172 | Values: 161.0 161.0 165.0 160.0 161.0 161.0 162.0 160.0 162.0 160.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:40.15 (52.8%) stddev-sans-first:41.98 05:05:02 INFO - PROCESS | 8172 | Values: 76.0 76.0 76.0 186.0 77.0 76.0 76.0 76.0 154.0 79.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.76 (31.3%) stddev-sans-first:29.77 05:05:02 INFO - PROCESS | 8172 | Values: 92.0 93.0 164.0 92.0 92.0 92.0 147.0 92.0 93.0 141.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:05:02 INFO - PROCESS | 8172 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:05:02 INFO - PROCESS | 8172 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:05:02 INFO - PROCESS | 8172 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:53.50 stddev:6.02 (11.3%) stddev-sans-first:6.32 05:05:02 INFO - PROCESS | 8172 | Values: 53.0 57.0 55.0 52.0 53.0 53.0 54.0 72.0 53.0 52.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 05:05:02 INFO - PROCESS | 8172 | Values: 59.0 60.0 59.0 58.0 59.0 58.0 58.0 59.0 58.0 58.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 05:05:02 INFO - PROCESS | 8172 | Values: 72.0 72.0 73.0 73.0 73.0 73.0 74.0 72.0 72.0 74.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:114.00 stddev:6.76 (5.9%) stddev-sans-first:7.00 05:05:02 INFO - PROCESS | 8172 | Values: 121.0 111.0 113.0 114.0 114.0 113.0 112.0 113.0 127.0 130.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:5.78 (3.5%) stddev-sans-first:6.09 05:05:02 INFO - PROCESS | 8172 | Values: 163.0 174.0 161.0 160.0 173.0 170.0 165.0 166.0 158.0 159.0 05:05:02 INFO - PROCESS | 8172 | 05:05:02 INFO - PROCESS | 8172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.39 (3.6%) stddev-sans-first:2.45 05:05:02 INFO - PROCESS | 8172 | Values: 64.0 66.0 72.0 65.0 65.0 66.0 63.0 66.0 66.0 65.0 05:05:02 INFO - PROCESS | 8172 | -------- Summary: end -------- 05:05:02 INFO - PROCESS | 8172 | 05:05:03 INFO - TEST-INFO | 8172: exit 0 05:05:03 INFO - TEST-OK | kraken | took 61786ms 05:05:03 INFO - SUITE-END | took 1175s 05:05:03 INFO - Completed test suite (00:19:35) 05:05:03 INFO - javascript benchmark 05:05:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.5150453184287, 3428.0744199066253, 3440.088376580205, 3457.429524128519, 3473.166440054386, 5681.602287839853, 5689.833584115257, 5694.943050569493, 5696.316442026952, 5698.629589076712, 5681.948839464702, 5705.914411283824, 5716.056850619653, 5716.428357164282, 5720.8855822883625, 4911.656184067117, 5159.509846564571, 5268.420473747885, 5307.920381194285, 5331.093714068617, 5088.007838471481, 5133.3326667533165, 5133.948660513403, 5134.178531434971, 5134.204198349262, 5127.538521533062, 5136.409312929005, 5183.740812959337, 5205.86985325368, 5207.088759467097, 5206.557442617382, 5290.867728306785, 5291.603129765283, 5300.337457817773, 5320.408724111209, 4996.050750357457, 5027.874303142414, 5095.31213286209, 5176.5858731301405, 5185.896282074337, 5469.917951230735, 5490.533304669108, 5527.447255274481, 5537.280153580049, 5539.335279766414, 5979.252593425822, 5982.521398288127, 5991.161237426763, 5993.61041532299, 5999.6700181490005, 5964.105384192362, 6036.637801731867, 6045.969770151165, 6060.515158787331, 6076.756929722806, 5691.06097493913, 5736.397678243766, 5756.769729210827, 5767.452092051249, 5775.971120144372, 6067.514598832083, 6252.624842509464, 6267.5299352548745, 6270.968645156836, 6289.371062893765, 5952.5833191676165, 6010.2186715726675, 6013.428724271187, 6014.097885317237, 6033.276006879202, 6040.09398590215, 6041.154238406627, 6049.1833602463985, 6050.576459647782, 6050.576459647782, 5817.50551203144, 6012.128241404972, 6016.69916504173, 6027.9095813562835, 6038.396160384014, 6046.093086037042, 6054.969725151346, 6056.576039677268, 6057.3639767824625, 6095.299040610298, 4585.060062687141, 4589.059242855206, 4590.0, 4591.104734576792, 4620.330052142488, 3965.940510892339, 4080.8367665293054, 4113.773742444135, 4132.152908653718, 4134.91730165395, 5774.307083150049, 5797.217375654317, 5799.420057994167, 5801.390853960358, 5801.82594522165, 6067.453929146398, 6104.572679912452, 6125.479334256549, 6130.47890929276, 6130.877382452326, 5608.383077861432, 5640.0693885508435, 5764.798232061858, 5770.971145144332, 5788.565857560699, 5022.070916880389, 5034.521720436553, 5049.671771334852, 5050.141475949097, 5058.190689489664, 6318.4313411793155, 6335.809925702236, 6339.936600634027, 6343.333949935282, 6363.713632886531, 5876.676782776988, 6062.848428789315, 6128.228138398679, 6133.8855759873895, 6143.266246520256, 6315.052742088724, 6335.303116657256, 6359.07793369968, 6360.300366959723, 6363.109164717036, 5770.971145144247, 6012.188354572077, 6023.096535519532, 6032.939670603238, 6033.487153591994, 6078.90881636767, 6144.385561443999, 6154.446099851035, 6158.599691020069, 6159.72281247336, 5809.448102430262, 5851.765929362778, 5859.150423188528, 5892.35184129754, 5921.14143449206, 5689.630174038674, 5795.246617939641, 5843.678597676999, 5856.59003869725, 5938.495227905503, 5769.221155144001, 5773.0, 5774.220480235114, 5779.566532510163, 5815.592908496534, 5846.093855452412, 5879.676617786063, 5885.293764748258, 5906.114082887601, 5914.497267732118, 5642.2665053544415, 5721.8569535761935, 5729.197912292199, 5745.339285982165, 5789.8263052108505], "value": 5583.087716615611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.6267552845936, 678.8370791010158, 680.3876511139973, 742.6583771465127, 764.6520833020976, 34128.31743365134, 42302.0, 42561.148777024515, 42568.14863702724, 42596.57403425965, 45933.31100033502, 46656.300155497695, 46784.53215467853, 46791.29813052807, 46827.76586117073, 7893.723719669812, 7995.520268783892, 8900.599473023729, 9088.54557272137, 10286.7428314292, 10360.896391036105, 10491.42297173655, 10499.895001050007, 10501.632442864502, 10510.684679459628, 10540.736481587945, 10584.470776461185, 10593.788124237512, 10598.417087060208, 10601.946990265076, 8051.114377418479, 10407.739806504822, 10552.050315471644, 10555.73610659732, 10617.57529698811, 10617.362958222531, 10697.144228461704, 10706.625268115578, 10727.731806704816, 10727.892721072845, 40768.38847417291, 41121.58878411238, 41399.58600413988, 41406.585934140574, 41410.37884431736, 3857.652811246973, 3917.849923888914, 3927.4501569780255, 4003.97998010011, 4027.8993025174314, 35435.645643543496, 35557.288854222774, 35581.466278005595, 35598.46602300968, 35650.28699425997, 4694.225452800284, 4747.928781068286, 4792.353032340624, 4795.520447955177, 4811.566958973709, 340674.0, 343164.0, 345002.0, 345467.0, 346184.0, 71043.2895671047, 71146.64426677834, 71607.0, 71769.2823071773, 71966.28033719701, 74933.25066749372, 74936.0, 75316.62341688256, 75324.72726909173, 75560.62219688867, 18291.176897039666, 19418.320358787376, 19641.803581964283, 19653.803461965483, 19666.0, 14835.703285934436, 15018.098914065191, 15069.321880515403, 15074.623134421727, 15074.924625376803, 21458.678119828215, 21735.804530750644, 21759.45601359947, 21762.238321658984, 21844.344669659935, 7822.485147970667, 8170.793885650841, 8203.138670439637, 8257.339412846957, 8285.130061343592, 1096.0354887698775, 1151.1884121694186, 1207.082617210926, 1285.948562057526, 1326.84741254755, 34238.0, 34605.82697086549, 34816.30367392638, 35002.672790987985, 35438.82280588581, 1219.8475190601175, 1233.771752225841, 1263.9304838233802, 1282.2562913510142, 1301.1412467771227, 17707.73438398425, 18330.816691833177, 18403.26386944534, 18557.44327670172, 18684.53288667767, 565949.6810063776, 570274.0, 570304.0, 575744.0, 576985.0, 64927.350726493074, 65314.0, 65860.67069664621, 65967.67016164889, 65975.34024659787, 1493.4623535526985, 1504.4734342979868, 1546.2037050918786, 1604.3422196899214, 1631.6410389714245, 30494.0, 30803.229919252197, 31884.202894927814, 32260.677393225767, 32347.0, 47558.762206188745, 47931.76034119807, 47993.120412775344, 48117.75941120272, 48169.759151204016, 307097.0, 313416.0, 313718.0, 313979.0, 315783.0, 28365.858170709016, 31913.840430797696, 31923.0, 32234.0, 32470.35059298848, 44264.77867610641, 45196.54803452055, 50083.74958125186, 50409.243861341376, 50919.236211457595, 39908.0, 42247.57752422436, 42851.78574107109, 43301.35047974346, 43880.78059609682, 41536.79231603823, 41897.581024190586, 42134.15731685411, 42410.0, 43189.78405107954, 42757.35863962105, 43412.78293608512, 43498.34752478652, 43811.12377752491, 43814.78092609517, 35547.82226088853, 37907.62092379151, 38007.80996095002, 38529.80735096306, 38979.61020389873, 29191.562126567693, 29449.0, 29474.705252948053, 29520.066714272056, 29969.70030299669], "value": 21712.49004501045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.4968785896217, 439.5867884188861, 445.674657500025, 446.56236887849906, 454.02837926836577, 19102.713459298106, 19460.902695486522, 19774.505637359074, 20496.282630107948, 21124.683129753026, 19767.80232197681, 19798.406047818553, 20901.1332903413, 21206.151753929826, 21244.256451024215, 5746.339170995337, 6020.939790602104, 6064.848378790543, 6070.57505974582, 6071.544634152434, 4394.40675508807, 5988.31134419543, 6033.69831508425, 6380.936190638104, 6704.061431399584, 6642.335766423344, 6676.532642715012, 6688.163979502562, 6688.230853451867, 6688.264290927994, 6378.394052564999, 6511.088447617338, 6530.510211734091, 6556.14770079889, 6628.73485060597, 3972.245273398045, 5514.6139770216105, 5737.995850726148, 5822.679752613604, 5823.941760582382, 20621.793782062286, 24395.26814195577, 24534.509309813882, 24573.38566535833, 24907.377315567075, 2575.1630720015883, 2596.766291033816, 2858.9285267868263, 3009.3981203759117, 3023.2744141406124, 14917.850821491755, 15129.773053404208, 15296.617584560363, 15509.689806203813, 15799.0, 1974.3188599933, 2067.0388269454775, 2077.8649387789746, 2099.454141923111, 2129.542148438093, 82256.9999999994, 82573.58713206396, 85260.0, 85672.0, 85710.57144714298, 11155.553777848796, 11409.0, 11551.711207219718, 11620.418979051014, 11651.184417090892, 16348.75476867848, 16373.754393684105, 16476.917615412087, 16521.421750238685, 16589.0, 9012.81974360509, 9099.636014559343, 9111.81776364469, 9139.131782480654, 9297.67458138962, 8947.32895032875, 9048.728538143867, 9059.229965452878, 9089.363744537952, 9168.8997320322, 7207.423406127497, 7235.010372147702, 7295.088113985752, 7305.5981920994855, 7314.0, 1823.7473500683418, 1963.59746252018, 1970.8226259636701, 2112.8837913914576, 2117.6811391526253, 1163.8245372173997, 1179.6556761581014, 1186.7270527778487, 1202.7353982123918, 1228.520876858026, 18805.905970470332, 19010.33463828787, 19163.233470661016, 19211.903940480486, 19504.0, 1090.8309212072143, 1146.9483873225724, 1155.820847768597, 1182.5920057580122, 1209.4255228766265, 11898.0, 11908.345041022654, 11918.165728399103, 11926.403679815974, 11960.940195298968, 539953.0, 567931.0, 580854.0, 583614.0, 592748.0, 87010.56494717486, 87088.0, 88713.55643221743, 90372.09627903768, 91412.0, 1145.5017067575632, 1146.18620779246, 1150.9539618415338, 1154.7748189103213, 1165.877582853805, 17517.526020456622, 17601.471955841345, 18057.18742656557, 18191.0, 18458.35395761142, 37721.81139094287, 38252.2349553013, 38385.23229535338, 40227.19545609013, 40683.796581016904, 58715.0, 58745.412545873995, 58894.4110558906, 59958.0, 60318.698406509444, 8804.515751633466, 8846.071162527842, 9142.405743626643, 9282.535873206447, 9417.670381536613, 13071.215727056408, 13507.729845403233, 13698.246596437291, 13718.657033573842, 14015.159090454605, 11593.884061159617, 11808.586699465477, 11840.0, 11943.641690749291, 11993.460294286604, 11875.881241187477, 11954.402279886144, 12009.35922984637, 12274.509019639472, 12363.75272494563, 12533.498660053861, 12686.682832929251, 12745.681357966125, 12798.360081996048, 12841.35793210317, 9053.275737941081, 9248.61270809384, 9389.906100938902, 9442.575084121094, 9446.29152813528, 9285.814283714422, 12191.329476878502, 12399.0, 12501.499940002299, 12647.114701970773], "value": 10046.362654406255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.8360288566819, 1566.8198157211923, 1586.6350739329953, 1808.6021075363424, 1925.1433112265047, 8388.916110838889, 8557.101504342048, 8595.0, 8606.440581362207, 8608.22525972663, 8469.872951905727, 8626.913730862689, 8647.610857511412, 8648.394612377137, 8675.392722509427, 2162.816160626349, 2365.9290221293345, 2390.689210402645, 2465.0386349323776, 2528.153068721971, 2406.518696260755, 2443.51129774045, 2445.058652418814, 2448.2410452759614, 2452.6934133233344, 2462.963055554168, 2500.6999160100813, 2502.4995000999875, 2506.636537702041, 2508.122157244968, 2070.0995067145764, 2353.364591560278, 2366.6923299971068, 2383.570957227707, 2393.4614711689906, 2361.8346715729904, 2366.372911178539, 2380.6548050532747, 2384.678068460753, 2428.550718117154, 8614.181652743042, 8653.653853845839, 8684.392092553524, 8687.826243475096, 8716.25911797498, 5435.83692489222, 5558.082916318803, 5565.777368905239, 5567.805126820583, 5602.0, 3775.848966041355, 3820.083180036771, 3860.1314704191614, 3896.4544963705102, 3921.5882332355263, 1290.9935450322782, 1294.3463550906827, 1315.7960516120017, 1324.2054767139734, 1348.4269185596083, 12449.377531123499, 12495.18781279223, 12496.81254781179, 12532.624021279376, 12620.116591838574, 4966.975165124151, 4988.152014157602, 5037.798488060436, 5062.063518249136, 5110.642255042111, 10674.839877401846, 10728.678139655824, 10794.892051079545, 10814.243002989715, 10817.56729730802, 4793.32893394925, 5672.914906276409, 5675.602707810413, 5679.290088738908, 5691.174779656926, 4369.978150109293, 4965.255211718199, 4980.203167493256, 5031.094403007493, 5035.345405097387, 4184.895377615584, 4196.769177695195, 4244.257254980428, 4279.037216626297, 4290.37789520524, 1322.8610995845297, 1326.476041963419, 1361.7548841208677, 1373.6977864869712, 1387.67389663429, 871.8212766382876, 931.6971984105193, 1003.2926786615419, 1069.4706120470416, 1083.7399024234128, 6281.0, 6313.337099604567, 6323.430891219812, 6368.5860419072615, 6498.772542960974, 472.058243803614, 483.20030349771184, 484.2349088440256, 484.4501490807958, 506.9847904562869, 4143.544210136883, 4160.771157586361, 4171.83312667496, 4177.122804211089, 4184.476940382452, 10667.946660266649, 10989.670309890716, 11064.28082174656, 11147.665570032912, 11148.944255278671, 10996.450177491093, 10996.780064398827, 11001.22991390611, 11003.724906877233, 11004.174686898514, 8178.550179740052, 8234.670613175525, 8290.419670622998, 8315.168483151758, 8398.328133749163, 6322.36776322364, 6355.682215889279, 6369.840753981002, 6399.840003999937, 6545.672716364067, 9840.0, 9856.457894815567, 10148.13740832008, 10153.441560714231, 10176.0, 10078.344907580984, 10262.538185781508, 10302.845457317997, 10466.424346661006, 10523.473826308807, 7851.685932562862, 7898.605069746375, 7943.205679432242, 8018.959905200437, 8022.799430014296, 8512.276456501268, 8548.700795472128, 8549.786255343417, 8550.82898342042, 8588.0, 7711.0746710395115, 7806.184392627529, 8154.347652187692, 8270.875936860832, 8271.669133234604, 7909.960450197712, 7923.484973476706, 7927.088384835818, 8017.398695098008, 8115.0, 7073.82315442118, 7118.145822501333, 7156.033935418652, 7163.140423149047, 7289.052423184952, 5279.128943724242, 5303.74739694905, 5537.5569954402745, 5580.274564306615, 5653.3216014076925, 5512.503874651301, 5588.273524441796, 5621.409751975983, 5694.743736531783, 5748.913766293425], "value": 4734.892872264791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5679263280379, 364.6007621654288, 369.5177792980161, 373.770131369208, 377.3848626738416, 6333.113364129025, 6357.745690172394, 6385.90421143682, 6386.329435409279, 6403.5197360197935, 6102.786402475915, 6135.417135372132, 6248.125262463259, 6251.468625166866, 6334.176557047589, 4906.582940450066, 4936.777844996984, 4938.432080310757, 4941.901161976758, 4969.4036715594175, 4925.039617274633, 4944.258361245806, 4946.777395017233, 4957.25641153828, 4966.652334336598, 4683.391159149306, 4715.90568188636, 4763.928541071887, 4838.63710221733, 4910.975445122769, 4809.975950120262, 4812.711237325771, 4830.589399901012, 4834.806607735686, 4844.418669759616, 4222.282212023963, 4231.386448964914, 4231.830726770925, 4232.4286221360335, 4250.851220207309, 6069.848253793646, 6073.605215660968, 6077.17958075663, 6081.209442772455, 6082.482988945945, 5597.776088956437, 5603.3836278009385, 5604.215409842625, 5605.747741351649, 5609.298837645294, 6442.581232219891, 6677.666116694146, 6685.264620891698, 6698.095757072831, 6737.191537015589, 4669.7665116744365, 4680.859574212779, 4687.20317546018, 4689.50760170184, 4696.530346965276, 6971.372576468142, 7048.577085374843, 7055.047568578228, 7059.647017649097, 7063.505554611179, 4764.6664733469015, 4772.093302272557, 4772.093302272557, 4773.09311230865, 4779.713217206979, 4824.059308434821, 4832.879178020507, 4835.734034628129, 4840.056189043103, 4846.830360937421, 5477.7261136943, 5586.86032849182, 5588.161775733673, 5599.776008959678, 5615.550755939515, 6714.261431242559, 6763.154605674291, 6770.119884415093, 6771.119754431991, 6799.32006799326, 1627.8453546913024, 1686.65067945643, 1701.3194722111255, 1708.2483707168806, 1709.9059551724774, 1111.7832022755485, 1131.4625552862324, 1135.4095870147642, 1139.9316041037564, 1141.2182654881433, 6448.355164483514, 6507.869842603216, 6514.739410423625, 6528.771492997722, 6532.150820393414, 6909.930900691029, 6964.756233531802, 6965.965170174117, 6982.755603553851, 6984.79045628632, 6576.901346479806, 6577.934220657828, 6582.17722784652, 6587.901181482282, 6590.5716128451495, 3749.081475038633, 3776.4146557283666, 3787.5076240089165, 3787.772733635991, 3789.621037896188, 7105.182903966007, 7141.071660684078, 7166.856662866713, 7244.637768111574, 7245.275472452712, 7068.929310706827, 7091.468139889529, 7092.397146242524, 7093.113360829896, 7098.467614928798, 7209.855802883913, 7230.710771569078, 7233.132024157135, 7237.638118094074, 7240.239774823673, 6959.19969203548, 6962.547434416747, 6986.0, 7046.189688185924, 7048.400885924549, 6738.199976221568, 6792.626405547545, 6849.794506164823, 6850.6574671267235, 6867.07294515234, 7190.820229494305, 7200.783976480714, 7215.530990485601, 7218.025566548448, 7222.458315626454, 4760.428748550196, 4786.3777708899015, 4797.688150270221, 4805.038992201644, 4805.783739731651, 6906.585604863724, 6910.101686780687, 6910.861782764216, 6925.961105834165, 6927.134108236471, 6545.345465453607, 6666.866662666816, 6724.025016372696, 6743.258241593323, 6808.080909077211, 6700.363465470772, 6721.294264102395, 6723.5293529452465, 6752.08846805675, 6851.212110607344, 6718.832029199114, 6721.731130754911, 6729.0915726376315, 6729.192496900403, 6737.59574425536, 6793.660316984032, 6830.726770929107, 6897.3447522485285, 6899.310068993262, 6905.827354316182, 6687.699053542505, 6700.229473610402, 6708.8993665094085, 6722.630255336004, 6723.831904202239], "value": 5095.617701179482, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.1828875402712, 815.7022686719346, 822.2887202569779, 855.7946092937694, 902.9638814447421, 15409.0, 15667.608309792247, 15681.764773528377, 15706.685866282682, 15717.0, 14702.264886755645, 14744.926275368634, 14746.115233086022, 14759.11445313282, 14783.778243326358, 730.5105579261894, 899.0335389456328, 920.6685593186447, 922.3451349541833, 925.7361651929201, 918.1277786103195, 923.1322556796623, 925.4031149908305, 926.666400095965, 926.8563372677246, 977.7408986618552, 979.3487330924927, 979.7256768104942, 980.2696990741907, 980.7204946590223, 782.9412794040442, 947.3794664494767, 965.034965034965, 969.2391472693937, 970.3450171134526, 711.3775446484326, 711.8006958051753, 712.0423031023265, 712.1205311440367, 712.4834494991142, 15199.392024319013, 15205.163715995615, 15275.923620381938, 15299.464518741903, 15304.540863774104, 14787.630309242355, 15149.772753408708, 15233.238338083162, 15291.770623440547, 15788.526344209693, 11880.392740255927, 11946.0, 12024.819627705592, 12116.575919842851, 12253.203541769757, 4099.508059032905, 4115.464989551339, 4165.396017577435, 4187.72779769314, 4309.267424537836, 59021.11468328021, 59207.40792592062, 59881.700591497196, 60692.393076069115, 60795.39204607942, 11395.373254470918, 11399.886001140048, 11475.942620287013, 11740.119491038036, 11742.941285293518, 20899.582008359746, 20937.26719564808, 20948.0, 20981.89509052445, 20983.37049888506, 8446.915530844735, 8472.915270847336, 8552.743417697478, 8618.698345557876, 8871.245944094695, 4942.505749425029, 5028.421731500851, 5097.057044446789, 5155.407128180233, 5162.1224391853475, 3586.605473397924, 3641.326354624403, 3652.0, 3657.4148136298063, 3658.5609726832417, 677.5629718831326, 681.151965802579, 699.566268913277, 703.9120109986252, 703.9225685174627, 653.3466533466534, 773.9574323412154, 794.2256300107465, 800.5556915911725, 816.1104396208161, 9428.717138485856, 9489.478078705599, 9500.762480937894, 9507.619695212114, 9966.596020310362, 762.1958833430673, 805.5408417202138, 807.8909347238165, 808.8907997420273, 825.3356048381111, 4607.124646317189, 4682.438107427062, 4733.313669517901, 4776.331313616097, 4838.7338696372035, 66153.0, 67333.66333168303, 67689.66155169193, 69589.30410695828, 70169.64915175493, 61191.0, 61311.38688613057, 62399.6880015597, 62556.68721656362, 62559.37440625626, 53046.469535304925, 53857.46142538603, 54314.45685543094, 54346.72826635841, 55229.44770552243, 10095.141912937483, 10150.390976541432, 10190.082892539707, 10217.1826253901, 10255.435951022766, 39145.0, 39636.0, 39769.40345894872, 42377.78811105925, 42813.785931070146, 49998.750006249735, 50226.24660630021, 53881.46118538921, 54710.0, 54865.177022345495, 13051.728323499003, 13115.08194426381, 13150.408231629408, 13454.529091482143, 13479.595612131652, 14205.147691138565, 14261.786073208703, 14881.47914822976, 15321.693566128837, 15637.609059773597, 13111.67220819449, 14048.297585120907, 14276.643083922985, 14415.0, 14561.053531520418, 13908.582742517741, 13919.721605567629, 13955.372008259856, 14180.858191418367, 14460.927695361455, 13508.729825403634, 14016.369263382969, 14203.573892783234, 14221.786673200117, 14279.64300892486, 11236.381998989807, 11546.42267886619, 11735.23720958135, 12120.818187727367, 12157.69605759863, 10959.452027398758, 11161.720956975816, 11603.361815099914, 11704.765904682028, 11720.824187637021], "value": 7401.124019958773, "unit": "score"}], "name": "dromaeo_css", "value": 7754.843518800179, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 105.0, 109.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 152.0, 169.0, 129.0, 151.0, 158.0, 129.0, 187.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 165.0, 160.0, 161.0, 161.0, 162.0, 160.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 186.0, 77.0, 76.0, 76.0, 76.0, 154.0, 79.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 164.0, 92.0, 92.0, 92.0, 147.0, 92.0, 93.0, 141.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 55.0, 52.0, 53.0, 53.0, 54.0, 72.0, 53.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 73.0, 73.0, 73.0, 74.0, 72.0, 72.0, 74.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 111.0, 113.0, 114.0, 114.0, 113.0, 112.0, 113.0, 127.0, 130.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 174.0, 161.0, 160.0, 173.0, 170.0, 165.0, 166.0, 158.0, 159.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 72.0, 65.0, 65.0, 66.0, 63.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1515.2999999999997, "alertThreshold": 2.0}]} 05:05:04 INFO - Return code: 0 05:05:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:05:04 ERROR - # TBPL SUCCESS # 05:05:04 INFO - Running post-action listener: _resource_record_post_action 05:05:04 INFO - Running post-run listener: _resource_record_post_run 05:05:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 503541760; Read time: 500; Write time: 1493736 05:05:05 INFO - install - Wall time: 16s; CPU: 23.0%; Read bytes: 0; Write bytes: 261677056; Read time: 0; Write time: 975464 05:05:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 241078272; Read time: 500; Write time: 517900 05:05:05 INFO - Running post-run listener: _upload_blobber_files 05:05:05 INFO - Blob upload gear active. 05:05:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:05 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 05:05:05 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:05:05 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:05:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:06 INFO - (blobuploader) - INFO - Done attempting. 05:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:07 INFO - (blobuploader) - INFO - Done attempting. 05:05:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:07 INFO - Return code: 0 05:05:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d80be1d049401b40b405bd293ae7b7da096c7eee2f7199396e04c2d42d7a8a23ab9fd7dbc315fe85072c1e01cf9b747e485560cb95a18a29a06d7a2390689e69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09ddf9bafd9d93605ceeb70e6b0eb817658cbaa217cdf048d71fc53529d87ccaa629c1c2daf092e4dc740d5ccfe27e064f2512319ee9b370043669c0d350b91e"} 05:05:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:07 INFO - Contents: 05:05:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d80be1d049401b40b405bd293ae7b7da096c7eee2f7199396e04c2d42d7a8a23ab9fd7dbc315fe85072c1e01cf9b747e485560cb95a18a29a06d7a2390689e69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09ddf9bafd9d93605ceeb70e6b0eb817658cbaa217cdf048d71fc53529d87ccaa629c1c2daf092e4dc740d5ccfe27e064f2512319ee9b370043669c0d350b91e"} 05:05:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:07 INFO - Copying logs to upload dir... 05:05:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.201057 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-19 05:05:06.966983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:06.970924) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d80be1d049401b40b405bd293ae7b7da096c7eee2f7199396e04c2d42d7a8a23ab9fd7dbc315fe85072c1e01cf9b747e485560cb95a18a29a06d7a2390689e69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09ddf9bafd9d93605ceeb70e6b0eb817658cbaa217cdf048d71fc53529d87ccaa629c1c2daf092e4dc740d5ccfe27e064f2512319ee9b370043669c0d350b91e"} build_url:https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/UTEMGMdaRjOH_tc1HLA2Sg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d80be1d049401b40b405bd293ae7b7da096c7eee2f7199396e04c2d42d7a8a23ab9fd7dbc315fe85072c1e01cf9b747e485560cb95a18a29a06d7a2390689e69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09ddf9bafd9d93605ceeb70e6b0eb817658cbaa217cdf048d71fc53529d87ccaa629c1c2daf092e4dc740d5ccfe27e064f2512319ee9b370043669c0d350b91e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:06.995594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:06.995933) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1463658169.803107-1491380581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:05:07.082036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:05:07.082509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:05:07.082956) ========= ========= Total master_lag: 0.18 =========