builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1463035952.97 results: success (0) buildid: 20160511211308 builduid: 0a152d4a48674049b523688be4de0588 revision: 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:32.967049) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:32.967654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:32.967928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:32.997118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:32.997381) ========= 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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 23:52:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.0M=0s 2016-05-11 23:52:33 (56.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:33.169391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:33.169676) ========= 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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009622 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:33.222654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 23:52:33.222963) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f --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 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f --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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 23:52:33,971 truncating revision to first 12 chars 2016-05-11 23:52:33,972 Setting DEBUG logging. 2016-05-11 23:52:33,972 attempt 1/10 2016-05-11 23:52:33,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1b2854d057e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 23:52:35,230 unpacking tar archive at: mozilla-aurora-1b2854d057e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 23:52:34.732151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:34.732511) ========= script_repo_revision: 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:34.732939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:34.733242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 23:52:34.739132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-11 23:52:34.739396) ========= /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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:52:35 INFO - MultiFileLogger online at 20160511 23:52:35 in /builds/slave/test 23:52:35 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 23:52:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:52:35 INFO - {'append_to_log': False, 23:52:35 INFO - 'base_work_dir': '/builds/slave/test', 23:52:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:52:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:52:35 INFO - 'branch': 'Mozilla-Aurora', 23:52:35 INFO - 'buildbot_json_path': 'buildprops.json', 23:52:35 INFO - 'config_files': ('talos/linux_config.py',), 23:52:35 INFO - 'default_actions': ('clobber', 23:52:35 INFO - 'read-buildbot-config', 23:52:35 INFO - 'download-and-extract', 23:52:35 INFO - 'populate-webroot', 23:52:35 INFO - 'create-virtualenv', 23:52:35 INFO - 'install', 23:52:35 INFO - 'run-tests'), 23:52:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:52:35 INFO - 'download_minidump_stackwalk': True, 23:52:35 INFO - 'download_symbols': 'ondemand', 23:52:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:52:35 INFO - 'tooltool.py': '/tools/tooltool.py', 23:52:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:52:35 INFO - '/tools/misc-python/virtualenv.py')}, 23:52:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:52:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:52:35 INFO - 'installer_path': 'installer.exe', 23:52:35 INFO - 'log_level': 'info', 23:52:35 INFO - 'log_name': 'talos', 23:52:35 INFO - 'log_to_console': True, 23:52:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:52:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:52:35 INFO - 'opt_config_files': (), 23:52:35 INFO - 'pip_index': False, 23:52:35 INFO - 'sps_profile': False, 23:52:35 INFO - 'sps_profile_interval': 0, 23:52:35 INFO - 'suite': 'dromaeojs', 23:52:35 INFO - 'system_bits': '32', 23:52:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:52:35 INFO - 'title': 'talos-linux64-ix-029', 23:52:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:52:35 INFO - 'use_talos_json': True, 23:52:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:52:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:52:35 INFO - 'work_dir': 'build'} 23:52:35 INFO - ##### 23:52:35 INFO - ##### Running clobber step. 23:52:35 INFO - ##### 23:52:35 INFO - Running pre-action listener: _resource_record_pre_action 23:52:35 INFO - Running main action method: clobber 23:52:35 INFO - rmtree: /builds/slave/test/build 23:52:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:52:36 INFO - Running post-action listener: _resource_record_post_action 23:52:36 INFO - ##### 23:52:36 INFO - ##### Running read-buildbot-config step. 23:52:36 INFO - ##### 23:52:36 INFO - Running pre-action listener: _resource_record_pre_action 23:52:36 INFO - Running main action method: read_buildbot_config 23:52:36 INFO - Using buildbot properties: 23:52:36 INFO - { 23:52:36 INFO - "project": "", 23:52:36 INFO - "product": "firefox", 23:52:36 INFO - "script_repo_revision": "production", 23:52:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:52:36 INFO - "repository": "", 23:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:52:36 INFO - "buildid": "20160511211308", 23:52:36 INFO - "pgo_build": "True", 23:52:36 INFO - "basedir": "/builds/slave/test", 23:52:36 INFO - "buildnumber": 325, 23:52:36 INFO - "slavename": "talos-linux64-ix-029", 23:52:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:52:36 INFO - "platform": "ubuntu64_hw", 23:52:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:52:36 INFO - "branch": "mozilla-aurora", 23:52:36 INFO - "repo_path": "releases/mozilla-aurora", 23:52:36 INFO - "revision": "1b2854d057e76fb0a7adf2796cf8482adf4b7a4f", 23:52:36 INFO - "stage_platform": "linux64-pgo", 23:52:36 INFO - "builduid": "0a152d4a48674049b523688be4de0588", 23:52:36 INFO - "slavebuilddir": "test" 23:52:36 INFO - } 23:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 23:52:36 INFO - Running post-action listener: _resource_record_post_action 23:52:36 INFO - ##### 23:52:36 INFO - ##### Running download-and-extract step. 23:52:36 INFO - ##### 23:52:36 INFO - Running pre-action listener: _resource_record_pre_action 23:52:36 INFO - Running main action method: download_and_extract 23:52:36 INFO - mkdir: /builds/slave/test/build/tests 23:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:36 INFO - https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:41 INFO - Downloaded 1361 bytes. 23:52:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 23:52:41 INFO - Using the following test package requirements: 23:52:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:52:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:52:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:52:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'jsshell-linux-x86_64.zip'], 23:52:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:52:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 23:52:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:52:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:52:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:52:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 23:52:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:52:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:52: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')]} 23:52:41 INFO - https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:44 INFO - Downloaded 23799980 bytes. 23:52:44 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'] 23:52:44 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 23:52:45 INFO - Return code: 0 23:52:45 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 23:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:45 INFO - https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 23:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:46 INFO - Downloaded 23799980 bytes. 23:52:46 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'] 23:52:46 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 23:52:47 INFO - Return code: 0 23:52:47 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')]} 23:52:47 INFO - https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 23:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:48 INFO - Downloaded 10840145 bytes. 23:52:48 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'] 23:52:48 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 23:52:49 INFO - Return code: 0 23:52: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')]} 23:52:49 INFO - https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T2t55X5mRcW_rHpkIsGgQg/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 23:52:50 INFO - Downloaded 62722960 bytes. 23:52:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:52:50 INFO - mkdir: /builds/slave/test/properties 23:52:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:52:50 INFO - Writing to file /builds/slave/test/properties/build_url 23:52:50 INFO - Contents: 23:52:50 INFO - build_url:https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 23:52:51 INFO - Running post-action listener: _resource_record_post_action 23:52:51 INFO - Running post-action listener: set_extra_try_arguments 23:52:51 INFO - ##### 23:52:51 INFO - ##### Running populate-webroot step. 23:52:51 INFO - ##### 23:52:51 INFO - Running pre-action listener: _resource_record_pre_action 23:52:51 INFO - Running main action method: populate_webroot 23:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:52:51 INFO - '--tppagecycles', 23:52:51 INFO - '7'], 23:52:51 INFO - 'tests': ['tsvgm']}}, 23:52:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:52:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:52:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:52:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:52:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['damp', 'tps']}, 23:52:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['damp', 'tps']}, 23:52:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['dromaeo_dom']}, 23:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:52:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'other-e10s': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['a11yr', 23:52:51 INFO - 'ts_paint', 23:52:51 INFO - 'tpaint', 23:52:51 INFO - 'sessionrestore', 23:52:51 INFO - 'sessionrestore_no_auto_restore', 23:52:51 INFO - 'tabpaint']}, 23:52:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['tsvgx', 23:52:51 INFO - 'tsvgr_opacity', 23:52:51 INFO - 'tart', 23:52:51 INFO - 'tscrollx', 23:52:51 INFO - 'cart']}, 23:52:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:52:51 INFO - 'tsvgr_opacity', 23:52:51 INFO - 'tart', 23:52:51 INFO - 'tscrollx', 23:52:51 INFO - 'cart']}, 23:52:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--disable-e10s'], 23:52:51 INFO - 'tests': ['tp5o']}, 23:52:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'tests': ['tp5o']}, 23:52:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--disable-e10s', 23:52:51 INFO - '--xperf_path', 23:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:51 INFO - 'tests': ['tp5n']}, 23:52:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:51 INFO - 'talos_options': ['--xperf_path', 23:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:51 INFO - 'tests': ['tp5n']}}, 23:52:51 INFO - 'talos.zip': {'path': '', 23:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:52:51 INFO - Running post-action listener: _resource_record_post_action 23:52:51 INFO - ##### 23:52:51 INFO - ##### Running create-virtualenv step. 23:52:51 INFO - ##### 23:52:51 INFO - Running pre-action listener: _resource_record_pre_action 23:52:51 INFO - Running main action method: create_virtualenv 23:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 23:52:51 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 23:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:52:51 INFO - Using real prefix '/usr' 23:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:52:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:52:53 INFO - Installing pip.................done. 23:52:53 INFO - Return code: 0 23:52:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:52:53 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')]} 23:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:53 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')]} 23:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:53 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:52:53 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 23:52:53 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 23:52:53 INFO - Using env: {'DISPLAY': ':0', 23:52:53 INFO - 'HOME': '/home/cltbld', 23:52:53 INFO - 'LANG': 'en_US.UTF-8', 23:52:53 INFO - 'LANGUAGE': 'en_US:en', 23:52:53 INFO - 'LOGNAME': 'cltbld', 23:52:53 INFO - 'MAIL': '/var/mail/cltbld', 23:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:53 INFO - 'MOZ_NO_REMOTE': '1', 23:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:53 INFO - 'NO_EM_RESTART': '1', 23:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:53 INFO - 'PWD': '/builds/slave/test', 23:52:53 INFO - 'SHELL': '/bin/bash', 23:52:53 INFO - 'SHLVL': '1', 23:52:53 INFO - 'TERM': 'linux', 23:52:53 INFO - 'TMOUT': '86400', 23:52:53 INFO - 'USER': 'cltbld', 23:52:53 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:53 INFO - '_': '/tools/buildbot/bin/python'} 23:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:52:54 INFO - Cleaning up... 23:52:54 INFO - Return code: 0 23:52:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:52:54 INFO - Using env: {'DISPLAY': ':0', 23:52:54 INFO - 'HOME': '/home/cltbld', 23:52:54 INFO - 'LANG': 'en_US.UTF-8', 23:52:54 INFO - 'LANGUAGE': 'en_US:en', 23:52:54 INFO - 'LOGNAME': 'cltbld', 23:52:54 INFO - 'MAIL': '/var/mail/cltbld', 23:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:54 INFO - 'MOZ_NO_REMOTE': '1', 23:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:54 INFO - 'NO_EM_RESTART': '1', 23:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:54 INFO - 'PWD': '/builds/slave/test', 23:52:54 INFO - 'SHELL': '/bin/bash', 23:52:54 INFO - 'SHLVL': '1', 23:52:54 INFO - 'TERM': 'linux', 23:52:54 INFO - 'TMOUT': '86400', 23:52:54 INFO - 'USER': 'cltbld', 23:52:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:54 INFO - '_': '/tools/buildbot/bin/python'} 23:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:54 INFO - Downloading/unpacking psutil>=0.7.1 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:56 INFO - Installing collected packages: psutil 23:52:56 INFO - Running setup.py install for psutil 23:52:56 INFO - building 'psutil._psutil_linux' extension 23:52:56 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 23:52:56 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 23:52:56 INFO - building 'psutil._psutil_posix' extension 23:52:56 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 23:52:56 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 23:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:56 INFO - Successfully installed psutil 23:52:56 INFO - Cleaning up... 23:52:56 INFO - Return code: 0 23:52:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:52:56 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')]} 23:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:56 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')]} 23:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:56 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:52:56 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 23:52:56 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 23:52:56 INFO - Using env: {'DISPLAY': ':0', 23:52:56 INFO - 'HOME': '/home/cltbld', 23:52:56 INFO - 'LANG': 'en_US.UTF-8', 23:52:56 INFO - 'LANGUAGE': 'en_US:en', 23:52:56 INFO - 'LOGNAME': 'cltbld', 23:52:56 INFO - 'MAIL': '/var/mail/cltbld', 23:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:56 INFO - 'MOZ_NO_REMOTE': '1', 23:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:56 INFO - 'NO_EM_RESTART': '1', 23:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:56 INFO - 'PWD': '/builds/slave/test', 23:52:56 INFO - 'SHELL': '/bin/bash', 23:52:56 INFO - 'SHLVL': '1', 23:52:56 INFO - 'TERM': 'linux', 23:52:56 INFO - 'TMOUT': '86400', 23:52:56 INFO - 'USER': 'cltbld', 23:52:56 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:56 INFO - '_': '/tools/buildbot/bin/python'} 23:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52: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 23:52:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:52:58 INFO - Installing collected packages: mozsystemmonitor 23:52:58 INFO - Running setup.py install for mozsystemmonitor 23:52:58 INFO - Successfully installed mozsystemmonitor 23:52:58 INFO - Cleaning up... 23:52:58 INFO - Return code: 0 23:52:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:52: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')]} 23:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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')]} 23:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:58 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:52:58 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 23:52:58 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 23:52:58 INFO - Using env: {'DISPLAY': ':0', 23:52:58 INFO - 'HOME': '/home/cltbld', 23:52:58 INFO - 'LANG': 'en_US.UTF-8', 23:52:58 INFO - 'LANGUAGE': 'en_US:en', 23:52:58 INFO - 'LOGNAME': 'cltbld', 23:52:58 INFO - 'MAIL': '/var/mail/cltbld', 23:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:58 INFO - 'MOZ_NO_REMOTE': '1', 23:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:58 INFO - 'NO_EM_RESTART': '1', 23:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:58 INFO - 'PWD': '/builds/slave/test', 23:52:58 INFO - 'SHELL': '/bin/bash', 23:52:58 INFO - 'SHLVL': '1', 23:52:58 INFO - 'TERM': 'linux', 23:52:58 INFO - 'TMOUT': '86400', 23:52:58 INFO - 'USER': 'cltbld', 23:52:58 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:58 INFO - '_': '/tools/buildbot/bin/python'} 23:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:52:59 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 23:52:59 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 23:52:59 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 23:52:59 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 23:52:59 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 23:52:59 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 23:53:00 INFO - Downloading blobuploader-1.2.4.tar.gz 23:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:53:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:01 INFO - Downloading docopt-0.6.1.tar.gz 23:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 23:53:01 INFO - Running setup.py install for blobuploader 23:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:53:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:53:01 INFO - Running setup.py install for requests 23:53:02 INFO - Running setup.py install for docopt 23:53:02 INFO - Successfully installed blobuploader requests docopt 23:53:02 INFO - Cleaning up... 23:53:02 INFO - Return code: 0 23:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:02 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:53:02 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 23:53:02 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 23:53:02 INFO - Using env: {'DISPLAY': ':0', 23:53:02 INFO - 'HOME': '/home/cltbld', 23:53:02 INFO - 'LANG': 'en_US.UTF-8', 23:53:02 INFO - 'LANGUAGE': 'en_US:en', 23:53:02 INFO - 'LOGNAME': 'cltbld', 23:53:02 INFO - 'MAIL': '/var/mail/cltbld', 23:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:02 INFO - 'MOZ_NO_REMOTE': '1', 23:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:02 INFO - 'NO_EM_RESTART': '1', 23:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:02 INFO - 'PWD': '/builds/slave/test', 23:53:02 INFO - 'SHELL': '/bin/bash', 23:53:02 INFO - 'SHLVL': '1', 23:53:02 INFO - 'TERM': 'linux', 23:53:02 INFO - 'TMOUT': '86400', 23:53:02 INFO - 'USER': 'cltbld', 23:53:02 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:02 INFO - '_': '/tools/buildbot/bin/python'} 23:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:53:02 INFO - Running setup.py (path:/tmp/pip-d0uWq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:53:02 INFO - Running setup.py (path:/tmp/pip-kFKR_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:53:02 INFO - Running setup.py (path:/tmp/pip-5IgpqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:53:02 INFO - Running setup.py (path:/tmp/pip-imiriD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:53:02 INFO - Running setup.py (path:/tmp/pip-a1IfQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:53:02 INFO - Running setup.py (path:/tmp/pip-W24hKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:53:02 INFO - Running setup.py (path:/tmp/pip-QIWVad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:53:02 INFO - Running setup.py (path:/tmp/pip-VEp9fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:53:02 INFO - Running setup.py (path:/tmp/pip-mEVxS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:53:02 INFO - Running setup.py (path:/tmp/pip-zI3C4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:53:02 INFO - Running setup.py (path:/tmp/pip-De9hNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:53:03 INFO - Running setup.py (path:/tmp/pip-c93RRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:53:03 INFO - Running setup.py (path:/tmp/pip-oB6bds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:53:03 INFO - Running setup.py (path:/tmp/pip-_j0b64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:03 INFO - Running setup.py (path:/tmp/pip-3mXal5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:53:03 INFO - Running setup.py (path:/tmp/pip-5Bw7yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:53:03 INFO - Running setup.py (path:/tmp/pip-eUv0tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:53:03 INFO - Running setup.py install for manifestparser 23:53:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:53:03 INFO - Running setup.py install for mozcrash 23:53:03 INFO - Running setup.py install for mozdebug 23:53:03 INFO - Running setup.py install for mozdevice 23:53:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:53:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:53:03 INFO - Running setup.py install for mozfile 23:53:03 INFO - Running setup.py install for mozhttpd 23:53:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:53:03 INFO - Running setup.py install for mozinfo 23:53:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:53:03 INFO - Running setup.py install for mozInstall 23:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Running setup.py install for mozleak 23:53:04 INFO - Running setup.py install for mozlog 23:53:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Running setup.py install for moznetwork 23:53:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Running setup.py install for mozprocess 23:53:04 INFO - Running setup.py install for mozprofile 23:53:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Running setup.py install for mozrunner 23:53:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Running setup.py install for mozscreenshot 23:53:04 INFO - Running setup.py install for moztest 23:53:04 INFO - Running setup.py install for mozversion 23:53:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:53:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:53:04 INFO - Cleaning up... 23:53:04 INFO - Return code: 0 23:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:04 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:53:04 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 23:53:04 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 23:53:04 INFO - Using env: {'DISPLAY': ':0', 23:53:04 INFO - 'HOME': '/home/cltbld', 23:53:04 INFO - 'LANG': 'en_US.UTF-8', 23:53:04 INFO - 'LANGUAGE': 'en_US:en', 23:53:04 INFO - 'LOGNAME': 'cltbld', 23:53:04 INFO - 'MAIL': '/var/mail/cltbld', 23:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:04 INFO - 'MOZ_NO_REMOTE': '1', 23:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:04 INFO - 'NO_EM_RESTART': '1', 23:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:04 INFO - 'PWD': '/builds/slave/test', 23:53:04 INFO - 'SHELL': '/bin/bash', 23:53:04 INFO - 'SHLVL': '1', 23:53:04 INFO - 'TERM': 'linux', 23:53:04 INFO - 'TMOUT': '86400', 23:53:04 INFO - 'USER': 'cltbld', 23:53:04 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:04 INFO - '_': '/tools/buildbot/bin/python'} 23:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:53:05 INFO - Running setup.py (path:/tmp/pip-eXyO_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:53:05 INFO - Running setup.py (path:/tmp/pip-TxeFkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:53:05 INFO - Running setup.py (path:/tmp/pip-8TH_D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:53:05 INFO - Running setup.py (path:/tmp/pip-GILU1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:53:05 INFO - Running setup.py (path:/tmp/pip-o6ISYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:53:05 INFO - Running setup.py (path:/tmp/pip-CnhrUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:53:05 INFO - Running setup.py (path:/tmp/pip-ZnLHL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:53:05 INFO - Running setup.py (path:/tmp/pip-LAJF9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:53:05 INFO - Running setup.py (path:/tmp/pip-SikG4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:53:05 INFO - Running setup.py (path:/tmp/pip-INGfLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:53:05 INFO - Running setup.py (path:/tmp/pip-H8crpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:53:05 INFO - Running setup.py (path:/tmp/pip-cavP7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:53:05 INFO - Running setup.py (path:/tmp/pip-Jh6Vr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:53:05 INFO - Running setup.py (path:/tmp/pip-L6Alth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:53:05 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)) 23:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:05 INFO - Running setup.py (path:/tmp/pip-IrxaBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:53:06 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)) 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:53:06 INFO - Running setup.py (path:/tmp/pip-o7oMYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:53:06 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)) 23:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:53:06 INFO - Running setup.py (path:/tmp/pip-BErmTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:53:06 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)) 23:53:06 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)) 23:53:06 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)) 23:53:06 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)) 23:53:06 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)) 23:53:06 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)) 23:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:07 INFO - Downloading blessings-1.6.tar.gz 23:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:53:08 INFO - Installing collected packages: blessings 23:53:08 INFO - Running setup.py install for blessings 23:53:08 INFO - Successfully installed blessings 23:53:08 INFO - Cleaning up... 23:53:08 INFO - Return code: 0 23:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:53:08 INFO - Reading from file tmpfile_stdout 23:53:08 INFO - Current package versions: 23:53:08 INFO - argparse == 1.2.1 23:53:08 INFO - blessings == 1.6 23:53:08 INFO - blobuploader == 1.2.4 23:53:08 INFO - docopt == 0.6.1 23:53:08 INFO - manifestparser == 1.1 23:53:08 INFO - mozInstall == 1.12 23:53:08 INFO - mozcrash == 0.17 23:53:08 INFO - mozdebug == 0.1 23:53:08 INFO - mozdevice == 0.48 23:53:08 INFO - mozfile == 1.2 23:53:08 INFO - mozhttpd == 0.7 23:53:08 INFO - mozinfo == 0.9 23:53:08 INFO - mozleak == 0.1 23:53:08 INFO - mozlog == 3.1 23:53:08 INFO - moznetwork == 0.27 23:53:08 INFO - mozprocess == 0.22 23:53:08 INFO - mozprofile == 0.28 23:53:08 INFO - mozrunner == 6.11 23:53:08 INFO - mozscreenshot == 0.1 23:53:08 INFO - mozsystemmonitor == 0.0 23:53:08 INFO - moztest == 0.7 23:53:08 INFO - mozversion == 1.4 23:53:08 INFO - psutil == 3.1.1 23:53:08 INFO - requests == 1.2.3 23:53:08 INFO - wsgiref == 0.1.2 23:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:53:08 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')]} 23:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:08 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')]} 23:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:08 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:53:08 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 23:53:08 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 23:53:08 INFO - Using env: {'DISPLAY': ':0', 23:53:08 INFO - 'HOME': '/home/cltbld', 23:53:08 INFO - 'LANG': 'en_US.UTF-8', 23:53:08 INFO - 'LANGUAGE': 'en_US:en', 23:53:08 INFO - 'LOGNAME': 'cltbld', 23:53:08 INFO - 'MAIL': '/var/mail/cltbld', 23:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:08 INFO - 'MOZ_NO_REMOTE': '1', 23:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:08 INFO - 'NO_EM_RESTART': '1', 23:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:08 INFO - 'PWD': '/builds/slave/test', 23:53:08 INFO - 'SHELL': '/bin/bash', 23:53:08 INFO - 'SHLVL': '1', 23:53:08 INFO - 'TERM': 'linux', 23:53:08 INFO - 'TMOUT': '86400', 23:53:08 INFO - 'USER': 'cltbld', 23:53:08 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:08 INFO - '_': '/tools/buildbot/bin/python'} 23:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 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)) 23:53:08 INFO - Cleaning up... 23:53:08 INFO - Return code: 0 23:53:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:53:08 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')]} 23:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:08 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')]} 23:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:08 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:53:08 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 23:53:08 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 23:53:08 INFO - Using env: {'DISPLAY': ':0', 23:53:08 INFO - 'HOME': '/home/cltbld', 23:53:08 INFO - 'LANG': 'en_US.UTF-8', 23:53:08 INFO - 'LANGUAGE': 'en_US:en', 23:53:08 INFO - 'LOGNAME': 'cltbld', 23:53:08 INFO - 'MAIL': '/var/mail/cltbld', 23:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:08 INFO - 'MOZ_NO_REMOTE': '1', 23:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:08 INFO - 'NO_EM_RESTART': '1', 23:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:08 INFO - 'PWD': '/builds/slave/test', 23:53:08 INFO - 'SHELL': '/bin/bash', 23:53:08 INFO - 'SHLVL': '1', 23:53:08 INFO - 'TERM': 'linux', 23:53:08 INFO - 'TMOUT': '86400', 23:53:08 INFO - 'USER': 'cltbld', 23:53:08 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:08 INFO - '_': '/tools/buildbot/bin/python'} 23:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:08 INFO - Downloading/unpacking jsonschema 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:53:10 INFO - Downloading/unpacking functools32 (from jsonschema) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:10 INFO - Downloading functools32-3.2.3-2.tar.gz 23:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:53:10 INFO - warning: no files found matching '*.txt' 23:53:10 INFO - no previously-included directories found matching 'build' 23:53:10 INFO - no previously-included directories found matching 'dist' 23:53:10 INFO - no previously-included directories found matching '.git*' 23:53:10 INFO - Installing collected packages: jsonschema, functools32 23:53:10 INFO - Running setup.py install for functools32 23:53:11 INFO - warning: no files found matching '*.txt' 23:53:11 INFO - no previously-included directories found matching 'build' 23:53:11 INFO - no previously-included directories found matching 'dist' 23:53:11 INFO - no previously-included directories found matching '.git*' 23:53:11 INFO - Successfully installed jsonschema functools32 23:53:11 INFO - Cleaning up... 23:53:11 INFO - Return code: 0 23:53:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:53:11 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')]} 23:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:11 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')]} 23:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:11 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 0x7fc25ce6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, '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': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', '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 23:53:11 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 23:53:11 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 23:53:11 INFO - Using env: {'DISPLAY': ':0', 23:53:11 INFO - 'HOME': '/home/cltbld', 23:53:11 INFO - 'LANG': 'en_US.UTF-8', 23:53:11 INFO - 'LANGUAGE': 'en_US:en', 23:53:11 INFO - 'LOGNAME': 'cltbld', 23:53:11 INFO - 'MAIL': '/var/mail/cltbld', 23:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:11 INFO - 'MOZ_NO_REMOTE': '1', 23:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:11 INFO - 'NO_EM_RESTART': '1', 23:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:11 INFO - 'PWD': '/builds/slave/test', 23:53:11 INFO - 'SHELL': '/bin/bash', 23:53:11 INFO - 'SHLVL': '1', 23:53:11 INFO - 'TERM': 'linux', 23:53:11 INFO - 'TMOUT': '86400', 23:53:11 INFO - 'USER': 'cltbld', 23:53:11 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:11 INFO - '_': '/tools/buildbot/bin/python'} 23:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:11 INFO - Downloading/unpacking flake8 23:53:11 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 23:53:11 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 23:53:11 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 23:53:11 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 23:53:11 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 23:53:11 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 23:53:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:53:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:53:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:53:13 INFO - no previously-included directories found matching 'docs/_build' 23:53:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:53:13 INFO - Running setup.py install for pep8 23:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:53:13 INFO - no previously-included directories found matching 'docs/_build' 23:53:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:53:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:53:13 INFO - Cleaning up... 23:53:14 INFO - Return code: 0 23:53:14 INFO - Running post-action listener: _resource_record_post_action 23:53:14 INFO - Running post-action listener: _start_resource_monitoring 23:53:14 INFO - Starting resource monitoring. 23:53:14 INFO - ##### 23:53:14 INFO - ##### Running install step. 23:53:14 INFO - ##### 23:53:14 INFO - Running pre-action listener: _resource_record_pre_action 23:53:14 INFO - Running main action method: install 23:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:53:14 INFO - Reading from file tmpfile_stdout 23:53:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:53:14 INFO - Reading from file tmpfile_stdout 23:53:14 INFO - Output received: 23:53:14 INFO - Usage: mozinstall [options] installer 23:53:14 INFO - Options: 23:53:14 INFO - -h, --help show this help message and exit 23:53:14 INFO - -d DEST, --destination=DEST 23:53:14 INFO - Directory to install application into. [default: 23:53:14 INFO - "/builds/slave/test"] 23:53:14 INFO - --app=APP Application being installed. [default: firefox] 23:53:14 INFO - mkdir: /builds/slave/test/build/application 23:53:14 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'] 23:53:14 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 23:53:30 INFO - Reading from file tmpfile_stdout 23:53:30 INFO - Output received: 23:53:30 INFO - /builds/slave/test/build/application/firefox/firefox 23:53:30 INFO - Running post-action listener: _resource_record_post_action 23:53:30 INFO - ##### 23:53:30 INFO - ##### Running run-tests step. 23:53:30 INFO - ##### 23:53:30 INFO - Running pre-action listener: _resource_record_pre_action 23:53:30 INFO - Running main action method: run_tests 23:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:53:30 INFO - Python 2.7.3 23:53:30 INFO - Return code: 0 23:53:30 INFO - grabbing minidump binary from tooltool 23:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:30 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 0x1a0d410>, '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 0x1a0e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:53:30 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 23:53:30 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 23:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:53:30 INFO - Return code: 0 23:53:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:53:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:53:31 INFO - Return code: 0 23:53:31 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/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 23:53:31 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/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 23:53:31 INFO - Using env: {'DISPLAY': ':0', 23:53:31 INFO - 'HOME': '/home/cltbld', 23:53:31 INFO - 'LANG': 'en_US.UTF-8', 23:53:31 INFO - 'LANGUAGE': 'en_US:en', 23:53:31 INFO - 'LOGNAME': 'cltbld', 23:53:31 INFO - 'MAIL': '/var/mail/cltbld', 23:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:31 INFO - 'MOZ_NO_REMOTE': '1', 23:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:31 INFO - 'NO_EM_RESTART': '1', 23:53:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:53:31 INFO - 'PWD': '/builds/slave/test', 23:53:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:53:31 INFO - 'SHELL': '/bin/bash', 23:53:31 INFO - 'SHLVL': '1', 23:53:31 INFO - 'TERM': 'linux', 23:53:31 INFO - 'TMOUT': '86400', 23:53:31 INFO - 'USER': 'cltbld', 23:53:31 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169', 23:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:31 INFO - '_': '/tools/buildbot/bin/python'} 23:53:31 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/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 23:53:31 INFO - mozversion application_buildid: 20160511211308 23:53:31 INFO - mozversion application_changeset: 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f 23:53:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:53:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:53:31 INFO - mozversion application_name: Firefox 23:53:31 INFO - mozversion application_remotingname: firefox-dev 23:53:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:53:31 INFO - mozversion application_vendor: Mozilla 23:53:31 INFO - mozversion application_version: 48.0a2 23:53:31 INFO - mozversion platform_buildid: 20160511211308 23:53:31 INFO - mozversion platform_changeset: 1b2854d057e76fb0a7adf2796cf8482adf4b7a4f 23:53:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:53:31 INFO - mozversion platform_version: 48.0a2 23:53:31 INFO - using testdate: 1463036011 23:53:31 INFO - actual date: 1463036011 23:53:31 INFO - starting webserver on 'localhost:42844' 23:53:31 INFO - SUITE-START | Running 2 tests 23:53:31 INFO - TEST-START | dromaeo_css 23:53:31 INFO - operating with platform_type : linux_ 23:53:31 INFO - Initialising browser for dromaeo_css test... 23:53:31 INFO - TEST-INFO | started process 7333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoZKb6/profile http://localhost:42844/getInfo.html) 23:53:34 INFO - PROCESS | 7333 | __metrics Screen width/height:1600/1200 23:53:34 INFO - PROCESS | 7333 | colorDepth:24 23:53:34 INFO - PROCESS | 7333 | Browser inner width/height: 1024/697 23:53:34 INFO - PROCESS | 7333 | __metrics 23:53:35 ERROR - PROCESS | 7333 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:53:35 INFO - TEST-INFO | 7333: exit 0 23:53:35 INFO - Browser initialized. 23:53:35 INFO - Running cycle 1/1 for dromaeo_css test... 23:53:35 INFO - TEST-INFO | started process 7427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoZKb6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:53:47 INFO - PROCESS | 7427 | RSS: Main: 140787712 23:53:47 INFO - PROCESS | 7427 | 23:54:38 INFO - PROCESS | 7427 | 1463036078102 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] 23:56:45 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42844/tests/dromaeo/cssquery-ext.html) 23:56:46 INFO - PROCESS | 7427 | RSS: Main: 249503744 23:56:46 INFO - PROCESS | 7427 | 23:59:48 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-ext.html (next: http://localhost:42844/tests/dromaeo/cssquery-jquery.html) 23:59:49 INFO - PROCESS | 7427 | RSS: Main: 222961664 23:59:49 INFO - PROCESS | 7427 | 00:02:50 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42844/tests/dromaeo/cssquery-mootools.html) 00:02:51 INFO - PROCESS | 7427 | RSS: Main: 215891968 00:02:51 INFO - PROCESS | 7427 | 00:05:53 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42844/tests/dromaeo/cssquery-prototype.html) 00:05:53 INFO - PROCESS | 7427 | RSS: Main: 223707136 00:05:53 INFO - PROCESS | 7427 | 00:08:56 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42844/tests/dromaeo/cssquery-yui.html) 00:08:56 INFO - PROCESS | 7427 | RSS: Main: 181207040 00:08:56 INFO - PROCESS | 7427 | 00:11:58 INFO - PROCESS | 7427 | Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-yui.html (next: http://localhost:42844/tests/dromaeo/cssquery-dojo.html) 00:11:59 INFO - PROCESS | 7427 | RSS: Main: 242663424 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | __start_tp_report 00:11:59 INFO - PROCESS | 7427 | _x_x_mozilla_page_load 00:11:59 INFO - PROCESS | 7427 | _x_x_mozilla_page_load_details 00:11:59 INFO - PROCESS | 7427 | |i|pagename|runs| 00:11:59 INFO - PROCESS | 7427 | |0;dojo.html;3218.7103160715533;3262.33122209947;3270.738340932726;3279.5900512435946;3295.3574053059647;5360.142377219646;5362.8123015694455;5390.8921821563545;5421.9457805421935;5422.728863556817;5405.675659460435;5414.972925135378;5419.3225846769155;5440.020796256672;5446.782128714856;4892.77982490787;4896.216605343146;4963.627727920402;5008.874778130539;5081.314022606938;4870.902581948359;4936.605071594282;4939.753012349386;4949.109160351135;4949.925751113737;4922.286268491067;4972.154733695281;4973.801047958095;4990.176620857555;4992.076465853828;4988.775505102279;5021.096202683516;5048.848534543933;5051.747412629391;5070.062038522867;4802.471728109905;4814.446338671028;4875.488073752241;4945.950540494585;4983.6013118950395;5337.412884582693;5381.327334083239;5427.267318911936;5442.91835622466;5461.808836690737;5753.539716822686;5764.394738552475;5767.279090113736;5785.062004228588;5797.536197104221;5823.097419899922;5838.824835254906;5856.180134781134;5885.440883116097;5967.492763115097;5491.780328786844;5492.231087647732;5509.311336082989;5524.889502209933;5539.861503462405;5864.149698293809;5969.820905372846;6009.909851352233;6011.48902343297;6061.090836374579;5703.62926409782;5786.855328616734;5796.101604251347;5799.5650326225705;5835.737391817378;5811.883762324815;5846.386129456346;5868.354481007086;5871.943050250996;5876.353601103875;5670.943290567042;5785.392533783976;5820.708964551755;5822.883542329215;5824.796132135355;5789.363170051291;5903.085021821625;5906;5920.993431116721;5943.049112142036;4460.598546130799;4479.10417916418;4484.12559550891;4486.798094085774;4512.751798651106;3899.2591407633026;3899.454076429302;3907.5701672815967;3988.80055997199;4059.7361171523758;5474.0146773580345;5480.205370221375;5482.643628164156;5540.695261760642;5571.4428557143965;5793.7392817323325;5809.883802324014;5810.302763668386;5829.621074630136;5846.41535846412;5440.564754819605;5440.7551660174595;5541.362743284574;5549.556035517149;5636.267285252891;4986.675866068694;5000.774965126578;5000.899982000413;5023.422306434733;5049.116404629175;6006.189164462741;6010.879782404328;6050.092486127028;6065.363136870653;6074.605150665193;5792.768289268382;5867.559933004956;5896.675682837314;5959.553033522589;5967.7016149191495;5991.580589358703;6010.789622363196;6016;6025.87948241024;6032.457078862748;5554.111342185231;5677.006523858391;5681.062624667049;5697.458741419724;5712.485876271156;5796.913046304225;5870.677112758839;5893.5874488787085;5902.2327097477055;5908.320543137423;5743.138529220483;5757.280339957505;5774.162746401832;5776.971115144565;5797.159411885337;5553.583481239004;5713.514351280188;5714.971305165111;5749.683767392834;5764.164196191613;5625.549956003428;5651.943480565142;5686.43135686428;5698.857528561819;5700.230468886647;5712.457316554921;5757.280339957505;5772.94227057724;5775.220345253337;5797.246357973437;5542.974549708317;5576.944230557642;5593.07714227148;5676.971615141898;5735.340435849931 00:11:59 INFO - PROCESS | 7427 | |1;ext.html;600.9188759517464;633.4204203154114;645.0678769178533;650.6161364794771;666.4768156996762;32805.67194328056;33532.32935341292;33652.4952125718;39013.60986390142;39937.40093898594;42730.78634606831;43243.70268891938;43444.782776086075;43461.7826910865;43622.34566481505;8094.473859199134;8727.956360218206;8854.424462409956;8866.246369058637;8927.598258078402;10478.790424191511;10806;10817.621383251588;10825.296355736891;10842.891571084267;10631.36211827289;10645;10678.092362149227;10749.355038697704;10753;10462.686119416392;10590.894091059106;10615.416152111631;10621.893781062168;10629.255952083357;10348.79302413955;10428.947855260674;10462.63380781669;10793.244472886901;10812.243142979994;42891.78554107241;43361.783191084156;43527;43586;43687.563124368666;3811.447340135665;3879.0884142226555;3927.892702435826;4286.535678172779;4615.884602884921;32629.67370326314;32872.83563582191;32875.342493150245;32991.6700832991;34390.65609343899;4360.171567402183;4420.58004489573;4425.690201685883;4436.0462500562535;4523.231050721385;336734.31632841926;337191;339646;340392;340785;38324.61675383266;39108.41337379941;39149.042547872494;65022.34977650163;65513.67243163754;37840.62159378426;37936.43095353572;37986.81006595005;38000.23999519994;38019.61980380216;17753;17994;18009.549761256072;18026;18036.368727094752;13373.933130334286;13461.326933653278;14531.78202326966;15194.924025379802;15241.847581524265;9094.454332740057;9098.499582523025;9131.954340228256;9169.312301577409;9188.448693078437;3568.928621427557;3594.155373487228;3599.3881040223223;3622.2031153146268;3647.398179300386;1120.8598925134359;1131.6039386214923;1137.6643890052455;1151.9769604607861;1250.956216532417;33071.834640826644;33322.67764202875;33472.83263583667;33594;33621.32757344839;1207.4204381896739;1216.8053111502118;1243.4093805442524;1273.7898246789362;1296.6758310422395;16501.69276133561;17551;17576.648467030842;17621.471355859343;17810.643787124183;468133;482651;483278;487215;488872;62756.686216568625;63009;63142.684286578275;63204;63387;1402.144691738039;1496.9700605987819;1515.909045457276;1561.7735428362596;1568.654895922895;30929.69070309358;33388.49917251195;34353.48469772905;34430.13924651803;34545;54041.459585403645;54084.459155407945;54439.455605443436;54782.178267325224;54894.72552637211;363466;367106;368314;368395;368923;38313;41677.79161104175;47046.29430558476;47549;47741.761291193325;44058.77970610127;44335.55664443443;44615.10769784651;44998.03512891052;45214.77392613016;37269.813650931574;37755.24489510249;37866.62133378631;37878.431823522114;38468.42297365486;36340.63659363478;37407.625923740416;37975.43036854504;38262.80868595639;38581.807090964365;42150.78924605357;43258.35112473378;43765.56234437615;43906.21411381755;44185.779071104436;35858.8207058963;36767.26465470622;37266.441003384425;37612.435813462274;37652.43521347237;28264.85867570649;28346;28416.234724658974;28417.432217143993;28812.279693007844 00:11:59 INFO - PROCESS | 7427 | |2;jquery.html;423.2043757735457;428.9292266775982;429.11602099674656;433.4408612889373;435.78864250838336;18363.908180459097;19130.33043843466;19158.425247242587;19165.712514312298;20217.797822021814;19656.60686786267;19877.900610496927;20063.59872802543;20098;20105;5176.896462070757;5355.6251062425645;5911.970440147793;5932.050871860503;5935.020721580934;3990.1421194443187;4966.379202599675;5193.298904647881;5479.835604931858;5781.508571771405;5792.507636850873;5792.971035144818;5793.594448388614;5797.3043234811885;5801.9129713054335;5274.709890955976;5572.804951826707;5589.74846131925;5745.6265342752795;5759.337676167232;3835.17543728097;5327.387350454708;5464.644798088151;5465.535429488498;5580.302462192226;13327.866721332759;13486.325683715873;13567.59297221085;13616.93191534036;20674.896625516925;2277.191596983064;2390.426297688542;2438.426969662128;2497.5629264878576;2564.1410127607087;10500.474976251233;10529.420881851494;13174.60476185716;13274.535391261259;14411.279436028157;2019.9495012624654;2029.3201777404588;2121.6075026120216;2218.7892150245702;2242.6636004599277;74586.62706686486;75254;78775.03062423428;79307.20692793056;80562.79155812727;11178.496967636476;11375.601853935073;11537.173392518718;11582.420878956018;11616.709582260512;16349.427770027993;16484.752728709078;16546.503604891874;16634.3346266148;16634.33462661504;8985.820283594292;9094.86357704635;9129.543522823833;9189.586468608795;9368.812623747623;8885.600147993357;8983.910160898438;9132.178103970675;9186.954065229631;9250.121238482334;5039.874003149877;5051.318072060299;5056.494350564988;5069.493050694901;5128.333316668809;1863.9440816775518;2012.577358754678;2013.1947221111673;2084.989575052115;2086.530530630596;1028.0695970147028;1029.1237036521545;1035.404642330648;1062.7715041266165;1079.9244052916379;18741.90629046846;18851.811481885004;18948.715769263472;18983.33558325452;19574.5106372339;1096.276457538021;1110.0675432636463;1122.074288711816;1150.7583407484522;1174.6593487888417;10433.634822781167;10730.302530335503;10795.78408431827;10805.675829725122;10952.123830093573;514235;514346;524935;536492;537313;88618.55690721505;89973;91076;92795.47261119663;94307.52846235725;1085.3270971997413;1087.228068071678;1096.3641088168683;1101.5098281264761;1106.8339749037548;16063.437779677655;16225.18874056269;16288.674226515166;16541.25564349583;16795.580110496845;38951.41572876466;40592.39111413272;40958.385624215065;41236.38145427881;41391.37912931369;57247.713761430925;57360.71319643375;57619;57643.423565765486;57856.4214357851;8644.049154592863;8724.127587241479;8750.212480876751;8874.378793484395;9285.396449230779;9840.065193806577;13449.125806822525;13522.459101636217;13522.526711565048;13614.659633509242;7712.5758083305955;11305.491252893475;11464.140189485988;11637.650870473899;11923.82114268304;10753.784924301626;11121.332720036824;11403.31580105163;12291.078169137529;12542.874571254171;12133.575324863587;12225.816612750637;12253.081018923438;12887.80668289995;13222.471101155847;8612.311015118901;8753.868691969752;8900.510471924106;9347.018563050782;9360.859587106062;8748.518831464076;11276.210665253353;11606.419679015846;11731.765364692828;11759.412029398667 00:11:59 INFO - PROCESS | 7427 | |3;mootools.html;1482.866542011219;1491.2022068193519;1682.5541231573627;1834.8990805505691;1837.2375464182364;8112.269895709385;8239.794005149874;8309.418340716153;8316.875246871294;8356.791080222989;7305.6712447939835;8082.555459449728;8192.262696357328;8260.752177434671;8307.252347288742;2290.4273931517123;2318.246569864792;2331.25399872041;2335.2060299498166;2340.5903966805827;2094.6543820269712;2268.750437451879;2285.337252196861;2296.2651951375565;2311.861288322706;2290.5189910118893;2325.4418939454577;2340.262817212581;2341.9648705269433;2351.6002279612508;2329.26628112145;2331.1374791327235;2378.203301893868;2396.0535588442467;2410.5781488239663;2314.502381987864;2325.6511523271474;2332.4052366646565;2360.799332056777;2369.028698233733;8093.473924194908;8137.918620813775;8141.715039973573;8298.128696486843;8367.330613550901;5126.102931986925;5245.26566280721;5258.211268309746;5259.789608415659;5267.367915850123;3406.5741782277214;3427.7771944823508;3466.636003219651;3491.458823882277;3492.3189977954307;1119.9552017919273;1152.6196355202762;1164.441068287227;1192;1219.8048312269993;11515.36665483398;11533.884661153448;11539.942300288529;11592.710182245428;11608.535658573646;4547.954520454753;4552.135094332067;4615.215413379734;4670.696404733681;4752.7623618818925;9337.673181438617;9340.906590934139;9347.252219822398;9349.485778282124;9398.718038458857;5219.112750832292;5231.032259032091;5236.895262094737;5251.868703282448;5291.312129423227;4775.283707443911;4792.2811578262845;4842.58837998774;4849.199882019428;4863.392075990501;3939.6454319111417;4032.8790136295956;4072.6538244249573;4086.8773936781945;4096.201240758083;1208.3173007250875;1236.8515778106505;1250.787366147757;1315.7828958221787;1325.787873940165;987.274353350287;1010.6917390196061;1044.1333693034762;1059.1315121600214;1059.8251288537458;5432.103702889058;5486.561075113981;5526;5536.335639723259;5600.215969764236;959.7744530035436;967.3591096306981;982.5774916785708;984.3404918704485;1000.3747657713928;3975.6421922027157;4009.1981603679383;4045.4336392905016;4070.898227544335;4302.978485107617;9843.212542996544;10158.13655839262;10187.439690816927;10200.948995254976;10254.743631409274;9987.80024399508;10039.598416063422;10092.192624590016;10103.64637237708;10108.696739097839;7406.333429991327;7795.376369890395;7837.05955285358;7897.368210543143;7978.441509094424;5758.568107392046;5769.624974376652;5789.681567513827;5833.125031245348;5913.290405151237;9189.356745027784;9327.720168394959;9357.157855793012;9574.090461406155;9613;9473.194778443909;9650.517474126405;9667.854982175133;9691.951540242253;9828.606855725977;7933.523988560705;8178.550179740171;8262.628181731716;8272.17278272192;8311.335093192409;8089.110197878111;8128.83742325162;8139.348852091937;8160.428769986044;8179.813926980673;7133.607651579213;7188.676509556978;7314.08573928259;7415.1101867776215;7420.406367490696;7130.857382852418;7174.605396703231;7178.318059784312;7193.640317983975;7222.313880181375;6783.525153239226;6790.354916282945;6797.66011699423;6803.489738269551;6821.283765204582;4865.878353041061;4940.308356829974;4986.401631804207;4988.102141614544;5030.84907452777;5071.39143302806;5114.974425127851;5126.307948427064;5126.769295381642;5222.060029194781 00:11:59 INFO - PROCESS | 7427 | |4;prototype.html;347.892153432436;354.2383874669462;356.13104026176126;358.1601145314238;359.1828589957845;6087.817365479043;6100.23747031621;6106.084087386894;6143.38566143386;6227.47066499347;5880.5883588148845;5987.6407415555095;6093.329733729297;6130.693465326738;6146.385361463851;4706.670533062687;4716.103940251359;4758.857234282977;4765.404324459442;4775.3075804008395;4752.976235118819;4778.450478195;4778.665493415462;4779.474257831635;4786.425628924534;4528.796204170803;4619.5611416915335;4730.97634511827;4741.9525804742025;4748.430188377382;4719.693219940727;4719.882002949954;4734.360861283717;4748.07412554552;4748.643851711118;4181.790910454465;4185.100203456241;4186.392973018896;4186.91626167475;4187.644050255732;5905.232319798399;5911;5920.733566989496;5922;5940;5459.3994660587305;5477.096279113942;5483.424240454735;5490.3411590609385;5508.91736623951;6351.142595749561;6461.903071453885;6471;6481.546291759579;6489.318621544717;4607.746573938432;4625.421822272216;4629.305604159369;4634.72191668501;4642.3500709900645;6734;6736.393724564813;6759.594424334556;6759.628220447873;6761.864762704768;4728.219843725816;4738.47876733559;4739.052189562101;4744.905101897943;4746.620270378361;4749.501302363271;4795.640326975491;4804.903901921942;4810.182269014276;4810.39870016248;5413.079776438015;5519.034169020405;5528.9494995950645;5534.280543529316;5541.0580201365865;6508.772192973318;6580.440662543738;6587.374199451045;6588.835279117964;6590.5716128451495;1609.6780643871273;1673.3055781850396;1691.0952640337607;1691.9492415227562;1698.6156282629863;1113.3431275547466;1121.814900541418;1138.971525711864;1139.9088072954144;1148.6496618531428;6191.1641928339095;6198.721057552421;6210.068489726577;6246.593971391845;6259.217597800275;6657.866842663119;6664.133662623828;6673.766418175341;6680.331966803281;6682.365175308338;6179.5056395488255;6190.566660333733;6212.875742485125;6213.844653883689;6237.719302631393;3536.964630353715;3577.94633080504;3582.8566857325413;3586.408242639935;3607.981960090183;6829.965850170717;6916.827079322957;6970.302969703091;7042.823929401703;7104.360607545243;6916.135483064617;6922.134733158356;6925.896111558331;6932.61870597122;6935.722571097201;7059.788206353817;7072.92927070733;7086.39765619928;7089.078419805495;7092.680829362691;6727.629980351127;6729.528932974645;6732.42774364165;6738.561993470409;6749.493787965824;6550.868982620416;6692.330766923464;6692.966535167293;6694.364035416627;6696.19645642526;7011.719531218694;7043.7534686285735;7046.788596342118;7057.576545407292;7069.575825450489;4602.976985115053;4613.67704260712;4649.325847752125;4650.744209068534;4665.953340466552;6773.729050837911;6776.28848970851;6806.115205023315;6819.659017049227;6833.180018397824;6297.590656607306;6421.743130274924;6526.608403495806;6545.985372267306;6628.337166283526;6561.311062338576;6563.967180164069;6576.473882089325;6580.76967306142;6586.70359833799;6427.100205971261;6450.8064758057335;6464.321246269074;6471.126397936407;6508.837279068061;6491.123698300669;6631.1379520662;6638.966805165944;6661.100751398693;6669.533132680665;6432.614043157426;6472.35276472349;6491.961286194186;6502.252240992158;6503.707333169924 00:11:59 INFO - PROCESS | 7427 | |5;yui.html;819.4223072733723;820.6389188756947;823.7899335669404;845.4758050008987;856.4946681457939;14158.15051096935;14315.856841431583;14781.408743650269;14808.481703140393;14852.48016319429;13300.268485233308;13315.267660278681;13398.732025359512;13405;13467.730645387086;746.0599644447981;878.8505953987838;889.2397000564521;895.7671005538574;898.1557336104074;890.6081324217356;898.2858627391207;901.5086777706133;902.0708670069838;904.2810965282583;782.4992005116729;934.0705997532465;936.0218571592668;940.8588711693233;940.9482478463716;918.4856480371013;934.0612684252351;935.9344845860827;938.1650331205199;938.6573900526258;678.8268991407209;682.2938258902062;684.5379368926004;686.37539838747;686.7802303262957;14292.07101538407;14309.28453577317;14341.713165736732;14359.138451692932;14394;13568.59294221175;14347.56957291283;14723.705525889529;14729;15008.624784380478;11598.362090085042;11859.88140118605;11926.940365298206;11949.761004779943;12028.819567706492;3886.689064874803;3904.4533765272886;3985.940210896839;4001.079751657135;4006.1587066716024;53776.462235377534;57152.42847571554;57334.71332643352;57599.42400575982;57643.13535296974;10510.579576816994;10666.520006599721;10888.564457421615;10938.945305273583;11019.338839669485;19341;19392.321268755808;19489.122989465508;19529.609407811764;19944.60110797776;8351.457155284887;8436.915630843612;8440.071592124861;8544;8656.567171641393;4796.496367881392;4809.831655892097;4830.3237546743485;4970.826021089317;4977.800887964441;3281.196106953764;3362.310726301151;3373.578302712161;3374.8481318340732;3378.223008707962;601.9969900150471;619.9039148931922;634.2040738872686;641.5477088652489;646.524804268862;659.4691273524859;684.3532861445885;710.2932582080863;715.4240836126863;719.76967370442;9069.41048831837;9158.542072896329;9240.584173712065;9510.952445237868;9706.854397184048;689.899964505154;725.1443296909697;727.1092911183757;739.7004213293625;742.387530287515;4321.546237645065;4380.014496738208;4448.822047118079;4540.182767101954;4597.42532183477;59020;60676.69661651752;60958.39041609616;61341.386586133565;64920;52797.472025280025;54232.45767542353;55966.72016639891;59514.70242648759;59607.70196148992;47857;49782.253266201034;50653;51504.22743658848;51829.222561661605;9660.275479339218;9672.177864881563;9710.70867873965;9741.951290243504;9834.114929656365;35900.461493078146;37406.2518749618;38639.22721545497;38828.61171388363;39117.80441097776;46076;49919;50193;50537.74731126321;51512.742436287575;11572.479238434122;11663.475143618727;11730.824037639613;11823.172377933462;12644.431000605178;13365.131266467648;14187.858121419067;14268.928655356656;14481;14673.119612823264;13151.671208219872;13332.93333533326;13509;13609.727805443637;13840.792388114387;13394.129381590166;13549.932250338685;13553.86446135526;13559.118657287245;13681.657958551115;13164.47342106305;13215.405306761026;13556.728865422834;13630.182189068688;13674.863251367358;11183.32900026001;11195.216334856483;11323.603673871376;11482;11545.191836571359;10956.34261944286;11214.887851121384;11410.315381077162;11440.427978601203;11554.711132221762 00:11:59 INFO - PROCESS | 7427 | __end_tp_report 00:11:59 INFO - PROCESS | 7427 | __start_cc_report 00:11:59 INFO - PROCESS | 7427 | _x_x_mozilla_cycle_collect,767 00:11:59 INFO - PROCESS | 7427 | __end_cc_report 00:11:59 INFO - PROCESS | 7427 | __startTimestamp1463037119240__endTimestamp 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | ------- Summary: start ------- 00:11:59 INFO - PROCESS | 7427 | Number of tests: 6 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#0] dojo.html Cycles:165 Average:5426.05 Median:5670.94 stddev:608.88 (10.7%) stddev-sans-first:585.61 00:11:59 INFO - PROCESS | 7427 | Values: 3218.7 3262.3 3270.7 3279.6 3295.4 5360.1 5362.8 5390.9 5421.9 5422.7 5405.7 5415.0 5419.3 5440.0 5446.8 4892.8 4896.2 4963.6 5008.9 5081.3 4870.9 4936.6 4939.8 4949.1 4949.9 4922.3 4972.2 4973.8 4990.2 4992.1 4988.8 5021.1 5048.8 5051.7 5070.1 4802.5 4814.4 4875.5 4946.0 4983.6 5337.4 5381.3 5427.3 5442.9 5461.8 5753.5 5764.4 5767.3 5785.1 5797.5 5823.1 5838.8 5856.2 5885.4 5967.5 5491.8 5492.2 5509.3 5524.9 5539.9 5864.1 5969.8 6009.9 6011.5 6061.1 5703.6 5786.9 5796.1 5799.6 5835.7 5811.9 5846.4 5868.4 5871.9 5876.4 5670.9 5785.4 5820.7 5822.9 5824.8 5789.4 5903.1 5906.0 5921.0 5943.0 4460.6 4479.1 4484.1 4486.8 4512.8 3899.3 3899.5 3907.6 3988.8 4059.7 5474.0 5480.2 5482.6 5540.7 5571.4 5793.7 5809.9 5810.3 5829.6 5846.4 5440.6 5440.8 5541.4 5549.6 5636.3 4986.7 5000.8 5000.9 5023.4 5049.1 6006.2 6010.9 6050.1 6065.4 6074.6 5792.8 5867.6 5896.7 5959.6 5967.7 5991.6 6010.8 6016.0 6025.9 6032.5 5554.1 5677.0 5681.1 5697.5 5712.5 5796.9 5870.7 5893.6 5902.2 5908.3 5743.1 5757.3 5774.2 5777.0 5797.2 5553.6 5713.5 5715.0 5749.7 5764.2 5625.5 5651.9 5686.4 5698.9 5700.2 5712.5 5757.3 5772.9 5775.2 5797.2 5543.0 5576.9 5593.1 5677.0 5735.3 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#1] ext.html Cycles:180 Average:56006.08 Median:203094.72 stddev:105841.42 (52.1%) stddev-sans-first:106056.59 00:11:59 INFO - PROCESS | 7427 | Values: 600.9 633.4 645.1 650.6 666.5 32805.7 33532.3 33652.5 39013.6 39937.4 42730.8 43243.7 43444.8 43461.8 43622.3 8094.5 8728.0 8854.4 8866.2 8927.6 10478.8 10806.0 10817.6 10825.3 10842.9 10631.4 10645.0 10678.1 10749.4 10753.0 10462.7 10590.9 10615.4 10621.9 10629.3 10348.8 10428.9 10462.6 10793.2 10812.2 42891.8 43361.8 43527.0 43586.0 43687.6 3811.4 3879.1 3927.9 4286.5 4615.9 32629.7 32872.8 32875.3 32991.7 34390.7 4360.2 4420.6 4425.7 4436.0 4523.2 336734.3 337191.0 339646.0 340392.0 340785.0 38324.6 39108.4 39149.0 65022.3 65513.7 37840.6 37936.4 37986.8 38000.2 38019.6 17753.0 17994.0 18009.5 18026.0 18036.4 13373.9 13461.3 14531.8 15194.9 15241.8 9094.5 9098.5 9132.0 9169.3 9188.4 3568.9 3594.2 3599.4 3622.2 3647.4 1120.9 1131.6 1137.7 1152.0 1251.0 33071.8 33322.7 33472.8 33594.0 33621.3 1207.4 1216.8 1243.4 1273.8 1296.7 16501.7 17551.0 17576.6 17621.5 17810.6 468133.0 482651.0 483278.0 487215.0 488872.0 62756.7 63009.0 63142.7 63204.0 63387.0 1402.1 1497.0 1515.9 1561.8 1568.7 30929.7 33388.5 34353.5 34430.1 34545.0 54041.5 54084.5 54439.5 54782.2 54894.7 363466.0 367106.0 368314.0 368395.0 368923.0 38313.0 41677.8 47046.3 47549.0 47741.8 44058.8 44335.6 44615.1 44998.0 45214.8 37269.8 37755.2 37866.6 37878.4 38468.4 36340.6 37407.6 37975.4 38262.8 38581.8 42150.8 43258.4 43765.6 43906.2 44185.8 35858.8 36767.3 37266.4 37612.4 37652.4 28264.9 28346.0 28416.2 28417.4 28812.3 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#2] jquery.html Cycles:180 Average:29744.21 Median:2230.73 stddev:86400.05 (3873.2%) stddev-sans-first:86614.37 00:11:59 INFO - PROCESS | 7427 | Values: 423.2 428.9 429.1 433.4 435.8 18363.9 19130.3 19158.4 19165.7 20217.8 19656.6 19877.9 20063.6 20098.0 20105.0 5176.9 5355.6 5912.0 5932.1 5935.0 3990.1 4966.4 5193.3 5479.8 5781.5 5792.5 5793.0 5793.6 5797.3 5801.9 5274.7 5572.8 5589.7 5745.6 5759.3 3835.2 5327.4 5464.6 5465.5 5580.3 13327.9 13486.3 13567.6 13616.9 20674.9 2277.2 2390.4 2438.4 2497.6 2564.1 10500.5 10529.4 13174.6 13274.5 14411.3 2019.9 2029.3 2121.6 2218.8 2242.7 74586.6 75254.0 78775.0 79307.2 80562.8 11178.5 11375.6 11537.2 11582.4 11616.7 16349.4 16484.8 16546.5 16634.3 16634.3 8985.8 9094.9 9129.5 9189.6 9368.8 8885.6 8983.9 9132.2 9187.0 9250.1 5039.9 5051.3 5056.5 5069.5 5128.3 1863.9 2012.6 2013.2 2085.0 2086.5 1028.1 1029.1 1035.4 1062.8 1079.9 18741.9 18851.8 18948.7 18983.3 19574.5 1096.3 1110.1 1122.1 1150.8 1174.7 10433.6 10730.3 10795.8 10805.7 10952.1 514235.0 514346.0 524935.0 536492.0 537313.0 88618.6 89973.0 91076.0 92795.5 94307.5 1085.3 1087.2 1096.4 1101.5 1106.8 16063.4 16225.2 16288.7 16541.3 16795.6 38951.4 40592.4 40958.4 41236.4 41391.4 57247.7 57360.7 57619.0 57643.4 57856.4 8644.0 8724.1 8750.2 8874.4 9285.4 9840.1 13449.1 13522.5 13522.5 13614.7 7712.6 11305.5 11464.1 11637.7 11923.8 10753.8 11121.3 11403.3 12291.1 12542.9 12133.6 12225.8 12253.1 12887.8 13222.5 8612.3 8753.9 8900.5 9347.0 9360.9 8748.5 11276.2 11606.4 11731.8 11759.4 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#3] mootools.html Cycles:180 Average:5576.11 Median:5126.21 stddev:3025.04 (59.0%) stddev-sans-first:3017.88 00:11:59 INFO - PROCESS | 7427 | Values: 1482.9 1491.2 1682.6 1834.9 1837.2 8112.3 8239.8 8309.4 8316.9 8356.8 7305.7 8082.6 8192.3 8260.8 8307.3 2290.4 2318.2 2331.3 2335.2 2340.6 2094.7 2268.8 2285.3 2296.3 2311.9 2290.5 2325.4 2340.3 2342.0 2351.6 2329.3 2331.1 2378.2 2396.1 2410.6 2314.5 2325.7 2332.4 2360.8 2369.0 8093.5 8137.9 8141.7 8298.1 8367.3 5126.1 5245.3 5258.2 5259.8 5267.4 3406.6 3427.8 3466.6 3491.5 3492.3 1120.0 1152.6 1164.4 1192.0 1219.8 11515.4 11533.9 11539.9 11592.7 11608.5 4548.0 4552.1 4615.2 4670.7 4752.8 9337.7 9340.9 9347.3 9349.5 9398.7 5219.1 5231.0 5236.9 5251.9 5291.3 4775.3 4792.3 4842.6 4849.2 4863.4 3939.6 4032.9 4072.7 4086.9 4096.2 1208.3 1236.9 1250.8 1315.8 1325.8 987.3 1010.7 1044.1 1059.1 1059.8 5432.1 5486.6 5526.0 5536.3 5600.2 959.8 967.4 982.6 984.3 1000.4 3975.6 4009.2 4045.4 4070.9 4303.0 9843.2 10158.1 10187.4 10200.9 10254.7 9987.8 10039.6 10092.2 10103.6 10108.7 7406.3 7795.4 7837.1 7897.4 7978.4 5758.6 5769.6 5789.7 5833.1 5913.3 9189.4 9327.7 9357.2 9574.1 9613.0 9473.2 9650.5 9667.9 9692.0 9828.6 7933.5 8178.6 8262.6 8272.2 8311.3 8089.1 8128.8 8139.3 8160.4 8179.8 7133.6 7188.7 7314.1 7415.1 7420.4 7130.9 7174.6 7178.3 7193.6 7222.3 6783.5 6790.4 6797.7 6803.5 6821.3 4865.9 4940.3 4986.4 4988.1 5030.8 5071.4 5115.0 5126.3 5126.8 5222.1 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#4] prototype.html Cycles:180 Average:5485.10 Median:6190.87 stddev:1641.25 (26.5%) stddev-sans-first:1599.92 00:11:59 INFO - PROCESS | 7427 | Values: 347.9 354.2 356.1 358.2 359.2 6087.8 6100.2 6106.1 6143.4 6227.5 5880.6 5987.6 6093.3 6130.7 6146.4 4706.7 4716.1 4758.9 4765.4 4775.3 4753.0 4778.5 4778.7 4779.5 4786.4 4528.8 4619.6 4731.0 4742.0 4748.4 4719.7 4719.9 4734.4 4748.1 4748.6 4181.8 4185.1 4186.4 4186.9 4187.6 5905.2 5911.0 5920.7 5922.0 5940.0 5459.4 5477.1 5483.4 5490.3 5508.9 6351.1 6461.9 6471.0 6481.5 6489.3 4607.7 4625.4 4629.3 4634.7 4642.4 6734.0 6736.4 6759.6 6759.6 6761.9 4728.2 4738.5 4739.1 4744.9 4746.6 4749.5 4795.6 4804.9 4810.2 4810.4 5413.1 5519.0 5528.9 5534.3 5541.1 6508.8 6580.4 6587.4 6588.8 6590.6 1609.7 1673.3 1691.1 1691.9 1698.6 1113.3 1121.8 1139.0 1139.9 1148.6 6191.2 6198.7 6210.1 6246.6 6259.2 6657.9 6664.1 6673.8 6680.3 6682.4 6179.5 6190.6 6212.9 6213.8 6237.7 3537.0 3577.9 3582.9 3586.4 3608.0 6830.0 6916.8 6970.3 7042.8 7104.4 6916.1 6922.1 6925.9 6932.6 6935.7 7059.8 7072.9 7086.4 7089.1 7092.7 6727.6 6729.5 6732.4 6738.6 6749.5 6550.9 6692.3 6693.0 6694.4 6696.2 7011.7 7043.8 7046.8 7057.6 7069.6 4603.0 4613.7 4649.3 4650.7 4666.0 6773.7 6776.3 6806.1 6819.7 6833.2 6297.6 6421.7 6526.6 6546.0 6628.3 6561.3 6564.0 6576.5 6580.8 6586.7 6427.1 6450.8 6464.3 6471.1 6508.8 6491.1 6631.1 6639.0 6661.1 6669.5 6432.6 6472.4 6492.0 6502.3 6503.7 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - PROCESS | 7427 | [#5] yui.html Cycles:180 Average:15334.50 Median:46966.50 stddev:17596.48 (37.5%) stddev-sans-first:17612.09 00:11:59 INFO - PROCESS | 7427 | Values: 819.4 820.6 823.8 845.5 856.5 14158.2 14315.9 14781.4 14808.5 14852.5 13300.3 13315.3 13398.7 13405.0 13467.7 746.1 878.9 889.2 895.8 898.2 890.6 898.3 901.5 902.1 904.3 782.5 934.1 936.0 940.9 940.9 918.5 934.1 935.9 938.2 938.7 678.8 682.3 684.5 686.4 686.8 14292.1 14309.3 14341.7 14359.1 14394.0 13568.6 14347.6 14723.7 14729.0 15008.6 11598.4 11859.9 11926.9 11949.8 12028.8 3886.7 3904.5 3985.9 4001.1 4006.2 53776.5 57152.4 57334.7 57599.4 57643.1 10510.6 10666.5 10888.6 10938.9 11019.3 19341.0 19392.3 19489.1 19529.6 19944.6 8351.5 8436.9 8440.1 8544.0 8656.6 4796.5 4809.8 4830.3 4970.8 4977.8 3281.2 3362.3 3373.6 3374.8 3378.2 602.0 619.9 634.2 641.5 646.5 659.5 684.4 710.3 715.4 719.8 9069.4 9158.5 9240.6 9511.0 9706.9 689.9 725.1 727.1 739.7 742.4 4321.5 4380.0 4448.8 4540.2 4597.4 59020.0 60676.7 60958.4 61341.4 64920.0 52797.5 54232.5 55966.7 59514.7 59607.7 47857.0 49782.3 50653.0 51504.2 51829.2 9660.3 9672.2 9710.7 9742.0 9834.1 35900.5 37406.3 38639.2 38828.6 39117.8 46076.0 49919.0 50193.0 50537.7 51512.7 11572.5 11663.5 11730.8 11823.2 12644.4 13365.1 14187.9 14268.9 14481.0 14673.1 13151.7 13332.9 13509.0 13609.7 13840.8 13394.1 13549.9 13553.9 13559.1 13681.7 13164.5 13215.4 13556.7 13630.2 13674.9 11183.3 11195.2 11323.6 11482.0 11545.2 10956.3 11214.9 11410.3 11440.4 11554.7 00:11:59 INFO - PROCESS | 7427 | -------- Summary: end -------- 00:11:59 INFO - PROCESS | 7427 | 00:11:59 INFO - TEST-INFO | 7427: exit 0 00:11:59 INFO - TEST-OK | dromaeo_css | took 1108466ms 00:11:59 INFO - TEST-START | kraken 00:11:59 INFO - operating with platform_type : linux_ 00:11:59 INFO - Initialising browser for kraken test... 00:11:59 INFO - TEST-INFO | started process 7616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGKkGL/profile http://localhost:42844/getInfo.html) 00:12:02 INFO - PROCESS | 7616 | __metrics Screen width/height:1600/1200 00:12:02 INFO - PROCESS | 7616 | colorDepth:24 00:12:02 INFO - PROCESS | 7616 | Browser inner width/height: 1024/697 00:12:02 INFO - PROCESS | 7616 | __metrics 00:12:03 ERROR - PROCESS | 7616 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:12:04 INFO - TEST-INFO | 7616: exit 0 00:12:04 INFO - Browser initialized. 00:12:04 INFO - Running cycle 1/1 for kraken test... 00:12:04 INFO - TEST-INFO | started process 7707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnGKkGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:12:15 INFO - PROCESS | 7707 | RSS: Main: 140935168 00:12:15 INFO - PROCESS | 7707 | 00:12:17 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-beat-detection) 00:12:18 INFO - PROCESS | 7707 | RSS: Main: 195792896 00:12:18 INFO - PROCESS | 7707 | 00:12:21 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-dft) 00:12:22 INFO - PROCESS | 7707 | RSS: Main: 181006336 00:12:22 INFO - PROCESS | 7707 | 00:12:24 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-fft) 00:12:25 INFO - PROCESS | 7707 | RSS: Main: 271933440 00:12:25 INFO - PROCESS | 7707 | 00:12:27 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-oscillator) 00:12:28 INFO - PROCESS | 7707 | RSS: Main: 178810880 00:12:28 INFO - PROCESS | 7707 | 00:12:30 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:12:30 INFO - PROCESS | 7707 | RSS: Main: 176775168 00:12:30 INFO - PROCESS | 7707 | 00:12:33 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-darkroom) 00:12:34 INFO - PROCESS | 7707 | RSS: Main: 211349504 00:12:34 INFO - PROCESS | 7707 | 00:12:37 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-desaturate) 00:12:38 INFO - PROCESS | 7707 | RSS: Main: 211243008 00:12:38 INFO - PROCESS | 7707 | 00:12:41 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42844/tests/kraken/driver.html?testName=json-parse-financial) 00:12:41 INFO - PROCESS | 7707 | RSS: Main: 210931712 00:12:41 INFO - PROCESS | 7707 | 00:12:43 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:12:43 INFO - PROCESS | 7707 | RSS: Main: 190709760 00:12:43 INFO - PROCESS | 7707 | 00:12:45 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:12:45 INFO - PROCESS | 7707 | RSS: Main: 193880064 00:12:45 INFO - PROCESS | 7707 | 00:12:47 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:12:48 INFO - PROCESS | 7707 | RSS: Main: 208302080 00:12:48 INFO - PROCESS | 7707 | 00:12:51 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:12:51 INFO - PROCESS | 7707 | RSS: Main: 209473536 00:12:51 INFO - PROCESS | 7707 | 00:12:54 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:12:54 INFO - PROCESS | 7707 | RSS: Main: 205742080 00:12:54 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42844/tests/kraken/driver.html?testName=ai-astar) 00:12:56 INFO - PROCESS | 7707 | RSS: Main: 269606912 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | __start_tp_report 00:12:56 INFO - PROCESS | 7707 | _x_x_mozilla_page_load 00:12:56 INFO - PROCESS | 7707 | _x_x_mozilla_page_load_details 00:12:56 INFO - PROCESS | 7707 | |i|pagename|runs| 00:12:56 INFO - PROCESS | 7707 | |0;ai-astar;113;112;111;113;111;113;109;111;110;110 00:12:56 INFO - PROCESS | 7707 | |1;audio-beat-detection;164;142;164;179;135;154;156;143;183;136 00:12:56 INFO - PROCESS | 7707 | |2;audio-dft;163;165;171;161;163;166;164;163;161;164 00:12:56 INFO - PROCESS | 7707 | |3;audio-fft;78;78;75;170;76;77;74;76;171;80 00:12:56 INFO - PROCESS | 7707 | |4;audio-oscillator;92;94;146;101;94;93;139;93;94;145 00:12:56 INFO - PROCESS | 7707 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;118;117;117 00:12:56 INFO - PROCESS | 7707 | |6;imaging-darkroom;149;148;149;148;148;148;147;148;147;148 00:12:56 INFO - PROCESS | 7707 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;97;95 00:12:56 INFO - PROCESS | 7707 | |8;json-parse-financial;56;56;55;56;56;55;56;69;53;56 00:12:56 INFO - PROCESS | 7707 | |9;json-stringify-tinderbox;57;58;60;58;58;57;57;59;58;57 00:12:56 INFO - PROCESS | 7707 | |10;stanford-crypto-aes;75;75;75;77;76;81;79;76;78;80 00:12:56 INFO - PROCESS | 7707 | |11;stanford-crypto-ccm;125;120;121;118;119;117;116;125;190;120 00:12:56 INFO - PROCESS | 7707 | |12;stanford-crypto-pbkdf2;168;165;165;165;166;170;165;166;167;166 00:12:56 INFO - PROCESS | 7707 | |13;stanford-crypto-sha256-iterative;70;68;68;68;71;68;67;67;69;67 00:12:56 INFO - PROCESS | 7707 | __end_tp_report 00:12:56 INFO - PROCESS | 7707 | __start_cc_report 00:12:56 INFO - PROCESS | 7707 | _x_x_mozilla_cycle_collect,1452 00:12:56 INFO - PROCESS | 7707 | __end_cc_report 00:12:56 INFO - PROCESS | 7707 | __startTimestamp1463037176817__endTimestamp 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | ------- Summary: start ------- 00:12:56 INFO - PROCESS | 7707 | Number of tests: 14 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:1.42 (1.3%) stddev-sans-first:1.36 00:12:56 INFO - PROCESS | 7707 | Values: 113.0 112.0 111.0 113.0 111.0 113.0 109.0 111.0 110.0 110.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:160.00 stddev:16.98 (10.6%) stddev-sans-first:17.73 00:12:56 INFO - PROCESS | 7707 | Values: 164.0 142.0 164.0 179.0 135.0 154.0 156.0 143.0 183.0 136.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.03 00:12:56 INFO - PROCESS | 7707 | Values: 163.0 165.0 171.0 161.0 163.0 166.0 164.0 163.0 161.0 164.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.50 stddev:39.56 (51.7%) stddev-sans-first:41.46 00:12:56 INFO - PROCESS | 7707 | Values: 78.0 78.0 75.0 170.0 76.0 77.0 74.0 76.0 171.0 80.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:93.00 stddev:23.82 (25.6%) stddev-sans-first:24.44 00:12:56 INFO - PROCESS | 7707 | Values: 92.0 94.0 146.0 101.0 94.0 93.0 139.0 93.0 94.0 145.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 00:12:56 INFO - PROCESS | 7707 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 117.0 117.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 00:12:56 INFO - PROCESS | 7707 | Values: 149.0 148.0 149.0 148.0 148.0 148.0 147.0 148.0 147.0 148.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 00:12:56 INFO - PROCESS | 7707 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 97.0 95.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:4.39 (7.8%) stddev-sans-first:4.65 00:12:56 INFO - PROCESS | 7707 | Values: 56.0 56.0 55.0 56.0 56.0 55.0 56.0 69.0 53.0 56.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:1.00 00:12:56 INFO - PROCESS | 7707 | Values: 57.0 58.0 60.0 58.0 58.0 57.0 57.0 59.0 58.0 57.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:2.20 (2.8%) stddev-sans-first:2.19 00:12:56 INFO - PROCESS | 7707 | Values: 75.0 75.0 75.0 77.0 76.0 81.0 79.0 76.0 78.0 80.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:120.50 stddev:22.30 (18.5%) stddev-sans-first:23.64 00:12:56 INFO - PROCESS | 7707 | Values: 125.0 120.0 121.0 118.0 119.0 117.0 116.0 125.0 190.0 120.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:1.64 (1.0%) stddev-sans-first:1.62 00:12:56 INFO - PROCESS | 7707 | Values: 168.0 165.0 165.0 165.0 166.0 170.0 165.0 166.0 167.0 166.0 00:12:56 INFO - PROCESS | 7707 | 00:12:56 INFO - PROCESS | 7707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 00:12:56 INFO - PROCESS | 7707 | Values: 70.0 68.0 68.0 68.0 71.0 68.0 67.0 67.0 69.0 67.0 00:12:56 INFO - PROCESS | 7707 | -------- Summary: end -------- 00:12:56 INFO - PROCESS | 7707 | 00:12:57 INFO - TEST-INFO | 7707: exit 0 00:12:57 INFO - TEST-OK | kraken | took 57805ms 00:12:57 INFO - SUITE-END | took 1166s 00:12:57 INFO - Completed test suite (00:19:26) 00:12:57 INFO - javascript benchmark 00:12:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3218.7103160715533, 3262.33122209947, 3270.738340932726, 3279.5900512435946, 3295.3574053059647, 5360.142377219646, 5362.8123015694455, 5390.8921821563545, 5421.9457805421935, 5422.728863556817, 5405.675659460435, 5414.972925135378, 5419.3225846769155, 5440.020796256672, 5446.782128714856, 4892.77982490787, 4896.216605343146, 4963.627727920402, 5008.874778130539, 5081.314022606938, 4870.902581948359, 4936.605071594282, 4939.753012349386, 4949.109160351135, 4949.925751113737, 4922.286268491067, 4972.154733695281, 4973.801047958095, 4990.176620857555, 4992.076465853828, 4988.775505102279, 5021.096202683516, 5048.848534543933, 5051.747412629391, 5070.062038522867, 4802.471728109905, 4814.446338671028, 4875.488073752241, 4945.950540494585, 4983.6013118950395, 5337.412884582693, 5381.327334083239, 5427.267318911936, 5442.91835622466, 5461.808836690737, 5753.539716822686, 5764.394738552475, 5767.279090113736, 5785.062004228588, 5797.536197104221, 5823.097419899922, 5838.824835254906, 5856.180134781134, 5885.440883116097, 5967.492763115097, 5491.780328786844, 5492.231087647732, 5509.311336082989, 5524.889502209933, 5539.861503462405, 5864.149698293809, 5969.820905372846, 6009.909851352233, 6011.48902343297, 6061.090836374579, 5703.62926409782, 5786.855328616734, 5796.101604251347, 5799.5650326225705, 5835.737391817378, 5811.883762324815, 5846.386129456346, 5868.354481007086, 5871.943050250996, 5876.353601103875, 5670.943290567042, 5785.392533783976, 5820.708964551755, 5822.883542329215, 5824.796132135355, 5789.363170051291, 5903.085021821625, 5906.0, 5920.993431116721, 5943.049112142036, 4460.598546130799, 4479.10417916418, 4484.12559550891, 4486.798094085774, 4512.751798651106, 3899.2591407633026, 3899.454076429302, 3907.5701672815967, 3988.80055997199, 4059.7361171523758, 5474.0146773580345, 5480.205370221375, 5482.643628164156, 5540.695261760642, 5571.4428557143965, 5793.7392817323325, 5809.883802324014, 5810.302763668386, 5829.621074630136, 5846.41535846412, 5440.564754819605, 5440.7551660174595, 5541.362743284574, 5549.556035517149, 5636.267285252891, 4986.675866068694, 5000.774965126578, 5000.899982000413, 5023.422306434733, 5049.116404629175, 6006.189164462741, 6010.879782404328, 6050.092486127028, 6065.363136870653, 6074.605150665193, 5792.768289268382, 5867.559933004956, 5896.675682837314, 5959.553033522589, 5967.7016149191495, 5991.580589358703, 6010.789622363196, 6016.0, 6025.87948241024, 6032.457078862748, 5554.111342185231, 5677.006523858391, 5681.062624667049, 5697.458741419724, 5712.485876271156, 5796.913046304225, 5870.677112758839, 5893.5874488787085, 5902.2327097477055, 5908.320543137423, 5743.138529220483, 5757.280339957505, 5774.162746401832, 5776.971115144565, 5797.159411885337, 5553.583481239004, 5713.514351280188, 5714.971305165111, 5749.683767392834, 5764.164196191613, 5625.549956003428, 5651.943480565142, 5686.43135686428, 5698.857528561819, 5700.230468886647, 5712.457316554921, 5757.280339957505, 5772.94227057724, 5775.220345253337, 5797.246357973437, 5542.974549708317, 5576.944230557642, 5593.07714227148, 5676.971615141898, 5735.340435849931], "value": 5385.966273600318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9188759517464, 633.4204203154114, 645.0678769178533, 650.6161364794771, 666.4768156996762, 32805.67194328056, 33532.32935341292, 33652.4952125718, 39013.60986390142, 39937.40093898594, 42730.78634606831, 43243.70268891938, 43444.782776086075, 43461.7826910865, 43622.34566481505, 8094.473859199134, 8727.956360218206, 8854.424462409956, 8866.246369058637, 8927.598258078402, 10478.790424191511, 10806.0, 10817.621383251588, 10825.296355736891, 10842.891571084267, 10631.36211827289, 10645.0, 10678.092362149227, 10749.355038697704, 10753.0, 10462.686119416392, 10590.894091059106, 10615.416152111631, 10621.893781062168, 10629.255952083357, 10348.79302413955, 10428.947855260674, 10462.63380781669, 10793.244472886901, 10812.243142979994, 42891.78554107241, 43361.783191084156, 43527.0, 43586.0, 43687.563124368666, 3811.447340135665, 3879.0884142226555, 3927.892702435826, 4286.535678172779, 4615.884602884921, 32629.67370326314, 32872.83563582191, 32875.342493150245, 32991.6700832991, 34390.65609343899, 4360.171567402183, 4420.58004489573, 4425.690201685883, 4436.0462500562535, 4523.231050721385, 336734.31632841926, 337191.0, 339646.0, 340392.0, 340785.0, 38324.61675383266, 39108.41337379941, 39149.042547872494, 65022.34977650163, 65513.67243163754, 37840.62159378426, 37936.43095353572, 37986.81006595005, 38000.23999519994, 38019.61980380216, 17753.0, 17994.0, 18009.549761256072, 18026.0, 18036.368727094752, 13373.933130334286, 13461.326933653278, 14531.78202326966, 15194.924025379802, 15241.847581524265, 9094.454332740057, 9098.499582523025, 9131.954340228256, 9169.312301577409, 9188.448693078437, 3568.928621427557, 3594.155373487228, 3599.3881040223223, 3622.2031153146268, 3647.398179300386, 1120.8598925134359, 1131.6039386214923, 1137.6643890052455, 1151.9769604607861, 1250.956216532417, 33071.834640826644, 33322.67764202875, 33472.83263583667, 33594.0, 33621.32757344839, 1207.4204381896739, 1216.8053111502118, 1243.4093805442524, 1273.7898246789362, 1296.6758310422395, 16501.69276133561, 17551.0, 17576.648467030842, 17621.471355859343, 17810.643787124183, 468133.0, 482651.0, 483278.0, 487215.0, 488872.0, 62756.686216568625, 63009.0, 63142.684286578275, 63204.0, 63387.0, 1402.144691738039, 1496.9700605987819, 1515.909045457276, 1561.7735428362596, 1568.654895922895, 30929.69070309358, 33388.49917251195, 34353.48469772905, 34430.13924651803, 34545.0, 54041.459585403645, 54084.459155407945, 54439.455605443436, 54782.178267325224, 54894.72552637211, 363466.0, 367106.0, 368314.0, 368395.0, 368923.0, 38313.0, 41677.79161104175, 47046.29430558476, 47549.0, 47741.761291193325, 44058.77970610127, 44335.55664443443, 44615.10769784651, 44998.03512891052, 45214.77392613016, 37269.813650931574, 37755.24489510249, 37866.62133378631, 37878.431823522114, 38468.42297365486, 36340.63659363478, 37407.625923740416, 37975.43036854504, 38262.80868595639, 38581.807090964365, 42150.78924605357, 43258.35112473378, 43765.56234437615, 43906.21411381755, 44185.779071104436, 35858.8207058963, 36767.26465470622, 37266.441003384425, 37612.435813462274, 37652.43521347237, 28264.85867570649, 28346.0, 28416.234724658974, 28417.432217143993, 28812.279693007844], "value": 19854.729062981307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.2043757735457, 428.9292266775982, 429.11602099674656, 433.4408612889373, 435.78864250838336, 18363.908180459097, 19130.33043843466, 19158.425247242587, 19165.712514312298, 20217.797822021814, 19656.60686786267, 19877.900610496927, 20063.59872802543, 20098.0, 20105.0, 5176.896462070757, 5355.6251062425645, 5911.970440147793, 5932.050871860503, 5935.020721580934, 3990.1421194443187, 4966.379202599675, 5193.298904647881, 5479.835604931858, 5781.508571771405, 5792.507636850873, 5792.971035144818, 5793.594448388614, 5797.3043234811885, 5801.9129713054335, 5274.709890955976, 5572.804951826707, 5589.74846131925, 5745.6265342752795, 5759.337676167232, 3835.17543728097, 5327.387350454708, 5464.644798088151, 5465.535429488498, 5580.302462192226, 13327.866721332759, 13486.325683715873, 13567.59297221085, 13616.93191534036, 20674.896625516925, 2277.191596983064, 2390.426297688542, 2438.426969662128, 2497.5629264878576, 2564.1410127607087, 10500.474976251233, 10529.420881851494, 13174.60476185716, 13274.535391261259, 14411.279436028157, 2019.9495012624654, 2029.3201777404588, 2121.6075026120216, 2218.7892150245702, 2242.6636004599277, 74586.62706686486, 75254.0, 78775.03062423428, 79307.20692793056, 80562.79155812727, 11178.496967636476, 11375.601853935073, 11537.173392518718, 11582.420878956018, 11616.709582260512, 16349.427770027993, 16484.752728709078, 16546.503604891874, 16634.3346266148, 16634.33462661504, 8985.820283594292, 9094.86357704635, 9129.543522823833, 9189.586468608795, 9368.812623747623, 8885.600147993357, 8983.910160898438, 9132.178103970675, 9186.954065229631, 9250.121238482334, 5039.874003149877, 5051.318072060299, 5056.494350564988, 5069.493050694901, 5128.333316668809, 1863.9440816775518, 2012.577358754678, 2013.1947221111673, 2084.989575052115, 2086.530530630596, 1028.0695970147028, 1029.1237036521545, 1035.404642330648, 1062.7715041266165, 1079.9244052916379, 18741.90629046846, 18851.811481885004, 18948.715769263472, 18983.33558325452, 19574.5106372339, 1096.276457538021, 1110.0675432636463, 1122.074288711816, 1150.7583407484522, 1174.6593487888417, 10433.634822781167, 10730.302530335503, 10795.78408431827, 10805.675829725122, 10952.123830093573, 514235.0, 514346.0, 524935.0, 536492.0, 537313.0, 88618.55690721505, 89973.0, 91076.0, 92795.47261119663, 94307.52846235725, 1085.3270971997413, 1087.228068071678, 1096.3641088168683, 1101.5098281264761, 1106.8339749037548, 16063.437779677655, 16225.18874056269, 16288.674226515166, 16541.25564349583, 16795.580110496845, 38951.41572876466, 40592.39111413272, 40958.385624215065, 41236.38145427881, 41391.37912931369, 57247.713761430925, 57360.71319643375, 57619.0, 57643.423565765486, 57856.4214357851, 8644.049154592863, 8724.127587241479, 8750.212480876751, 8874.378793484395, 9285.396449230779, 9840.065193806577, 13449.125806822525, 13522.459101636217, 13522.526711565048, 13614.659633509242, 7712.5758083305955, 11305.491252893475, 11464.140189485988, 11637.650870473899, 11923.82114268304, 10753.784924301626, 11121.332720036824, 11403.31580105163, 12291.078169137529, 12542.874571254171, 12133.575324863587, 12225.816612750637, 12253.081018923438, 12887.80668289995, 13222.471101155847, 8612.311015118901, 8753.868691969752, 8900.510471924106, 9347.018563050782, 9360.859587106062, 8748.518831464076, 11276.210665253353, 11606.419679015846, 11731.765364692828, 11759.412029398667], "value": 9327.985745921422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.866542011219, 1491.2022068193519, 1682.5541231573627, 1834.8990805505691, 1837.2375464182364, 8112.269895709385, 8239.794005149874, 8309.418340716153, 8316.875246871294, 8356.791080222989, 7305.6712447939835, 8082.555459449728, 8192.262696357328, 8260.752177434671, 8307.252347288742, 2290.4273931517123, 2318.246569864792, 2331.25399872041, 2335.2060299498166, 2340.5903966805827, 2094.6543820269712, 2268.750437451879, 2285.337252196861, 2296.2651951375565, 2311.861288322706, 2290.5189910118893, 2325.4418939454577, 2340.262817212581, 2341.9648705269433, 2351.6002279612508, 2329.26628112145, 2331.1374791327235, 2378.203301893868, 2396.0535588442467, 2410.5781488239663, 2314.502381987864, 2325.6511523271474, 2332.4052366646565, 2360.799332056777, 2369.028698233733, 8093.473924194908, 8137.918620813775, 8141.715039973573, 8298.128696486843, 8367.330613550901, 5126.102931986925, 5245.26566280721, 5258.211268309746, 5259.789608415659, 5267.367915850123, 3406.5741782277214, 3427.7771944823508, 3466.636003219651, 3491.458823882277, 3492.3189977954307, 1119.9552017919273, 1152.6196355202762, 1164.441068287227, 1192.0, 1219.8048312269993, 11515.36665483398, 11533.884661153448, 11539.942300288529, 11592.710182245428, 11608.535658573646, 4547.954520454753, 4552.135094332067, 4615.215413379734, 4670.696404733681, 4752.7623618818925, 9337.673181438617, 9340.906590934139, 9347.252219822398, 9349.485778282124, 9398.718038458857, 5219.112750832292, 5231.032259032091, 5236.895262094737, 5251.868703282448, 5291.312129423227, 4775.283707443911, 4792.2811578262845, 4842.58837998774, 4849.199882019428, 4863.392075990501, 3939.6454319111417, 4032.8790136295956, 4072.6538244249573, 4086.8773936781945, 4096.201240758083, 1208.3173007250875, 1236.8515778106505, 1250.787366147757, 1315.7828958221787, 1325.787873940165, 987.274353350287, 1010.6917390196061, 1044.1333693034762, 1059.1315121600214, 1059.8251288537458, 5432.103702889058, 5486.561075113981, 5526.0, 5536.335639723259, 5600.215969764236, 959.7744530035436, 967.3591096306981, 982.5774916785708, 984.3404918704485, 1000.3747657713928, 3975.6421922027157, 4009.1981603679383, 4045.4336392905016, 4070.898227544335, 4302.978485107617, 9843.212542996544, 10158.13655839262, 10187.439690816927, 10200.948995254976, 10254.743631409274, 9987.80024399508, 10039.598416063422, 10092.192624590016, 10103.64637237708, 10108.696739097839, 7406.333429991327, 7795.376369890395, 7837.05955285358, 7897.368210543143, 7978.441509094424, 5758.568107392046, 5769.624974376652, 5789.681567513827, 5833.125031245348, 5913.290405151237, 9189.356745027784, 9327.720168394959, 9357.157855793012, 9574.090461406155, 9613.0, 9473.194778443909, 9650.517474126405, 9667.854982175133, 9691.951540242253, 9828.606855725977, 7933.523988560705, 8178.550179740171, 8262.628181731716, 8272.17278272192, 8311.335093192409, 8089.110197878111, 8128.83742325162, 8139.348852091937, 8160.428769986044, 8179.813926980673, 7133.607651579213, 7188.676509556978, 7314.08573928259, 7415.1101867776215, 7420.406367490696, 7130.857382852418, 7174.605396703231, 7178.318059784312, 7193.640317983975, 7222.313880181375, 6783.525153239226, 6790.354916282945, 6797.66011699423, 6803.489738269551, 6821.283765204582, 4865.878353041061, 4940.308356829974, 4986.401631804207, 4988.102141614544, 5030.84907452777, 5071.39143302806, 5114.974425127851, 5126.307948427064, 5126.769295381642, 5222.060029194781], "value": 4549.836868602923, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.892153432436, 354.2383874669462, 356.13104026176126, 358.1601145314238, 359.1828589957845, 6087.817365479043, 6100.23747031621, 6106.084087386894, 6143.38566143386, 6227.47066499347, 5880.5883588148845, 5987.6407415555095, 6093.329733729297, 6130.693465326738, 6146.385361463851, 4706.670533062687, 4716.103940251359, 4758.857234282977, 4765.404324459442, 4775.3075804008395, 4752.976235118819, 4778.450478195, 4778.665493415462, 4779.474257831635, 4786.425628924534, 4528.796204170803, 4619.5611416915335, 4730.97634511827, 4741.9525804742025, 4748.430188377382, 4719.693219940727, 4719.882002949954, 4734.360861283717, 4748.07412554552, 4748.643851711118, 4181.790910454465, 4185.100203456241, 4186.392973018896, 4186.91626167475, 4187.644050255732, 5905.232319798399, 5911.0, 5920.733566989496, 5922.0, 5940.0, 5459.3994660587305, 5477.096279113942, 5483.424240454735, 5490.3411590609385, 5508.91736623951, 6351.142595749561, 6461.903071453885, 6471.0, 6481.546291759579, 6489.318621544717, 4607.746573938432, 4625.421822272216, 4629.305604159369, 4634.72191668501, 4642.3500709900645, 6734.0, 6736.393724564813, 6759.594424334556, 6759.628220447873, 6761.864762704768, 4728.219843725816, 4738.47876733559, 4739.052189562101, 4744.905101897943, 4746.620270378361, 4749.501302363271, 4795.640326975491, 4804.903901921942, 4810.182269014276, 4810.39870016248, 5413.079776438015, 5519.034169020405, 5528.9494995950645, 5534.280543529316, 5541.0580201365865, 6508.772192973318, 6580.440662543738, 6587.374199451045, 6588.835279117964, 6590.5716128451495, 1609.6780643871273, 1673.3055781850396, 1691.0952640337607, 1691.9492415227562, 1698.6156282629863, 1113.3431275547466, 1121.814900541418, 1138.971525711864, 1139.9088072954144, 1148.6496618531428, 6191.1641928339095, 6198.721057552421, 6210.068489726577, 6246.593971391845, 6259.217597800275, 6657.866842663119, 6664.133662623828, 6673.766418175341, 6680.331966803281, 6682.365175308338, 6179.5056395488255, 6190.566660333733, 6212.875742485125, 6213.844653883689, 6237.719302631393, 3536.964630353715, 3577.94633080504, 3582.8566857325413, 3586.408242639935, 3607.981960090183, 6829.965850170717, 6916.827079322957, 6970.302969703091, 7042.823929401703, 7104.360607545243, 6916.135483064617, 6922.134733158356, 6925.896111558331, 6932.61870597122, 6935.722571097201, 7059.788206353817, 7072.92927070733, 7086.39765619928, 7089.078419805495, 7092.680829362691, 6727.629980351127, 6729.528932974645, 6732.42774364165, 6738.561993470409, 6749.493787965824, 6550.868982620416, 6692.330766923464, 6692.966535167293, 6694.364035416627, 6696.19645642526, 7011.719531218694, 7043.7534686285735, 7046.788596342118, 7057.576545407292, 7069.575825450489, 4602.976985115053, 4613.67704260712, 4649.325847752125, 4650.744209068534, 4665.953340466552, 6773.729050837911, 6776.28848970851, 6806.115205023315, 6819.659017049227, 6833.180018397824, 6297.590656607306, 6421.743130274924, 6526.608403495806, 6545.985372267306, 6628.337166283526, 6561.311062338576, 6563.967180164069, 6576.473882089325, 6580.76967306142, 6586.70359833799, 6427.100205971261, 6450.8064758057335, 6464.321246269074, 6471.126397936407, 6508.837279068061, 6491.123698300669, 6631.1379520662, 6638.966805165944, 6661.100751398693, 6669.533132680665, 6432.614043157426, 6472.35276472349, 6491.961286194186, 6502.252240992158, 6503.707333169924], "value": 4954.865130397254, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.4223072733723, 820.6389188756947, 823.7899335669404, 845.4758050008987, 856.4946681457939, 14158.15051096935, 14315.856841431583, 14781.408743650269, 14808.481703140393, 14852.48016319429, 13300.268485233308, 13315.267660278681, 13398.732025359512, 13405.0, 13467.730645387086, 746.0599644447981, 878.8505953987838, 889.2397000564521, 895.7671005538574, 898.1557336104074, 890.6081324217356, 898.2858627391207, 901.5086777706133, 902.0708670069838, 904.2810965282583, 782.4992005116729, 934.0705997532465, 936.0218571592668, 940.8588711693233, 940.9482478463716, 918.4856480371013, 934.0612684252351, 935.9344845860827, 938.1650331205199, 938.6573900526258, 678.8268991407209, 682.2938258902062, 684.5379368926004, 686.37539838747, 686.7802303262957, 14292.07101538407, 14309.28453577317, 14341.713165736732, 14359.138451692932, 14394.0, 13568.59294221175, 14347.56957291283, 14723.705525889529, 14729.0, 15008.624784380478, 11598.362090085042, 11859.88140118605, 11926.940365298206, 11949.761004779943, 12028.819567706492, 3886.689064874803, 3904.4533765272886, 3985.940210896839, 4001.079751657135, 4006.1587066716024, 53776.462235377534, 57152.42847571554, 57334.71332643352, 57599.42400575982, 57643.13535296974, 10510.579576816994, 10666.520006599721, 10888.564457421615, 10938.945305273583, 11019.338839669485, 19341.0, 19392.321268755808, 19489.122989465508, 19529.609407811764, 19944.60110797776, 8351.457155284887, 8436.915630843612, 8440.071592124861, 8544.0, 8656.567171641393, 4796.496367881392, 4809.831655892097, 4830.3237546743485, 4970.826021089317, 4977.800887964441, 3281.196106953764, 3362.310726301151, 3373.578302712161, 3374.8481318340732, 3378.223008707962, 601.9969900150471, 619.9039148931922, 634.2040738872686, 641.5477088652489, 646.524804268862, 659.4691273524859, 684.3532861445885, 710.2932582080863, 715.4240836126863, 719.76967370442, 9069.41048831837, 9158.542072896329, 9240.584173712065, 9510.952445237868, 9706.854397184048, 689.899964505154, 725.1443296909697, 727.1092911183757, 739.7004213293625, 742.387530287515, 4321.546237645065, 4380.014496738208, 4448.822047118079, 4540.182767101954, 4597.42532183477, 59020.0, 60676.69661651752, 60958.39041609616, 61341.386586133565, 64920.0, 52797.472025280025, 54232.45767542353, 55966.72016639891, 59514.70242648759, 59607.70196148992, 47857.0, 49782.253266201034, 50653.0, 51504.22743658848, 51829.222561661605, 9660.275479339218, 9672.177864881563, 9710.70867873965, 9741.951290243504, 9834.114929656365, 35900.461493078146, 37406.2518749618, 38639.22721545497, 38828.61171388363, 39117.80441097776, 46076.0, 49919.0, 50193.0, 50537.74731126321, 51512.742436287575, 11572.479238434122, 11663.475143618727, 11730.824037639613, 11823.172377933462, 12644.431000605178, 13365.131266467648, 14187.858121419067, 14268.928655356656, 14481.0, 14673.119612823264, 13151.671208219872, 13332.93333533326, 13509.0, 13609.727805443637, 13840.792388114387, 13394.129381590166, 13549.932250338685, 13553.86446135526, 13559.118657287245, 13681.657958551115, 13164.47342106305, 13215.405306761026, 13556.728865422834, 13630.182189068688, 13674.863251367358, 11183.32900026001, 11195.216334856483, 11323.603673871376, 11482.0, 11545.191836571359, 10956.34261944286, 11214.887851121384, 11410.315381077162, 11440.427978601203, 11554.711132221762], "value": 7002.306045213273, "unit": "score"}], "name": "dromaeo_css", "value": 7348.589158604826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 113.0, 111.0, 113.0, 109.0, 111.0, 110.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 142.0, 164.0, 179.0, 135.0, 154.0, 156.0, 143.0, 183.0, 136.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 171.0, 161.0, 163.0, 166.0, 164.0, 163.0, 161.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 170.0, 76.0, 77.0, 74.0, 76.0, 171.0, 80.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 146.0, 101.0, 94.0, 93.0, 139.0, 93.0, 94.0, 145.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 69.0, 53.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 60.0, 58.0, 58.0, 57.0, 57.0, 59.0, 58.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 77.0, 76.0, 81.0, 79.0, 76.0, 78.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 121.0, 118.0, 119.0, 117.0, 116.0, 125.0, 190.0, 120.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 165.0, 166.0, 170.0, 165.0, 166.0, 167.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 68.0, 71.0, 68.0, 67.0, 67.0, 69.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1550.8999999999999, "alertThreshold": 2.0}]} 00:12:58 INFO - Return code: 0 00:12:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:12:58 ERROR - # TBPL SUCCESS # 00:12:58 INFO - Running post-action listener: _resource_record_post_action 00:12:58 INFO - Running post-run listener: _resource_record_post_run 00:12:59 INFO - Total resource usage - Wall time: 1183s; CPU: 25.0%; Read bytes: 266240; Write bytes: 492105728; Read time: 28; Write time: 405996 00:12:59 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 248070144; Read time: 0; Write time: 231600 00:12:59 INFO - run-tests - Wall time: 1168s; CPU: 25.0%; Read bytes: 266240; Write bytes: 243437568; Read time: 28; Write time: 174396 00:12:59 INFO - Running post-run listener: _upload_blobber_files 00:12:59 INFO - Blob upload gear active. 00:12:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:12:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:12:59 INFO - (blobuploader) - INFO - Open directory for files ... 00:12:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:12:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:13:00 INFO - (blobuploader) - INFO - Done attempting. 00:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:13:01 INFO - (blobuploader) - INFO - Done attempting. 00:13:01 INFO - (blobuploader) - INFO - Iteration through files over. 00:13:01 INFO - Return code: 0 00:13:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:13:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:13:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97f88c9c4d9f611dc3a8c1f25ae0219d501e08c10b92cfa65fa9cd558fc74e733e13aa1d696ef323e6605c734da163d1767a528f2d2903af91093ab2561744bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7c312d600d6a0fa5d6813b0d78e2d5966133ac30de71dda52e6d66f26bbcc6149d9f5b5e0f0d71db0c5440c674528c08514f20d85b8b107e2193c9203a4f835"} 00:13:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:13:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:13:01 INFO - Contents: 00:13:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97f88c9c4d9f611dc3a8c1f25ae0219d501e08c10b92cfa65fa9cd558fc74e733e13aa1d696ef323e6605c734da163d1767a528f2d2903af91093ab2561744bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7c312d600d6a0fa5d6813b0d78e2d5966133ac30de71dda52e6d66f26bbcc6149d9f5b5e0f0d71db0c5440c674528c08514f20d85b8b107e2193c9203a4f835"} 00:13:01 INFO - Running post-run listener: copy_logs_to_upload_dir 00:13:01 INFO - Copying logs to upload dir... 00:13:01 INFO - mkdir: /builds/slave/test/build/upload/logs 00:13:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.757402 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-12 00:13:00.507198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:13:00.510868) ========= 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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 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/97f88c9c4d9f611dc3a8c1f25ae0219d501e08c10b92cfa65fa9cd558fc74e733e13aa1d696ef323e6605c734da163d1767a528f2d2903af91093ab2561744bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7c312d600d6a0fa5d6813b0d78e2d5966133ac30de71dda52e6d66f26bbcc6149d9f5b5e0f0d71db0c5440c674528c08514f20d85b8b107e2193c9203a4f835"} build_url:https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005334 build_url: 'https://queue.taskcluster.net/v1/task/T2t55X5mRcW_rHpkIsGgQg/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/97f88c9c4d9f611dc3a8c1f25ae0219d501e08c10b92cfa65fa9cd558fc74e733e13aa1d696ef323e6605c734da163d1767a528f2d2903af91093ab2561744bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7c312d600d6a0fa5d6813b0d78e2d5966133ac30de71dda52e6d66f26bbcc6149d9f5b5e0f0d71db0c5440c674528c08514f20d85b8b107e2193c9203a4f835"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 00:13:00.524409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:13:00.524738) ========= 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=0274524eba3bdaad075c2247000001d4-1463030882.846721-510750169 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002135 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 00:13:00.607703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:13:00.608032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 00:13:00.608346) ========= ========= Total master_lag: 0.17 =========