builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1463632713.01 results: success (0) buildid: 20160518184444 builduid: 067369e73c60416d88ca524a2aa8569c revision: 4902143daafcfca72916ac8cba4ae8150ef271a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.013879) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.014361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.014716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.040510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.040945) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 21:38: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% 46.3M=0s 2016-05-18 21:38:33 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.175480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.175759) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018474 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.228350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.228717) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4902143daafcfca72916ac8cba4ae8150ef271a1 --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 4902143daafcfca72916ac8cba4ae8150ef271a1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 21:38:33,486 truncating revision to first 12 chars 2016-05-18 21:38:33,486 Setting DEBUG logging. 2016-05-18 21:38:33,486 attempt 1/10 2016-05-18 21:38:33,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4902143daafc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 21:38:33,724 unpacking tar archive at: mozilla-aurora-4902143daafc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.497303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.742653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.743251) ========= script_repo_revision: 4902143daafcfca72916ac8cba4ae8150ef271a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.744005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.744663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 21:38:33.755879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-18 21:38:33.756148) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:38:34 INFO - MultiFileLogger online at 20160518 21:38:34 in /builds/slave/test 21:38:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:38:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:38:34 INFO - {'append_to_log': False, 21:38:34 INFO - 'base_work_dir': '/builds/slave/test', 21:38:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:38:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:38:34 INFO - 'branch': 'Mozilla-Aurora', 21:38:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:38:34 INFO - 'config_files': ('talos/linux_config.py',), 21:38:34 INFO - 'default_actions': ('clobber', 21:38:34 INFO - 'read-buildbot-config', 21:38:34 INFO - 'download-and-extract', 21:38:34 INFO - 'populate-webroot', 21:38:34 INFO - 'create-virtualenv', 21:38:34 INFO - 'install', 21:38:34 INFO - 'run-tests'), 21:38:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:38:34 INFO - 'download_minidump_stackwalk': True, 21:38:34 INFO - 'download_symbols': 'ondemand', 21:38:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:38:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:38:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:38:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:38:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:38:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:38:34 INFO - 'installer_path': 'installer.exe', 21:38:34 INFO - 'log_level': 'info', 21:38:34 INFO - 'log_name': 'talos', 21:38:34 INFO - 'log_to_console': True, 21:38:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:38:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:38:34 INFO - 'opt_config_files': (), 21:38:34 INFO - 'pip_index': False, 21:38:34 INFO - 'sps_profile': False, 21:38:34 INFO - 'sps_profile_interval': 0, 21:38:34 INFO - 'suite': 'dromaeojs', 21:38:34 INFO - 'system_bits': '32', 21:38:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:38:34 INFO - 'title': 'talos-linux64-ix-034', 21:38:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:38:34 INFO - 'use_talos_json': True, 21:38:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:38:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:38:34 INFO - 'work_dir': 'build'} 21:38:34 INFO - ##### 21:38:34 INFO - ##### Running clobber step. 21:38:34 INFO - ##### 21:38:34 INFO - Running pre-action listener: _resource_record_pre_action 21:38:34 INFO - Running main action method: clobber 21:38:34 INFO - rmtree: /builds/slave/test/build 21:38:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:38:35 INFO - Running post-action listener: _resource_record_post_action 21:38:35 INFO - ##### 21:38:35 INFO - ##### Running read-buildbot-config step. 21:38:35 INFO - ##### 21:38:35 INFO - Running pre-action listener: _resource_record_pre_action 21:38:35 INFO - Running main action method: read_buildbot_config 21:38:35 INFO - Using buildbot properties: 21:38:35 INFO - { 21:38:35 INFO - "project": "", 21:38:35 INFO - "product": "firefox", 21:38:35 INFO - "script_repo_revision": "production", 21:38:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:38:35 INFO - "repository": "", 21:38:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:38:35 INFO - "buildid": "20160518184444", 21:38:35 INFO - "pgo_build": "True", 21:38:35 INFO - "basedir": "/builds/slave/test", 21:38:35 INFO - "buildnumber": 334, 21:38:35 INFO - "slavename": "talos-linux64-ix-034", 21:38:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:38:35 INFO - "platform": "ubuntu64_hw", 21:38:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:38:35 INFO - "branch": "mozilla-aurora", 21:38:35 INFO - "repo_path": "releases/mozilla-aurora", 21:38:35 INFO - "revision": "4902143daafcfca72916ac8cba4ae8150ef271a1", 21:38:35 INFO - "stage_platform": "linux64-pgo", 21:38:35 INFO - "builduid": "067369e73c60416d88ca524a2aa8569c", 21:38:35 INFO - "slavebuilddir": "test" 21:38:35 INFO - } 21:38:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 21:38:35 INFO - Running post-action listener: _resource_record_post_action 21:38:35 INFO - ##### 21:38:35 INFO - ##### Running download-and-extract step. 21:38:35 INFO - ##### 21:38:35 INFO - Running pre-action listener: _resource_record_pre_action 21:38:35 INFO - Running main action method: download_and_extract 21:38:35 INFO - mkdir: /builds/slave/test/build/tests 21:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:35 INFO - https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:44 INFO - Downloaded 1361 bytes. 21:38:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 21:38:44 INFO - Using the following test package requirements: 21:38:44 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:38:44 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:38:44 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:38:44 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'jsshell-linux-x86_64.zip'], 21:38:44 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:38:44 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 21:38:44 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:38:44 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:38:44 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:38:44 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:38:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:38:44 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')]} 21:38:44 INFO - https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:50 INFO - Downloaded 23812978 bytes. 21:38:50 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'] 21:38:50 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 21:38:52 INFO - Return code: 0 21:38:52 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 21:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:52 INFO - https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 21:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:54 INFO - Downloaded 23812978 bytes. 21:38:54 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'] 21:38:54 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 21:38:56 INFO - Return code: 0 21:38: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')]} 21:38:56 INFO - https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:38:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:38:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 21:38:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:57 INFO - Downloaded 10840145 bytes. 21:38:57 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'] 21:38:57 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 21:38:57 INFO - Return code: 0 21:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:57 INFO - https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:38:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:38:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:38:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjdbeiHeS9uXFunndPM1MQ/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 21:38:58 INFO - Downloaded 62735029 bytes. 21:38:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:38:58 INFO - mkdir: /builds/slave/test/properties 21:38:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:58 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:58 INFO - Contents: 21:38:58 INFO - build_url:https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 21:38:59 INFO - Running post-action listener: _resource_record_post_action 21:38:59 INFO - Running post-action listener: set_extra_try_arguments 21:38:59 INFO - ##### 21:38:59 INFO - ##### Running populate-webroot step. 21:38:59 INFO - ##### 21:38:59 INFO - Running pre-action listener: _resource_record_pre_action 21:38:59 INFO - Running main action method: populate_webroot 21:38:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:59 INFO - '--tppagecycles', 21:38:59 INFO - '7'], 21:38:59 INFO - 'tests': ['tsvgm']}}, 21:38:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['damp', 'tps']}, 21:38:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'tests': ['damp', 'tps']}, 21:38:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['dromaeo_dom']}, 21:38:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['a11yr', 21:38:59 INFO - 'ts_paint', 21:38:59 INFO - 'tpaint', 21:38:59 INFO - 'sessionrestore', 21:38:59 INFO - 'sessionrestore_no_auto_restore', 21:38:59 INFO - 'tabpaint']}, 21:38:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['tsvgx', 21:38:59 INFO - 'tsvgr_opacity', 21:38:59 INFO - 'tart', 21:38:59 INFO - 'tscrollx', 21:38:59 INFO - 'cart']}, 21:38:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:59 INFO - 'tsvgr_opacity', 21:38:59 INFO - 'tart', 21:38:59 INFO - 'tscrollx', 21:38:59 INFO - 'cart']}, 21:38:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'talos_options': ['--disable-e10s'], 21:38:59 INFO - 'tests': ['tp5o']}, 21:38:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'tests': ['tp5o']}, 21:38:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'talos_options': ['--disable-e10s', 21:38:59 INFO - '--xperf_path', 21:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:59 INFO - 'tests': ['tp5n']}, 21:38:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:59 INFO - 'talos_options': ['--xperf_path', 21:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:59 INFO - 'tests': ['tp5n']}}, 21:38:59 INFO - 'talos.zip': {'path': '', 21:38:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:59 INFO - Running post-action listener: _resource_record_post_action 21:38:59 INFO - ##### 21:38:59 INFO - ##### Running create-virtualenv step. 21:38:59 INFO - ##### 21:38:59 INFO - Running pre-action listener: _resource_record_pre_action 21:38:59 INFO - Running main action method: create_virtualenv 21:38:59 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:59 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 21:38:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:59 INFO - Using real prefix '/usr' 21:38:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:39:00 INFO - Installing distribute.............................................................................................................................................................................................done. 21:39:02 INFO - Installing pip.................done. 21:39:02 INFO - Return code: 0 21:39:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:02 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:02 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 21:39:02 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 21:39:02 INFO - Using env: {'DISPLAY': ':0', 21:39:02 INFO - 'HOME': '/home/cltbld', 21:39:02 INFO - 'LANG': 'en_US.UTF-8', 21:39:02 INFO - 'LANGUAGE': 'en_US:en', 21:39:02 INFO - 'LOGNAME': 'cltbld', 21:39:02 INFO - 'MAIL': '/var/mail/cltbld', 21:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:02 INFO - 'MOZ_NO_REMOTE': '1', 21:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:02 INFO - 'NO_EM_RESTART': '1', 21:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:02 INFO - 'PWD': '/builds/slave/test', 21:39:02 INFO - 'SHELL': '/bin/bash', 21:39:02 INFO - 'SHLVL': '1', 21:39:02 INFO - 'TERM': 'linux', 21:39:02 INFO - 'TMOUT': '86400', 21:39:02 INFO - 'USER': 'cltbld', 21:39:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:02 INFO - '_': '/tools/buildbot/bin/python'} 21:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:02 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 21:39:02 INFO - Cleaning up... 21:39:02 INFO - Return code: 0 21:39:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:02 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:02 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 21:39:02 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 21:39:02 INFO - Using env: {'DISPLAY': ':0', 21:39:02 INFO - 'HOME': '/home/cltbld', 21:39:02 INFO - 'LANG': 'en_US.UTF-8', 21:39:02 INFO - 'LANGUAGE': 'en_US:en', 21:39:02 INFO - 'LOGNAME': 'cltbld', 21:39:02 INFO - 'MAIL': '/var/mail/cltbld', 21:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:02 INFO - 'MOZ_NO_REMOTE': '1', 21:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:02 INFO - 'NO_EM_RESTART': '1', 21:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:02 INFO - 'PWD': '/builds/slave/test', 21:39:02 INFO - 'SHELL': '/bin/bash', 21:39:02 INFO - 'SHLVL': '1', 21:39:02 INFO - 'TERM': 'linux', 21:39:02 INFO - 'TMOUT': '86400', 21:39:02 INFO - 'USER': 'cltbld', 21:39:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:02 INFO - '_': '/tools/buildbot/bin/python'} 21:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:02 INFO - Downloading/unpacking psutil>=0.7.1 21:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:04 INFO - Installing collected packages: psutil 21:39:04 INFO - Running setup.py install for psutil 21:39:04 INFO - building 'psutil._psutil_linux' extension 21:39:04 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 21:39:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:39:05 INFO - building 'psutil._psutil_posix' extension 21:39:05 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 21:39:05 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 21:39:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:39:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:39:05 INFO - Successfully installed psutil 21:39:05 INFO - Cleaning up... 21:39:05 INFO - Return code: 0 21:39:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:39:05 INFO - Using env: {'DISPLAY': ':0', 21:39:05 INFO - 'HOME': '/home/cltbld', 21:39:05 INFO - 'LANG': 'en_US.UTF-8', 21:39:05 INFO - 'LANGUAGE': 'en_US:en', 21:39:05 INFO - 'LOGNAME': 'cltbld', 21:39:05 INFO - 'MAIL': '/var/mail/cltbld', 21:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:05 INFO - 'MOZ_NO_REMOTE': '1', 21:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:05 INFO - 'NO_EM_RESTART': '1', 21:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:05 INFO - 'PWD': '/builds/slave/test', 21:39:05 INFO - 'SHELL': '/bin/bash', 21:39:05 INFO - 'SHLVL': '1', 21:39:05 INFO - 'TERM': 'linux', 21:39:05 INFO - 'TMOUT': '86400', 21:39:05 INFO - 'USER': 'cltbld', 21:39:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:05 INFO - '_': '/tools/buildbot/bin/python'} 21:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:39:07 INFO - Installing collected packages: mozsystemmonitor 21:39:07 INFO - Running setup.py install for mozsystemmonitor 21:39:07 INFO - Successfully installed mozsystemmonitor 21:39:07 INFO - Cleaning up... 21:39:07 INFO - Return code: 0 21:39:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:39:07 INFO - Using env: {'DISPLAY': ':0', 21:39:07 INFO - 'HOME': '/home/cltbld', 21:39:07 INFO - 'LANG': 'en_US.UTF-8', 21:39:07 INFO - 'LANGUAGE': 'en_US:en', 21:39:07 INFO - 'LOGNAME': 'cltbld', 21:39:07 INFO - 'MAIL': '/var/mail/cltbld', 21:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:07 INFO - 'MOZ_NO_REMOTE': '1', 21:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:07 INFO - 'NO_EM_RESTART': '1', 21:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:07 INFO - 'PWD': '/builds/slave/test', 21:39:07 INFO - 'SHELL': '/bin/bash', 21:39:07 INFO - 'SHLVL': '1', 21:39:07 INFO - 'TERM': 'linux', 21:39:07 INFO - 'TMOUT': '86400', 21:39:07 INFO - 'USER': 'cltbld', 21:39:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:07 INFO - '_': '/tools/buildbot/bin/python'} 21:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:39:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:39:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:39: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 21:39: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 21:39: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 21:39: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 21:39: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 21:39: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 21:39:10 INFO - Downloading docopt-0.6.1.tar.gz 21:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:39:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:39:10 INFO - Running setup.py install for blobuploader 21:39:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:39:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:39:10 INFO - Running setup.py install for requests 21:39:10 INFO - Running setup.py install for docopt 21:39:11 INFO - Successfully installed blobuploader requests docopt 21:39:11 INFO - Cleaning up... 21:39:11 INFO - Return code: 0 21:39:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39: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')]} 21:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39: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')]} 21:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:11 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:11 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 21:39:11 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 21:39:11 INFO - Using env: {'DISPLAY': ':0', 21:39:11 INFO - 'HOME': '/home/cltbld', 21:39:11 INFO - 'LANG': 'en_US.UTF-8', 21:39:11 INFO - 'LANGUAGE': 'en_US:en', 21:39:11 INFO - 'LOGNAME': 'cltbld', 21:39:11 INFO - 'MAIL': '/var/mail/cltbld', 21:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:11 INFO - 'MOZ_NO_REMOTE': '1', 21:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:11 INFO - 'NO_EM_RESTART': '1', 21:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:11 INFO - 'PWD': '/builds/slave/test', 21:39:11 INFO - 'SHELL': '/bin/bash', 21:39:11 INFO - 'SHLVL': '1', 21:39:11 INFO - 'TERM': 'linux', 21:39:11 INFO - 'TMOUT': '86400', 21:39:11 INFO - 'USER': 'cltbld', 21:39:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:11 INFO - '_': '/tools/buildbot/bin/python'} 21:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:11 INFO - Running setup.py (path:/tmp/pip-F9OPJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:11 INFO - Running setup.py (path:/tmp/pip-PbWaN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:11 INFO - Running setup.py (path:/tmp/pip-ZxQJJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:11 INFO - Running setup.py (path:/tmp/pip-pHsyTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:11 INFO - Running setup.py (path:/tmp/pip-HMX9S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:11 INFO - Running setup.py (path:/tmp/pip-6dZnnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:11 INFO - Running setup.py (path:/tmp/pip-BTRRpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:11 INFO - Running setup.py (path:/tmp/pip-Kt_qYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:11 INFO - Running setup.py (path:/tmp/pip-nhl0Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:11 INFO - Running setup.py (path:/tmp/pip-7gsZHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:12 INFO - Running setup.py (path:/tmp/pip-pTTFej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:12 INFO - Running setup.py (path:/tmp/pip-bRXIxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:12 INFO - Running setup.py (path:/tmp/pip-d0XDDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:12 INFO - Running setup.py (path:/tmp/pip-DRU5Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:12 INFO - Running setup.py (path:/tmp/pip-mnzQtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:12 INFO - Running setup.py (path:/tmp/pip-3MkUGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:12 INFO - Running setup.py (path:/tmp/pip-fF43TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:39:12 INFO - Running setup.py install for manifestparser 21:39:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:39:12 INFO - Running setup.py install for mozcrash 21:39:12 INFO - Running setup.py install for mozdebug 21:39:12 INFO - Running setup.py install for mozdevice 21:39:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:39:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:39:12 INFO - Running setup.py install for mozfile 21:39:13 INFO - Running setup.py install for mozhttpd 21:39:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for mozinfo 21:39:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for mozInstall 21:39:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for mozleak 21:39:13 INFO - Running setup.py install for mozlog 21:39:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for moznetwork 21:39:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for mozprocess 21:39:13 INFO - Running setup.py install for mozprofile 21:39:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:39:13 INFO - Running setup.py install for mozrunner 21:39:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:39:14 INFO - Running setup.py install for mozscreenshot 21:39:14 INFO - Running setup.py install for moztest 21:39:14 INFO - Running setup.py install for mozversion 21:39:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:39:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:39:14 INFO - Cleaning up... 21:39:14 INFO - Return code: 0 21:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:14 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:14 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 21:39:14 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 21:39:14 INFO - Using env: {'DISPLAY': ':0', 21:39:14 INFO - 'HOME': '/home/cltbld', 21:39:14 INFO - 'LANG': 'en_US.UTF-8', 21:39:14 INFO - 'LANGUAGE': 'en_US:en', 21:39:14 INFO - 'LOGNAME': 'cltbld', 21:39:14 INFO - 'MAIL': '/var/mail/cltbld', 21:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:14 INFO - 'MOZ_NO_REMOTE': '1', 21:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:14 INFO - 'NO_EM_RESTART': '1', 21:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:14 INFO - 'PWD': '/builds/slave/test', 21:39:14 INFO - 'SHELL': '/bin/bash', 21:39:14 INFO - 'SHLVL': '1', 21:39:14 INFO - 'TERM': 'linux', 21:39:14 INFO - 'TMOUT': '86400', 21:39:14 INFO - 'USER': 'cltbld', 21:39:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:14 INFO - '_': '/tools/buildbot/bin/python'} 21:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:39:14 INFO - Running setup.py (path:/tmp/pip-VPKdRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:39:14 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)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:39:14 INFO - Running setup.py (path:/tmp/pip-oUTh0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:39:14 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)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:39:14 INFO - Running setup.py (path:/tmp/pip-K1KmAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:39:14 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)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:39:14 INFO - Running setup.py (path:/tmp/pip-_fjORe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:39:14 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)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:39:14 INFO - Running setup.py (path:/tmp/pip-VoXwrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:39:14 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)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:39:14 INFO - Running setup.py (path:/tmp/pip-8TNhZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:39:14 INFO - Running setup.py (path:/tmp/pip-cp3kIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:39:15 INFO - Running setup.py (path:/tmp/pip-JMjLdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:39:15 INFO - Running setup.py (path:/tmp/pip-zr2UzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:39:15 INFO - Running setup.py (path:/tmp/pip-2mAmST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:39:15 INFO - Running setup.py (path:/tmp/pip-NYVFjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:39:15 INFO - Running setup.py (path:/tmp/pip-lRZbiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:39:15 INFO - Running setup.py (path:/tmp/pip-2yVwvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:39:15 INFO - Running setup.py (path:/tmp/pip-cEZu4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:15 INFO - Running setup.py (path:/tmp/pip-IdpIO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:39:15 INFO - Running setup.py (path:/tmp/pip-hCRZMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:39:15 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)) 21:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:39:15 INFO - Running setup.py (path:/tmp/pip-9YU90J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:39:15 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)) 21:39:15 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)) 21:39:15 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)) 21:39:15 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)) 21:39:15 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)) 21:39:15 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)) 21:39:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:17 INFO - Downloading blessings-1.6.tar.gz 21:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:17 INFO - Installing collected packages: blessings 21:39:17 INFO - Running setup.py install for blessings 21:39:17 INFO - Successfully installed blessings 21:39:17 INFO - Cleaning up... 21:39:17 INFO - Return code: 0 21:39:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:18 INFO - Reading from file tmpfile_stdout 21:39:18 INFO - Current package versions: 21:39:18 INFO - argparse == 1.2.1 21:39:18 INFO - blessings == 1.6 21:39:18 INFO - blobuploader == 1.2.4 21:39:18 INFO - docopt == 0.6.1 21:39:18 INFO - manifestparser == 1.1 21:39:18 INFO - mozInstall == 1.12 21:39:18 INFO - mozcrash == 0.17 21:39:18 INFO - mozdebug == 0.1 21:39:18 INFO - mozdevice == 0.48 21:39:18 INFO - mozfile == 1.2 21:39:18 INFO - mozhttpd == 0.7 21:39:18 INFO - mozinfo == 0.9 21:39:18 INFO - mozleak == 0.1 21:39:18 INFO - mozlog == 3.1 21:39:18 INFO - moznetwork == 0.27 21:39:18 INFO - mozprocess == 0.22 21:39:18 INFO - mozprofile == 0.28 21:39:18 INFO - mozrunner == 6.11 21:39:18 INFO - mozscreenshot == 0.1 21:39:18 INFO - mozsystemmonitor == 0.0 21:39:18 INFO - moztest == 0.7 21:39:18 INFO - mozversion == 1.4 21:39:18 INFO - psutil == 3.1.1 21:39:18 INFO - requests == 1.2.3 21:39:18 INFO - wsgiref == 0.1.2 21:39:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:18 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')]} 21:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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')]} 21:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:18 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 21:39:18 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 21:39:18 INFO - Using env: {'DISPLAY': ':0', 21:39:18 INFO - 'HOME': '/home/cltbld', 21:39:18 INFO - 'LANG': 'en_US.UTF-8', 21:39:18 INFO - 'LANGUAGE': 'en_US:en', 21:39:18 INFO - 'LOGNAME': 'cltbld', 21:39:18 INFO - 'MAIL': '/var/mail/cltbld', 21:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:18 INFO - 'MOZ_NO_REMOTE': '1', 21:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:18 INFO - 'NO_EM_RESTART': '1', 21:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:18 INFO - 'PWD': '/builds/slave/test', 21:39:18 INFO - 'SHELL': '/bin/bash', 21:39:18 INFO - 'SHLVL': '1', 21:39:18 INFO - 'TERM': 'linux', 21:39:18 INFO - 'TMOUT': '86400', 21:39:18 INFO - 'USER': 'cltbld', 21:39:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:18 INFO - '_': '/tools/buildbot/bin/python'} 21:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 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)) 21:39:18 INFO - Cleaning up... 21:39:18 INFO - Return code: 0 21:39:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:39:18 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')]} 21:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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')]} 21:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:18 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:18 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 21:39:18 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 21:39:18 INFO - Using env: {'DISPLAY': ':0', 21:39:18 INFO - 'HOME': '/home/cltbld', 21:39:18 INFO - 'LANG': 'en_US.UTF-8', 21:39:18 INFO - 'LANGUAGE': 'en_US:en', 21:39:18 INFO - 'LOGNAME': 'cltbld', 21:39:18 INFO - 'MAIL': '/var/mail/cltbld', 21:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:18 INFO - 'MOZ_NO_REMOTE': '1', 21:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:18 INFO - 'NO_EM_RESTART': '1', 21:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:18 INFO - 'PWD': '/builds/slave/test', 21:39:18 INFO - 'SHELL': '/bin/bash', 21:39:18 INFO - 'SHLVL': '1', 21:39:18 INFO - 'TERM': 'linux', 21:39:18 INFO - 'TMOUT': '86400', 21:39:18 INFO - 'USER': 'cltbld', 21:39:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:18 INFO - '_': '/tools/buildbot/bin/python'} 21:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:18 INFO - Downloading/unpacking jsonschema 21:39:18 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 21:39:18 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 21:39:18 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 21:39:18 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 21:39:18 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 21:39:18 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 21:39:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:39:20 INFO - Downloading/unpacking functools32 (from jsonschema) 21:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:20 INFO - Downloading functools32-3.2.3-2.tar.gz 21:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:39:20 INFO - warning: no files found matching '*.txt' 21:39:20 INFO - no previously-included directories found matching 'build' 21:39:20 INFO - no previously-included directories found matching 'dist' 21:39:20 INFO - no previously-included directories found matching '.git*' 21:39:20 INFO - Installing collected packages: jsonschema, functools32 21:39:20 INFO - Running setup.py install for functools32 21:39:20 INFO - warning: no files found matching '*.txt' 21:39:20 INFO - no previously-included directories found matching 'build' 21:39:20 INFO - no previously-included directories found matching 'dist' 21:39:20 INFO - no previously-included directories found matching '.git*' 21:39:20 INFO - Successfully installed jsonschema functools32 21:39:20 INFO - Cleaning up... 21:39:20 INFO - Return code: 0 21:39:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:39:20 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')]} 21:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:20 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')]} 21:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:20 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 0x7f1597889f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', '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 21:39:20 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 21:39:20 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 21:39:20 INFO - Using env: {'DISPLAY': ':0', 21:39:20 INFO - 'HOME': '/home/cltbld', 21:39:20 INFO - 'LANG': 'en_US.UTF-8', 21:39:20 INFO - 'LANGUAGE': 'en_US:en', 21:39:20 INFO - 'LOGNAME': 'cltbld', 21:39:20 INFO - 'MAIL': '/var/mail/cltbld', 21:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:20 INFO - 'MOZ_NO_REMOTE': '1', 21:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:20 INFO - 'NO_EM_RESTART': '1', 21:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:20 INFO - 'PWD': '/builds/slave/test', 21:39:20 INFO - 'SHELL': '/bin/bash', 21:39:20 INFO - 'SHLVL': '1', 21:39:20 INFO - 'TERM': 'linux', 21:39:20 INFO - 'TMOUT': '86400', 21:39:20 INFO - 'USER': 'cltbld', 21:39:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:20 INFO - '_': '/tools/buildbot/bin/python'} 21:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:21 INFO - Downloading/unpacking flake8 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:21 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 21:39:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:39:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:39:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:39:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 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 21:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:39:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:39:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:39:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:39:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:39:23 INFO - no previously-included directories found matching 'docs/_build' 21:39:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:39:23 INFO - Running setup.py install for pep8 21:39:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:39:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:39:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:39:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:39:23 INFO - no previously-included directories found matching 'docs/_build' 21:39:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:39:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:39:23 INFO - Cleaning up... 21:39:23 INFO - Return code: 0 21:39:23 INFO - Running post-action listener: _resource_record_post_action 21:39:23 INFO - Running post-action listener: _start_resource_monitoring 21:39:24 INFO - Starting resource monitoring. 21:39:24 INFO - ##### 21:39:24 INFO - ##### Running install step. 21:39:24 INFO - ##### 21:39:24 INFO - Running pre-action listener: _resource_record_pre_action 21:39:24 INFO - Running main action method: install 21:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:24 INFO - Reading from file tmpfile_stdout 21:39:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:39:24 INFO - Reading from file tmpfile_stdout 21:39:24 INFO - Output received: 21:39:24 INFO - Usage: mozinstall [options] installer 21:39:24 INFO - Options: 21:39:24 INFO - -h, --help show this help message and exit 21:39:24 INFO - -d DEST, --destination=DEST 21:39:24 INFO - Directory to install application into. [default: 21:39:24 INFO - "/builds/slave/test"] 21:39:24 INFO - --app=APP Application being installed. [default: firefox] 21:39:24 INFO - mkdir: /builds/slave/test/build/application 21:39:24 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'] 21:39:24 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 21:39:39 INFO - Reading from file tmpfile_stdout 21:39:39 INFO - Output received: 21:39:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:39 INFO - Running post-action listener: _resource_record_post_action 21:39:39 INFO - ##### 21:39:39 INFO - ##### Running run-tests step. 21:39:39 INFO - ##### 21:39:39 INFO - Running pre-action listener: _resource_record_pre_action 21:39:39 INFO - Running main action method: run_tests 21:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:39 INFO - Python 2.7.3 21:39:39 INFO - Return code: 0 21:39:39 INFO - grabbing minidump binary from tooltool 21:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f410>, '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 0x2970310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29707a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:39:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:39:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:40 INFO - Return code: 0 21:39:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:39:40 INFO - Return code: 0 21:39:40 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/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:39:40 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/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:39:40 INFO - Using env: {'DISPLAY': ':0', 21:39:40 INFO - 'HOME': '/home/cltbld', 21:39:40 INFO - 'LANG': 'en_US.UTF-8', 21:39:40 INFO - 'LANGUAGE': 'en_US:en', 21:39:40 INFO - 'LOGNAME': 'cltbld', 21:39:40 INFO - 'MAIL': '/var/mail/cltbld', 21:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:40 INFO - 'MOZ_NO_REMOTE': '1', 21:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:40 INFO - 'NO_EM_RESTART': '1', 21:39:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:40 INFO - 'PWD': '/builds/slave/test', 21:39:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:40 INFO - 'SHELL': '/bin/bash', 21:39:40 INFO - 'SHLVL': '1', 21:39:40 INFO - 'TERM': 'linux', 21:39:40 INFO - 'TMOUT': '86400', 21:39:40 INFO - 'USER': 'cltbld', 21:39:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463', 21:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:40 INFO - '_': '/tools/buildbot/bin/python'} 21:39:40 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/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:39:41 INFO - mozversion application_buildid: 20160518184444 21:39:41 INFO - mozversion application_changeset: 4902143daafcfca72916ac8cba4ae8150ef271a1 21:39:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:39:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:41 INFO - mozversion application_name: Firefox 21:39:41 INFO - mozversion application_remotingname: firefox-dev 21:39:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:39:41 INFO - mozversion application_vendor: Mozilla 21:39:41 INFO - mozversion application_version: 48.0a2 21:39:41 INFO - mozversion platform_buildid: 20160518184444 21:39:41 INFO - mozversion platform_changeset: 4902143daafcfca72916ac8cba4ae8150ef271a1 21:39:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:39:41 INFO - mozversion platform_version: 48.0a2 21:39:41 INFO - using testdate: 1463632781 21:39:41 INFO - actual date: 1463632781 21:39:41 INFO - starting webserver on 'localhost:53342' 21:39:41 INFO - SUITE-START | Running 2 tests 21:39:41 INFO - TEST-START | dromaeo_css 21:39:41 INFO - operating with platform_type : linux_ 21:39:41 INFO - Initialising browser for dromaeo_css test... 21:39:41 INFO - TEST-INFO | started process 23295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCNzbB/profile http://localhost:53342/getInfo.html) 21:39:44 INFO - PROCESS | 23295 | __metrics Screen width/height:1600/1200 21:39:44 INFO - PROCESS | 23295 | colorDepth:24 21:39:44 INFO - PROCESS | 23295 | Browser inner width/height: 1024/697 21:39:44 INFO - PROCESS | 23295 | __metrics 21:39:46 ERROR - PROCESS | 23295 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:39:46 INFO - TEST-INFO | 23295: exit 0 21:39:46 INFO - Browser initialized. 21:39:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:46 INFO - TEST-INFO | started process 23385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCNzbB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:58 INFO - PROCESS | 23385 | RSS: Main: 142221312 21:39:58 INFO - PROCESS | 23385 | 21:40:49 INFO - PROCESS | 23385 | 1463632849840 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] 21:42:57 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53342/tests/dromaeo/cssquery-ext.html) 21:42:58 INFO - PROCESS | 23385 | RSS: Main: 251752448 21:42:58 INFO - PROCESS | 23385 | 21:46:00 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-ext.html (next: http://localhost:53342/tests/dromaeo/cssquery-jquery.html) 21:46:00 INFO - PROCESS | 23385 | RSS: Main: 221712384 21:46:00 INFO - PROCESS | 23385 | 21:49:02 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53342/tests/dromaeo/cssquery-mootools.html) 21:49:03 INFO - PROCESS | 23385 | RSS: Main: 221638656 21:49:03 INFO - PROCESS | 23385 | 21:52:05 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53342/tests/dromaeo/cssquery-prototype.html) 21:52:05 INFO - PROCESS | 23385 | RSS: Main: 217718784 21:52:05 INFO - PROCESS | 23385 | 21:55:08 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53342/tests/dromaeo/cssquery-yui.html) 21:55:08 INFO - PROCESS | 23385 | RSS: Main: 212746240 21:55:08 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | Cycle 1(1): loaded http://localhost:53342/tests/dromaeo/cssquery-yui.html (next: http://localhost:53342/tests/dromaeo/cssquery-dojo.html) 21:58:11 INFO - PROCESS | 23385 | RSS: Main: 257183744 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | __start_tp_report 21:58:11 INFO - PROCESS | 23385 | _x_x_mozilla_page_load 21:58:11 INFO - PROCESS | 23385 | _x_x_mozilla_page_load_details 21:58:11 INFO - PROCESS | 23385 | |i|pagename|runs| 21:58:11 INFO - PROCESS | 23385 | |0;dojo.html;3303.157694787829;3357;3363.276895467474;3405.5402520659704;3420.4527275635905;5630.943690563093;5661.971690141554;5673.943260567393;5692.658440493573;5701.401352857947;5619.971900140504;5684.261046064016;5687.090065589507;5692.715364231783;5711.857203569913;4892.877678058041;5104.540591346788;5194.558462530689;5262.894742105155;5295.4969277918535;5075.4163271223915;5108.795648174068;5117.104506711329;5118.283440318359;5122.129238029525;5053.166227572447;5096.847094587169;5109.233614957768;5134.435212126663;5157.6131790115705;5146.3824341078935;5173.456787037345;5181.119209734355;5189.117849965515;5212.218167274939;4931.309616653672;4958.281049247839;5024.974875125601;5084.694918304914;5100.923486147673;5511.614187006911;5536.058869992111;5560.527355174815;5585.972070139664;5593.3847276799515;5970.34326224115;5971.343152253248;5973.910391344133;5978.8505287367725;6002.609830361012;5933.139694744238;6016.639001659871;6027.276726792769;6028.96985515074;6061.212042434499;5525.751341189616;5586.385497595302;5591.440855914376;5594.720263986785;5602.047651899187;5965.105234214902;6079.209702738704;6081.695915204222;6089.2997305310455;6098.969505152535;5791.739371728282;5859.355470898197;5872.236609240771;5881.823545293648;5882.117682347596;5958.106284057426;5966.015607424726;5973.402659733992;5974.193483879708;5982.760689572368;5777.6822274775295;5928.170056192136;5931.139984702194;5946.554008449383;5946.851328716817;5956.404359564009;5990.34106248321;5992.64044157352;5995.430434108753;6026.427489388501;4522.253828118323;4522.773861306921;4528.796204170821;4548.385967894358;4555.362249285103;3977.025628720982;3992.3412636915164;4057.69567282455;4064.288749468831;4099.569545197771;5626.803061892814;5649.378568357477;5653.80211692597;5656.2929633795775;5696.430356964271;5980.790672326448;5984.3417224105315;5998.310194327708;6002.729877155539;6002.819915402545;5527.778888844482;5569.331680198402;5583.69289689071;5589.972050139723;5660.433956604306;5102.33669622954;5114.130597798383;5126.5898728101665;5127.1540195867265;5149.098907691139;6214.161088253119;6224.097505861625;6228.408301211378;6237.563370564108;6243.406876346739;5803.9419605803405;5959.851003724942;6009.849753756191;6030.819075427744;6034.275886893601;6196.95500484848;6224.595401298901;6224.719887605159;6239.719212635351;6243.843903902439;5776.971115144397;5914.408559144051;5917.230760001173;5930.7627694893445;5956.463918247378;5944.078667806497;5996.310424301261;6040.456358927718;6063.029915213545;6076.908846367396;5830.737616807169;5847.64914105138;5859.882802344015;5863.325717542367;5868;5663.2071509989455;5787.334456537552;5825.970870145622;5835.67903765297;5838.2702162229725;5773.653580785166;5774.249347584787;5780.421957804186;5781.82654520365;5817.621854579608;5880.441358070976;5883.970580147072;5910.143029260819;5915.585908986502;5924.585279030426;5638.746256418389;5792.681402522901;5821.068629019336;5826.126081087871;5919.556033297434 21:58:11 INFO - PROCESS | 23385 | |1;ext.html;661.6460193796316;669.6350488983503;676.1919506190103;725.4885305859369;743.776866939918;33401.83299083504;34010;34315;41100;42095.579044209546;43889.12221755563;44551;44583;44596.10807783842;44647.33029004568;8777.42946708465;8888.155625215593;8912.376133670645;8913.331500137483;8917.286617070651;9090.86363704545;9223.677171299007;9251.814963700723;9254.028327025633;9263.120003599648;9209;9264.814703705923;9284.860727089099;9287.721368358927;9287.72136835896;9154.221891139261;9162.86255706165;9173.174414302712;9224.584893679767;9231.723048308562;8844.33667474942;8924.643014279485;8940.240079593243;8947.910520894839;8960.148785865333;43449;44325;44336.89157771081;44382.11235775267;44448.555514444764;3986.382110772806;3988.2422339755353;4013.1572369802375;4029.1337362466916;4540.387047748578;33599.49600755991;34780.478292825625;34940.65059349399;35145.297094057976;35638.46542301868;4498.595126438603;4545.545445455461;4547.8635640930825;4577.633789296849;4618.584327410549;310441;312070;312984;313525;314355;40025.79987100104;64912;66011.37920345626;66030.66984665046;66082.33917660858;40275.39586906199;40400.19199615991;40628.39057414141;40745.38881916774;40838;16044.43844465438;16265.837341626433;16280.185990700418;16282.67434651324;16285.59286017859;13598.796018059737;13736.519221827188;13745.725085498234;13751.449942002208;13755.243461609507;9422.717318480456;9488.383255088396;9514.04859514043;9569.473678947585;9599.568019439143;3464.3244567309134;3512.7541072124704;3558.4128618777613;3634.6547078027547;3669.3395188865725;1154.9018333441752;1157.5138441854442;1182.0661677274857;1211.5093387178206;1231.3043130631165;34879.65120348764;35234.8238258807;35363.4695479568;35442;35845.20370554805;1235.8208059831275;1250.118666340228;1311.5081844308384;1327;1329.9135556188817;17985.7302140468;18411.447656570323;18651.533711657317;18799.624007519775;18853.434396968114;448545;451066;453063;453477;456525;64910.35089649138;65450.67274663691;65599;65638;65668.34331656717;1433.2260579287067;1458.0886945658963;1483.169425121935;1500.5873384819045;1527.3585094260438;32097.518537222426;34264.486032710025;34407.48388774221;34555.65444345524;34655.01714092381;53315.4668453326;53432.73283633557;53824;53850;53856.73071634617;296260;297293;297908;298246;298494;28428.289292767848;31405;31501.36997259996;31812.681873180973;31989.200269993435;46242;46409;46720.766396167804;47034.529654703016;47608.04783904372;38602.6139738599;39397.80301098476;39888.002799929076;40439.19121617492;40528.797356013034;37553.81223093867;37955;38136.427953581275;38163.045923851016;38261.234775304896;43001.78499107484;43105;43786;44410.33384499171;44583.777081114386;34386.48420273648;36383.45424818683;36877.815610921774;37172.256554869295;37713.81143094267;29030.41939161247;29416.55875161917;29534.55698164572;29562.852185738935;29685.257868553457 21:58:11 INFO - PROCESS | 23385 | |2;jquery.html;409.16121950002486;412.21473093756407;412.8678822776711;421.3995057043712;436.5307294658241;18446;18797.718034229463;18957.810421895778;18995.620087598258;20031.098600562975;19172.137253823577;19268.13293401797;19441.319553815618;20302;20305;5799.3620701722775;5856.648601083927;5898.970505147468;5956.076808094752;5982.282126144869;5700.857478563028;5862.003459411911;5884.529237660999;5903;5904.763809447617;5755.510781583549;5832.504237139827;5846.21076154718;5848.532117430616;5861.3552509223955;5731.426857314277;5785.82642520725;5838.065909454467;5869.882602347971;5909.6158749681135;5192.3769147702515;5288.497592728685;5292.073887069748;5292.655977361459;5313.256144139824;23031.53936921252;23503.17738879131;23775.405614859596;23934.760652393426;24005.279841604606;2596.792256619466;2621.30535408117;2670.4926064047963;2791.0231419003185;2911.6651585067566;14338.64153396163;14591.197484138369;14675.412983480648;14953.252337383195;15197.924010379988;2018.1019446346381;2018.8082132197417;2097.8216851567636;2101.7582977957577;2153.590817744639;76642;76893.61553192198;77813.61093194554;79003.60498197473;80748.59625701893;10768.730781730519;10892;10929.289596176382;10941.28881622708;11020.118390528738;15764.68470630581;15851.128187949773;15883.364665413254;15885.841141588668;15913.681726365408;8361.247487726134;8669.56652167389;8709.216170544682;8813.33899957493;8839.734807955772;8548.444351117158;8585.527795971282;8606;8681.609327580274;8701.825963480695;4798.832040878552;4835.6131509479155;4875.390576177978;4915.631327650441;4923.310736496894;1930.5173706573357;1938.1665883669875;1958.6474434601907;1962.1856929374435;1990.7312512810586;1029.940119760479;1124.42092322454;1137.1869113583662;1174.7063234191453;1193.5822462138183;19436.902815486115;19474.221031158595;19571.412857614294;19737.703934440993;19810.90094549518;1053.773438710681;1078.9514471848786;1118.5134466506934;1127.5827943660897;1147.2772153543215;10823.350598964087;11068.391238481961;11140.665780026613;11266.830997535044;11303.378314192634;561508;569986;571664.4250336249;571803;588216;72736.63631681808;87420.56289718511;95293.52353238189;96945;97301.51349243209;976.2482888176065;1077.8437126616598;1126.5437497813398;1140.811766058591;1152.4122697424375;16320.836791631931;16643.645383118754;16966.151692415577;17269.913650431667;17324.393646222827;36751.632483674824;37617;37753;39006;40861.795691021354;57460.42539574718;57546.712266440074;57557.136642949554;57960;57979.4202057974;8700.434471759316;8820.223877242184;8835.867461987948;8929.508877011827;9119.7264082075;9659.71020869375;13338.399772010089;13608.591742247749;13637.86362136366;13866.237356945465;11465.598704045318;11545.826812597987;12029.639110826689;12061.577844775391;12080.093992950387;11518.424078796193;11561.30632162073;11608.361540115375;11698.590549331073;11717.472713727731;11615.825762613398;11856.17006809515;11953.402329883296;11977.700557486132;12044.75910481768;8606.225439710455;8788.912110879066;8794.692185773467;8859.496877930243;8913;11579.189456737948;11653.242539234923;11888;11910.880891191324;12023.819642705192 21:58:11 INFO - PROCESS | 23385 | |3;mootools.html;1445.1401416157382;1568.4667213147527;1594.9920250398745;1781.3676144968535;1873.7002079667247;7704.383649308056;8376.874346884793;8534.658613655447;8538;8544.615492302846;8621.353398495106;8827.735167944957;8830.24942879856;8831.072737362581;8837.027926928033;2160.157538559955;2208.3485371815354;2209.0611490116635;2450.4363996280867;2482.491089326693;2427.2718184544656;2490.5766019776684;2491.700995880497;2492.8130390220804;2495.3262619092834;2408.9879550602222;2430.064425196303;2432.84186527876;2439.2072576412647;2439.9146029888957;2115.111653105699;2330.3707998840387;2395.580773364663;2403.8557686538866;2404.915827946022;2358.209999650102;2398.3884109552127;2405.6992875890514;2406.3984003999;2408.8675122868235;8367;8431.789205269855;8435.240828325419;8447.95776021122;8454.323654107719;5273.077211487975;5358.651687640291;5386.057439947994;5398.13629819227;5403.594730395236;3386.7121294689982;3478.3565040467342;3613.963860361389;3635.5092062571744;3647.4164133738473;1138.1122724275078;1142.8400023996646;1164.4934453512665;1180.5454899863614;1188.6552899659089;12291.815622765665;12331.93834030833;12353.197042192229;12365.75268494625;12371.257724536466;4661.463931647904;4749.976250118727;4819.542143496362;4838.637102217348;4850.514948505192;10437.895621043845;10525.684229473129;10542.841857372145;10544.736381590368;10546.209034322457;5519;5556.055470570012;5568.081266590967;5569.916451253153;5570.275864137636;4416.933745993812;4835.637327200474;4914.410270767531;5096.05722941257;5108.233764935215;4106.876793696194;4143.268786326124;4186.05813691923;4213.599708027732;4213.599708027732;1305.106002388367;1330.813686083949;1334.5595953335376;1341.03445519226;1345.6770375109902;1012.6050840172338;1019.3883669798211;1021.0555236406294;1023.4013102335068;1039.111559616532;5936.643801371932;5993;6002.4897883679505;6020.4280593343565;6314.810555683337;965.7344230336573;992.1715367667933;1008.1027885182194;1056.9905740018264;1081.3619964221148;3973.5827738087087;4159.833606655699;4186.120914607966;4236.745795252295;4259.297215959394;10628.627998020032;11010.614628487965;11041.33751974884;11049.17131215146;11064;10713.250072495006;10747.83878241827;10858.565657373774;10897.346159230472;10909.781804364027;7804.804879878048;8345.4158208926;8347.165283471604;8445.746627601182;8456.40805143634;5559.610827242054;5606.635568688022;5619.297587801525;5698.943010569841;5769.798057067983;9370.34407591462;9474.57364418589;9556.56995435221;9565.186959108554;9636.71089867277;9533.570989305359;9603.423794572349;9752.024797520475;9756.17072548813;9844.60621575129;7117.252688467636;7469.327760501364;7521.097468303619;7566.772996810105;7658.2724641159;8165.305948994402;8201.71294004707;8205.548694821842;8212;8264.380171487282;7337.339639432476;7346.96326518364;7389;7538.170801211972;7643.235676432535;7292.489525733148;7431.851362972602;7466.552006879605;7531.585762783099;7532.17146113938;6853.143357080365;7076.716931322895;7081.752138675121;7087.468439867133;7122.7507037253445;4912.582430493305;4967.552920237196;4979.925301120414;5035.244713292889;5076.568491678248;4974.253861920741;4976.178930476431;4986.376702912136;5081.491850815037;5100.2349647553165 21:58:11 INFO - PROCESS | 23385 | |4;prototype.html;336.776043930786;337.22270167264463;345.6906069068184;346.75900249326713;348.3294657783766;6149.569530132887;6206.255249370076;6241.625502469844;6256.781012664552;6278.811635650938;6193.411625895544;6206.9068963965465;6223.408776166269;6225.408586184317;6226.875462490748;4484.372187893689;4584.541545845422;4650.069986002796;4711.246200607903;4729.148753224418;4686.367340409035;4709.576138147566;4720.811167553294;4728.90542189156;4729.574338309551;4457.799399027052;4670.579647831694;4684.484706682262;4689.671722979393;4693.694909830867;4559;4694.50707675696;4698.177818881716;4698.976505117486;4701.365315682373;4100.856470023535;4108.856190033334;4113.568075352075;4115.36211887158;4118.588141185887;5938.8218353449465;5941.138534912457;5942.078977758411;5945.672987985659;5949;5482.945170548283;5494.642848214853;5494.917576236359;5497.835064948058;5499.917501237444;6393.712282947278;6475.093486911789;6516.3157868423605;6520.152380190592;6531.542792004561;4537.909241815179;4585;4589.219832628428;4592.173408786417;4606.378138951266;6776.05135281061;6801.761938332134;6810.897836532456;6816.7614133505085;6817.659117044128;4682.976585117052;4683.7892294846815;4689;4692.81228750853;4697.412823397075;4748.3114948332295;4749.928751068736;4753.358296629911;4753.619710423158;4756.762161891892;5453.863653408696;5471.452854714496;5473.261109750212;5473.589480788957;5480.095784195642;6432.839179020469;6573;6577.144971153815;6582.24304205013;6589.769358072444;1648.4972083514642;1656.1967445788782;1666.8999860008196;1671.1059583122972;1671.8244584318716;1046.4296958157822;1082.880883102858;1086.201641793297;1087.494315143462;1107.197281970581;6305.3379395163765;6423.293437721847;6444;6522.902156467657;6528.543001989815;6733.158355205599;6740.9325906740305;6797.388235058868;6823.761168359183;6835.179778426621;6393.776217832354;6393.968030159913;6396.136521569621;6413.3266007069515;6417.74329026843;3574.8927532174075;3605.891823245307;3662.011256960606;3669.192777588926;3671.706263498914;7109.324614161646;7111.288871112847;7116.893246601305;7126.144862616519;7152.713891444388;6933.168019837551;6955.374016338554;6971.895421568681;6972.093627828452;6979.336962988508;7064.50548461613;7085.964570177116;7095.609741464165;7102.396296314768;7104.786856394317;6648.368405001517;6775.830604234933;6789.422899053438;6789.694463749044;6797.830054248683;6639.236487803964;6706.731730730716;6709.630970296485;6715.7985260442265;6717.395434410926;7057;7083.964580177066;7089.397401220954;7099.645017748989;7101.715931362688;4759.6430267729365;4769.022350418225;4769.332293478847;4771.379720636295;4773.11697335994;6752.189737231563;6757.763478278237;6766.96616516934;6774.898376524257;6788.898166527407;6413.294537600954;6541.901871472027;6574.276829548841;6585.176852893388;6620.735170593122;6519.054737063005;6553.705083271359;6605.636689982097;6624.635645039569;6626.768063117768;6525.3800888915475;6531.281559028408;6531.869362612626;6543.149390579194;6545.14913061299;6691.36432038975;6695.5982641039745;6695.866082678416;6699.5310328276555;6708.429783468265;6420.967895160681;6523.836904077246;6537.477001839937;6538.673066346759;6546.770863019771 21:58:11 INFO - PROCESS | 23385 | |5;yui.html;822.8601137806572;851.5401683091131;852.7015544559403;914.6387177065059;924.8716565789734;14240.287985600731;14334.498292559763;14380.640483987892;14385.352659130338;14427.63930901728;13205.735885282313;13248.271345076017;13257.668558286048;13259.668508287297;13261.27063011534;742.6101296819172;879.5250564695057;893.1470445724318;903.9548022598876;906.1527471813843;875.4222213339198;878.8198419324024;882.2809410330592;883.0507204754882;884.1600479544427;940.8212439636482;943.0286804591248;943.4433684126365;943.5329511891623;944.4710961861346;784.3254800871246;928.9303302252358;942.4157022646003;943.9622415103388;943.9952800236024;694.4791406445166;694.6492021529147;695.0651373902093;695.1727444341268;695.4922906278395;14150.433982640681;14212.573622791333;14256.857431425657;14278.571642850731;14285.142891426443;14735.852641473555;14987.70024599502;15091.47179848711;15091.849081509154;15479.380824767108;11305.26515776472;11325;11507;11786.057115430745;11836.940815295955;3974.7615143091216;4001.6198461146437;4057.6550993165615;4124.4019617155345;4133.235351459959;56580;57103.42896571023;57115.14327285094;57326;57538.7123064382;11533.826992595117;11543.249688770204;11565.421728913521;11691.941540292244;11864.94067529674;21709.67435488469;21791.564168716854;21823.12707491714;21830.126794928343;21859.453513661967;8406.789830254293;8664.8700269496;8819.073997230327;8839.955800221087;8994.955025224832;4808.7595620219545;4930.5069493050405;4982.90034199314;5010.473900240422;5082.567981721521;3665.248624032067;3720.516332876763;3727.8881633551036;3736.4582135590185;3736.850525978985;627.2347735762363;627.4823270801606;656.4420242793587;697.3828162076497;724.8767709489294;670.4301343857779;671.4762485261504;687.8658661561047;702.1118285369013;770.1605250277113;9311.44131352121;9362.672306469241;9426.245900327956;9468.857967130498;9506.90493095074;710.1939298895687;782.9451938364374;804.3886646148969;820.2114344795544;835.7075023741642;4416.712913660602;4499.887502812456;4552;4575.931361029588;4614.861554153381;67209;68768.6561567199;68770.3122968764;69174.30825691679;69369;55099.72450137723;58670.7066464665;58853.41146588479;59010.40989590049;59606;53844;53980.46019539754;54526.72736636292;54624.45375546273;55008.724956374965;9667.854982175413;9801.950990245003;9930.900690992998;9936.850947235653;10047.598096076368;37682;39404;40427;41360.58639413567;41823.37264941089;51143.744281278356;51971;52422;52735.20897186622;53352.1997170035;12562.43469043877;12750.298733569372;12773.61679149627;12806;12846.935765321114;13731.754557616725;13750.587482375544;13868.791968120688;13973.021888468116;14158.150510969375;12581.370931453208;13023.544175953795;13251.80122298147;13444;13667.726645466835;12615.558455454015;12983.091183617435;13133.73732525325;13235;13405;12318.337024501578;12406.565770198;12449.004079673785;13022.609321720363;13039.217646941213;10502.579896804042;10732.892671073188;10971.177161713063;11084.722881927693;11299.71750706206;11192.38441885704;11348.319100853974;11569.247998880046;11577.826332605186;11626.18616696857 21:58:11 INFO - PROCESS | 23385 | __end_tp_report 21:58:11 INFO - PROCESS | 23385 | __start_cc_report 21:58:11 INFO - PROCESS | 23385 | _x_x_mozilla_cycle_collect,845 21:58:11 INFO - PROCESS | 23385 | __end_cc_report 21:58:11 INFO - PROCESS | 23385 | __startTimestamp1463633891505__endTimestamp 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | ------- Summary: start ------- 21:58:11 INFO - PROCESS | 23385 | Number of tests: 6 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#0] dojo.html Cycles:165 Average:5564.34 Median:5781.83 stddev:620.14 (10.7%) stddev-sans-first:596.14 21:58:11 INFO - PROCESS | 23385 | Values: 3303.2 3357.0 3363.3 3405.5 3420.5 5630.9 5662.0 5673.9 5692.7 5701.4 5620.0 5684.3 5687.1 5692.7 5711.9 4892.9 5104.5 5194.6 5262.9 5295.5 5075.4 5108.8 5117.1 5118.3 5122.1 5053.2 5096.8 5109.2 5134.4 5157.6 5146.4 5173.5 5181.1 5189.1 5212.2 4931.3 4958.3 5025.0 5084.7 5100.9 5511.6 5536.1 5560.5 5586.0 5593.4 5970.3 5971.3 5973.9 5978.9 6002.6 5933.1 6016.6 6027.3 6029.0 6061.2 5525.8 5586.4 5591.4 5594.7 5602.0 5965.1 6079.2 6081.7 6089.3 6099.0 5791.7 5859.4 5872.2 5881.8 5882.1 5958.1 5966.0 5973.4 5974.2 5982.8 5777.7 5928.2 5931.1 5946.6 5946.9 5956.4 5990.3 5992.6 5995.4 6026.4 4522.3 4522.8 4528.8 4548.4 4555.4 3977.0 3992.3 4057.7 4064.3 4099.6 5626.8 5649.4 5653.8 5656.3 5696.4 5980.8 5984.3 5998.3 6002.7 6002.8 5527.8 5569.3 5583.7 5590.0 5660.4 5102.3 5114.1 5126.6 5127.2 5149.1 6214.2 6224.1 6228.4 6237.6 6243.4 5803.9 5959.9 6009.8 6030.8 6034.3 6197.0 6224.6 6224.7 6239.7 6243.8 5777.0 5914.4 5917.2 5930.8 5956.5 5944.1 5996.3 6040.5 6063.0 6076.9 5830.7 5847.6 5859.9 5863.3 5868.0 5663.2 5787.3 5826.0 5835.7 5838.3 5773.7 5774.2 5780.4 5781.8 5817.6 5880.4 5884.0 5910.1 5915.6 5924.6 5638.7 5792.7 5821.1 5826.1 5919.6 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#1] ext.html Cycles:180 Average:52740.79 Median:22152.26 stddev:95161.26 (429.6%) stddev-sans-first:95347.88 21:58:11 INFO - PROCESS | 23385 | Values: 661.6 669.6 676.2 725.5 743.8 33401.8 34010.0 34315.0 41100.0 42095.6 43889.1 44551.0 44583.0 44596.1 44647.3 8777.4 8888.2 8912.4 8913.3 8917.3 9090.9 9223.7 9251.8 9254.0 9263.1 9209.0 9264.8 9284.9 9287.7 9287.7 9154.2 9162.9 9173.2 9224.6 9231.7 8844.3 8924.6 8940.2 8947.9 8960.1 43449.0 44325.0 44336.9 44382.1 44448.6 3986.4 3988.2 4013.2 4029.1 4540.4 33599.5 34780.5 34940.7 35145.3 35638.5 4498.6 4545.5 4547.9 4577.6 4618.6 310441.0 312070.0 312984.0 313525.0 314355.0 40025.8 64912.0 66011.4 66030.7 66082.3 40275.4 40400.2 40628.4 40745.4 40838.0 16044.4 16265.8 16280.2 16282.7 16285.6 13598.8 13736.5 13745.7 13751.4 13755.2 9422.7 9488.4 9514.0 9569.5 9599.6 3464.3 3512.8 3558.4 3634.7 3669.3 1154.9 1157.5 1182.1 1211.5 1231.3 34879.7 35234.8 35363.5 35442.0 35845.2 1235.8 1250.1 1311.5 1327.0 1329.9 17985.7 18411.4 18651.5 18799.6 18853.4 448545.0 451066.0 453063.0 453477.0 456525.0 64910.4 65450.7 65599.0 65638.0 65668.3 1433.2 1458.1 1483.2 1500.6 1527.4 32097.5 34264.5 34407.5 34555.7 34655.0 53315.5 53432.7 53824.0 53850.0 53856.7 296260.0 297293.0 297908.0 298246.0 298494.0 28428.3 31405.0 31501.4 31812.7 31989.2 46242.0 46409.0 46720.8 47034.5 47608.0 38602.6 39397.8 39888.0 40439.2 40528.8 37553.8 37955.0 38136.4 38163.0 38261.2 43001.8 43105.0 43786.0 44410.3 44583.8 34386.5 36383.5 36877.8 37172.3 37713.8 29030.4 29416.6 29534.6 29562.9 29685.3 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#2] jquery.html Cycles:180 Average:31318.09 Median:23855.08 stddev:93907.92 (393.7%) stddev-sans-first:94142.67 21:58:11 INFO - PROCESS | 23385 | Values: 409.2 412.2 412.9 421.4 436.5 18446.0 18797.7 18957.8 18995.6 20031.1 19172.1 19268.1 19441.3 20302.0 20305.0 5799.4 5856.6 5899.0 5956.1 5982.3 5700.9 5862.0 5884.5 5903.0 5904.8 5755.5 5832.5 5846.2 5848.5 5861.4 5731.4 5785.8 5838.1 5869.9 5909.6 5192.4 5288.5 5292.1 5292.7 5313.3 23031.5 23503.2 23775.4 23934.8 24005.3 2596.8 2621.3 2670.5 2791.0 2911.7 14338.6 14591.2 14675.4 14953.3 15197.9 2018.1 2018.8 2097.8 2101.8 2153.6 76642.0 76893.6 77813.6 79003.6 80748.6 10768.7 10892.0 10929.3 10941.3 11020.1 15764.7 15851.1 15883.4 15885.8 15913.7 8361.2 8669.6 8709.2 8813.3 8839.7 8548.4 8585.5 8606.0 8681.6 8701.8 4798.8 4835.6 4875.4 4915.6 4923.3 1930.5 1938.2 1958.6 1962.2 1990.7 1029.9 1124.4 1137.2 1174.7 1193.6 19436.9 19474.2 19571.4 19737.7 19810.9 1053.8 1079.0 1118.5 1127.6 1147.3 10823.4 11068.4 11140.7 11266.8 11303.4 561508.0 569986.0 571664.4 571803.0 588216.0 72736.6 87420.6 95293.5 96945.0 97301.5 976.2 1077.8 1126.5 1140.8 1152.4 16320.8 16643.6 16966.2 17269.9 17324.4 36751.6 37617.0 37753.0 39006.0 40861.8 57460.4 57546.7 57557.1 57960.0 57979.4 8700.4 8820.2 8835.9 8929.5 9119.7 9659.7 13338.4 13608.6 13637.9 13866.2 11465.6 11545.8 12029.6 12061.6 12080.1 11518.4 11561.3 11608.4 11698.6 11717.5 11615.8 11856.2 11953.4 11977.7 12044.8 8606.2 8788.9 8794.7 8859.5 8913.0 11579.2 11653.2 11888.0 11910.9 12023.8 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#3] mootools.html Cycles:180 Average:5767.83 Median:4913.50 stddev:3201.27 (65.2%) stddev-sans-first:3193.76 21:58:11 INFO - PROCESS | 23385 | Values: 1445.1 1568.5 1595.0 1781.4 1873.7 7704.4 8376.9 8534.7 8538.0 8544.6 8621.4 8827.7 8830.2 8831.1 8837.0 2160.2 2208.3 2209.1 2450.4 2482.5 2427.3 2490.6 2491.7 2492.8 2495.3 2409.0 2430.1 2432.8 2439.2 2439.9 2115.1 2330.4 2395.6 2403.9 2404.9 2358.2 2398.4 2405.7 2406.4 2408.9 8367.0 8431.8 8435.2 8448.0 8454.3 5273.1 5358.7 5386.1 5398.1 5403.6 3386.7 3478.4 3614.0 3635.5 3647.4 1138.1 1142.8 1164.5 1180.5 1188.7 12291.8 12331.9 12353.2 12365.8 12371.3 4661.5 4750.0 4819.5 4838.6 4850.5 10437.9 10525.7 10542.8 10544.7 10546.2 5519.0 5556.1 5568.1 5569.9 5570.3 4416.9 4835.6 4914.4 5096.1 5108.2 4106.9 4143.3 4186.1 4213.6 4213.6 1305.1 1330.8 1334.6 1341.0 1345.7 1012.6 1019.4 1021.1 1023.4 1039.1 5936.6 5993.0 6002.5 6020.4 6314.8 965.7 992.2 1008.1 1057.0 1081.4 3973.6 4159.8 4186.1 4236.7 4259.3 10628.6 11010.6 11041.3 11049.2 11064.0 10713.3 10747.8 10858.6 10897.3 10909.8 7804.8 8345.4 8347.2 8445.7 8456.4 5559.6 5606.6 5619.3 5698.9 5769.8 9370.3 9474.6 9556.6 9565.2 9636.7 9533.6 9603.4 9752.0 9756.2 9844.6 7117.3 7469.3 7521.1 7566.8 7658.3 8165.3 8201.7 8205.5 8212.0 8264.4 7337.3 7347.0 7389.0 7538.2 7643.2 7292.5 7431.9 7466.6 7531.6 7532.2 6853.1 7076.7 7081.8 7087.5 7122.8 4912.6 4967.6 4979.9 5035.2 5076.6 4974.3 4976.2 4986.4 5081.5 5100.2 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#4] prototype.html Cycles:180 Average:5513.34 Median:6349.53 stddev:1673.98 (26.4%) stddev-sans-first:1632.96 21:58:11 INFO - PROCESS | 23385 | Values: 336.8 337.2 345.7 346.8 348.3 6149.6 6206.3 6241.6 6256.8 6278.8 6193.4 6206.9 6223.4 6225.4 6226.9 4484.4 4584.5 4650.1 4711.2 4729.1 4686.4 4709.6 4720.8 4728.9 4729.6 4457.8 4670.6 4684.5 4689.7 4693.7 4559.0 4694.5 4698.2 4699.0 4701.4 4100.9 4108.9 4113.6 4115.4 4118.6 5938.8 5941.1 5942.1 5945.7 5949.0 5482.9 5494.6 5494.9 5497.8 5499.9 6393.7 6475.1 6516.3 6520.2 6531.5 4537.9 4585.0 4589.2 4592.2 4606.4 6776.1 6801.8 6810.9 6816.8 6817.7 4683.0 4683.8 4689.0 4692.8 4697.4 4748.3 4749.9 4753.4 4753.6 4756.8 5453.9 5471.5 5473.3 5473.6 5480.1 6432.8 6573.0 6577.1 6582.2 6589.8 1648.5 1656.2 1666.9 1671.1 1671.8 1046.4 1082.9 1086.2 1087.5 1107.2 6305.3 6423.3 6444.0 6522.9 6528.5 6733.2 6740.9 6797.4 6823.8 6835.2 6393.8 6394.0 6396.1 6413.3 6417.7 3574.9 3605.9 3662.0 3669.2 3671.7 7109.3 7111.3 7116.9 7126.1 7152.7 6933.2 6955.4 6971.9 6972.1 6979.3 7064.5 7086.0 7095.6 7102.4 7104.8 6648.4 6775.8 6789.4 6789.7 6797.8 6639.2 6706.7 6709.6 6715.8 6717.4 7057.0 7084.0 7089.4 7099.6 7101.7 4759.6 4769.0 4769.3 4771.4 4773.1 6752.2 6757.8 6767.0 6774.9 6788.9 6413.3 6541.9 6574.3 6585.2 6620.7 6519.1 6553.7 6605.6 6624.6 6626.8 6525.4 6531.3 6531.9 6543.1 6545.1 6691.4 6695.6 6695.9 6699.5 6708.4 6421.0 6523.8 6537.5 6538.7 6546.8 21:58:11 INFO - PROCESS | 23385 | 21:58:11 INFO - PROCESS | 23385 | [#5] yui.html Cycles:180 Average:15927.26 Median:4711.81 stddev:18734.14 (397.6%) stddev-sans-first:18752.36 21:58:11 INFO - PROCESS | 23385 | Values: 822.9 851.5 852.7 914.6 924.9 14240.3 14334.5 14380.6 14385.4 14427.6 13205.7 13248.3 13257.7 13259.7 13261.3 742.6 879.5 893.1 904.0 906.2 875.4 878.8 882.3 883.1 884.2 940.8 943.0 943.4 943.5 944.5 784.3 928.9 942.4 944.0 944.0 694.5 694.6 695.1 695.2 695.5 14150.4 14212.6 14256.9 14278.6 14285.1 14735.9 14987.7 15091.5 15091.8 15479.4 11305.3 11325.0 11507.0 11786.1 11836.9 3974.8 4001.6 4057.7 4124.4 4133.2 56580.0 57103.4 57115.1 57326.0 57538.7 11533.8 11543.2 11565.4 11691.9 11864.9 21709.7 21791.6 21823.1 21830.1 21859.5 8406.8 8664.9 8819.1 8840.0 8995.0 4808.8 4930.5 4982.9 5010.5 5082.6 3665.2 3720.5 3727.9 3736.5 3736.9 627.2 627.5 656.4 697.4 724.9 670.4 671.5 687.9 702.1 770.2 9311.4 9362.7 9426.2 9468.9 9506.9 710.2 782.9 804.4 820.2 835.7 4416.7 4499.9 4552.0 4575.9 4614.9 67209.0 68768.7 68770.3 69174.3 69369.0 55099.7 58670.7 58853.4 59010.4 59606.0 53844.0 53980.5 54526.7 54624.5 55008.7 9667.9 9802.0 9930.9 9936.9 10047.6 37682.0 39404.0 40427.0 41360.6 41823.4 51143.7 51971.0 52422.0 52735.2 53352.2 12562.4 12750.3 12773.6 12806.0 12846.9 13731.8 13750.6 13868.8 13973.0 14158.2 12581.4 13023.5 13251.8 13444.0 13667.7 12615.6 12983.1 13133.7 13235.0 13405.0 12318.3 12406.6 12449.0 13022.6 13039.2 10502.6 10732.9 10971.2 11084.7 11299.7 11192.4 11348.3 11569.2 11577.8 11626.2 21:58:11 INFO - PROCESS | 23385 | -------- Summary: end -------- 21:58:11 INFO - PROCESS | 23385 | 21:58:12 INFO - TEST-INFO | 23385: exit 0 21:58:12 INFO - TEST-OK | dromaeo_css | took 1110967ms 21:58:12 INFO - TEST-START | kraken 21:58:12 INFO - operating with platform_type : linux_ 21:58:12 INFO - Initialising browser for kraken test... 21:58:12 INFO - TEST-INFO | started process 23572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsXWwdv/profile http://localhost:53342/getInfo.html) 21:58:16 INFO - PROCESS | 23572 | __metrics Screen width/height:1600/1200 21:58:16 INFO - PROCESS | 23572 | colorDepth:24 21:58:16 INFO - PROCESS | 23572 | Browser inner width/height: 1024/697 21:58:16 INFO - PROCESS | 23572 | __metrics 21:58:17 ERROR - PROCESS | 23572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:58:17 INFO - TEST-INFO | 23572: exit 0 21:58:17 INFO - Browser initialized. 21:58:17 INFO - Running cycle 1/1 for kraken test... 21:58:17 INFO - TEST-INFO | started process 23663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsXWwdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:29 INFO - PROCESS | 23663 | RSS: Main: 142209024 21:58:29 INFO - PROCESS | 23663 | 21:58:32 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53342/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:32 INFO - PROCESS | 23663 | RSS: Main: 196440064 21:58:32 INFO - PROCESS | 23663 | 21:58:35 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53342/tests/kraken/driver.html?testName=audio-dft) 21:58:36 INFO - PROCESS | 23663 | RSS: Main: 182423552 21:58:36 INFO - PROCESS | 23663 | 21:58:38 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53342/tests/kraken/driver.html?testName=audio-fft) 21:58:39 INFO - PROCESS | 23663 | RSS: Main: 273047552 21:58:39 INFO - PROCESS | 23663 | 21:58:41 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53342/tests/kraken/driver.html?testName=audio-oscillator) 21:58:42 INFO - PROCESS | 23663 | RSS: Main: 179449856 21:58:42 INFO - PROCESS | 23663 | 21:58:44 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:44 INFO - PROCESS | 23663 | RSS: Main: 177745920 21:58:44 INFO - PROCESS | 23663 | 21:58:47 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53342/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:48 INFO - PROCESS | 23663 | RSS: Main: 212357120 21:58:48 INFO - PROCESS | 23663 | 21:58:51 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53342/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:52 INFO - PROCESS | 23663 | RSS: Main: 212955136 21:58:52 INFO - PROCESS | 23663 | 21:58:55 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53342/tests/kraken/driver.html?testName=json-parse-financial) 21:58:55 INFO - PROCESS | 23663 | RSS: Main: 212856832 21:58:55 INFO - PROCESS | 23663 | 21:58:57 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:57 INFO - PROCESS | 23663 | RSS: Main: 194957312 21:58:57 INFO - PROCESS | 23663 | 21:58:59 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:59:00 INFO - PROCESS | 23663 | RSS: Main: 197791744 21:59:00 INFO - PROCESS | 23663 | 21:59:01 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:59:02 INFO - PROCESS | 23663 | RSS: Main: 209858560 21:59:02 INFO - PROCESS | 23663 | 21:59:05 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:59:05 INFO - PROCESS | 23663 | RSS: Main: 213823488 21:59:05 INFO - PROCESS | 23663 | 21:59:08 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:59:08 INFO - PROCESS | 23663 | RSS: Main: 210472960 21:59:08 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | Cycle 1(1): loaded http://localhost:53342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53342/tests/kraken/driver.html?testName=ai-astar) 21:59:10 INFO - PROCESS | 23663 | RSS: Main: 273432576 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | __start_tp_report 21:59:10 INFO - PROCESS | 23663 | _x_x_mozilla_page_load 21:59:10 INFO - PROCESS | 23663 | _x_x_mozilla_page_load_details 21:59:10 INFO - PROCESS | 23663 | |i|pagename|runs| 21:59:10 INFO - PROCESS | 23663 | |0;ai-astar;112;110;109;114;111;111;107;111;111;110 21:59:10 INFO - PROCESS | 23663 | |1;audio-beat-detection;155;124;156;183;127;152;155;127;178;126 21:59:10 INFO - PROCESS | 23663 | |2;audio-dft;161;160;161;161;161;162;161;161;160;161 21:59:10 INFO - PROCESS | 23663 | |3;audio-fft;77;75;77;174;76;74;76;75;161;75 21:59:10 INFO - PROCESS | 23663 | |4;audio-oscillator;92;93;152;92;93;93;144;92;92;154 21:59:10 INFO - PROCESS | 23663 | |5;imaging-gaussian-blur;116;118;117;116;117;116;117;116;117;117 21:59:10 INFO - PROCESS | 23663 | |6;imaging-darkroom;145;145;146;144;145;145;145;145;145;145 21:59:10 INFO - PROCESS | 23663 | |7;imaging-desaturate;94;95;95;95;95;95;94;94;94;94 21:59:10 INFO - PROCESS | 23663 | |8;json-parse-financial;55;55;53;53;54;54;54;74;54;52 21:59:10 INFO - PROCESS | 23663 | |9;json-stringify-tinderbox;57;58;58;58;59;58;58;58;59;58 21:59:10 INFO - PROCESS | 23663 | |10;stanford-crypto-aes;71;73;71;73;73;72;72;72;72;72 21:59:10 INFO - PROCESS | 23663 | |11;stanford-crypto-ccm;113;134;122;112;110;111;114;119;128;114 21:59:10 INFO - PROCESS | 23663 | |12;stanford-crypto-pbkdf2;158;157;158;158;163;162;159;158;155;158 21:59:10 INFO - PROCESS | 23663 | |13;stanford-crypto-sha256-iterative;68;66;66;66;66;66;66;66;65;66 21:59:10 INFO - PROCESS | 23663 | __end_tp_report 21:59:10 INFO - PROCESS | 23663 | __start_cc_report 21:59:10 INFO - PROCESS | 23663 | _x_x_mozilla_cycle_collect,1591 21:59:10 INFO - PROCESS | 23663 | __end_cc_report 21:59:10 INFO - PROCESS | 23663 | __startTimestamp1463633950874__endTimestamp 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | ------- Summary: start ------- 21:59:10 INFO - PROCESS | 23663 | Number of tests: 14 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.88 21:59:10 INFO - PROCESS | 23663 | Values: 112.0 110.0 109.0 114.0 111.0 111.0 107.0 111.0 111.0 110.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.00 stddev:21.72 (14.0%) stddev-sans-first:22.90 21:59:10 INFO - PROCESS | 23663 | Values: 155.0 124.0 156.0 183.0 127.0 152.0 155.0 127.0 178.0 126.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:59:10 INFO - PROCESS | 23663 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 161.0 161.0 160.0 161.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:38.87 (51.5%) stddev-sans-first:40.74 21:59:10 INFO - PROCESS | 23663 | Values: 77.0 75.0 77.0 174.0 76.0 74.0 76.0 75.0 161.0 75.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:27.92 (30.4%) stddev-sans-first:28.87 21:59:10 INFO - PROCESS | 23663 | Values: 92.0 93.0 152.0 92.0 93.0 93.0 144.0 92.0 92.0 154.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 21:59:10 INFO - PROCESS | 23663 | Values: 116.0 118.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 21:59:10 INFO - PROCESS | 23663 | Values: 145.0 145.0 146.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 21:59:10 INFO - PROCESS | 23663 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.00 stddev:6.46 (12.0%) stddev-sans-first:6.85 21:59:10 INFO - PROCESS | 23663 | Values: 55.0 55.0 53.0 53.0 54.0 54.0 54.0 74.0 54.0 52.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 21:59:10 INFO - PROCESS | 23663 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 58.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#10] stanford-crypto-aes Cycles:10 Average:72.10 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 21:59:10 INFO - PROCESS | 23663 | Values: 71.0 73.0 71.0 73.0 73.0 72.0 72.0 72.0 72.0 72.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:116.50 stddev:8.01 (6.9%) stddev-sans-first:8.32 21:59:10 INFO - PROCESS | 23663 | Values: 113.0 134.0 122.0 112.0 110.0 111.0 114.0 119.0 128.0 114.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:158.00 stddev:2.32 (1.5%) stddev-sans-first:2.45 21:59:10 INFO - PROCESS | 23663 | Values: 158.0 157.0 158.0 158.0 163.0 162.0 159.0 158.0 155.0 158.0 21:59:10 INFO - PROCESS | 23663 | 21:59:10 INFO - PROCESS | 23663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.33 21:59:10 INFO - PROCESS | 23663 | Values: 68.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 21:59:10 INFO - PROCESS | 23663 | -------- Summary: end -------- 21:59:10 INFO - PROCESS | 23663 | 21:59:11 INFO - TEST-INFO | 23663: exit 0 21:59:11 INFO - TEST-OK | kraken | took 59688ms 21:59:11 INFO - SUITE-END | took 1170s 21:59:12 INFO - Completed test suite (00:19:30) 21:59:12 INFO - javascript benchmark 21:59:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.157694787829, 3357.0, 3363.276895467474, 3405.5402520659704, 3420.4527275635905, 5630.943690563093, 5661.971690141554, 5673.943260567393, 5692.658440493573, 5701.401352857947, 5619.971900140504, 5684.261046064016, 5687.090065589507, 5692.715364231783, 5711.857203569913, 4892.877678058041, 5104.540591346788, 5194.558462530689, 5262.894742105155, 5295.4969277918535, 5075.4163271223915, 5108.795648174068, 5117.104506711329, 5118.283440318359, 5122.129238029525, 5053.166227572447, 5096.847094587169, 5109.233614957768, 5134.435212126663, 5157.6131790115705, 5146.3824341078935, 5173.456787037345, 5181.119209734355, 5189.117849965515, 5212.218167274939, 4931.309616653672, 4958.281049247839, 5024.974875125601, 5084.694918304914, 5100.923486147673, 5511.614187006911, 5536.058869992111, 5560.527355174815, 5585.972070139664, 5593.3847276799515, 5970.34326224115, 5971.343152253248, 5973.910391344133, 5978.8505287367725, 6002.609830361012, 5933.139694744238, 6016.639001659871, 6027.276726792769, 6028.96985515074, 6061.212042434499, 5525.751341189616, 5586.385497595302, 5591.440855914376, 5594.720263986785, 5602.047651899187, 5965.105234214902, 6079.209702738704, 6081.695915204222, 6089.2997305310455, 6098.969505152535, 5791.739371728282, 5859.355470898197, 5872.236609240771, 5881.823545293648, 5882.117682347596, 5958.106284057426, 5966.015607424726, 5973.402659733992, 5974.193483879708, 5982.760689572368, 5777.6822274775295, 5928.170056192136, 5931.139984702194, 5946.554008449383, 5946.851328716817, 5956.404359564009, 5990.34106248321, 5992.64044157352, 5995.430434108753, 6026.427489388501, 4522.253828118323, 4522.773861306921, 4528.796204170821, 4548.385967894358, 4555.362249285103, 3977.025628720982, 3992.3412636915164, 4057.69567282455, 4064.288749468831, 4099.569545197771, 5626.803061892814, 5649.378568357477, 5653.80211692597, 5656.2929633795775, 5696.430356964271, 5980.790672326448, 5984.3417224105315, 5998.310194327708, 6002.729877155539, 6002.819915402545, 5527.778888844482, 5569.331680198402, 5583.69289689071, 5589.972050139723, 5660.433956604306, 5102.33669622954, 5114.130597798383, 5126.5898728101665, 5127.1540195867265, 5149.098907691139, 6214.161088253119, 6224.097505861625, 6228.408301211378, 6237.563370564108, 6243.406876346739, 5803.9419605803405, 5959.851003724942, 6009.849753756191, 6030.819075427744, 6034.275886893601, 6196.95500484848, 6224.595401298901, 6224.719887605159, 6239.719212635351, 6243.843903902439, 5776.971115144397, 5914.408559144051, 5917.230760001173, 5930.7627694893445, 5956.463918247378, 5944.078667806497, 5996.310424301261, 6040.456358927718, 6063.029915213545, 6076.908846367396, 5830.737616807169, 5847.64914105138, 5859.882802344015, 5863.325717542367, 5868.0, 5663.2071509989455, 5787.334456537552, 5825.970870145622, 5835.67903765297, 5838.2702162229725, 5773.653580785166, 5774.249347584787, 5780.421957804186, 5781.82654520365, 5817.621854579608, 5880.441358070976, 5883.970580147072, 5910.143029260819, 5915.585908986502, 5924.585279030426, 5638.746256418389, 5792.681402522901, 5821.068629019336, 5826.126081087871, 5919.556033297434], "value": 5523.776605368849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.6460193796316, 669.6350488983503, 676.1919506190103, 725.4885305859369, 743.776866939918, 33401.83299083504, 34010.0, 34315.0, 41100.0, 42095.579044209546, 43889.12221755563, 44551.0, 44583.0, 44596.10807783842, 44647.33029004568, 8777.42946708465, 8888.155625215593, 8912.376133670645, 8913.331500137483, 8917.286617070651, 9090.86363704545, 9223.677171299007, 9251.814963700723, 9254.028327025633, 9263.120003599648, 9209.0, 9264.814703705923, 9284.860727089099, 9287.721368358927, 9287.72136835896, 9154.221891139261, 9162.86255706165, 9173.174414302712, 9224.584893679767, 9231.723048308562, 8844.33667474942, 8924.643014279485, 8940.240079593243, 8947.910520894839, 8960.148785865333, 43449.0, 44325.0, 44336.89157771081, 44382.11235775267, 44448.555514444764, 3986.382110772806, 3988.2422339755353, 4013.1572369802375, 4029.1337362466916, 4540.387047748578, 33599.49600755991, 34780.478292825625, 34940.65059349399, 35145.297094057976, 35638.46542301868, 4498.595126438603, 4545.545445455461, 4547.8635640930825, 4577.633789296849, 4618.584327410549, 310441.0, 312070.0, 312984.0, 313525.0, 314355.0, 40025.79987100104, 64912.0, 66011.37920345626, 66030.66984665046, 66082.33917660858, 40275.39586906199, 40400.19199615991, 40628.39057414141, 40745.38881916774, 40838.0, 16044.43844465438, 16265.837341626433, 16280.185990700418, 16282.67434651324, 16285.59286017859, 13598.796018059737, 13736.519221827188, 13745.725085498234, 13751.449942002208, 13755.243461609507, 9422.717318480456, 9488.383255088396, 9514.04859514043, 9569.473678947585, 9599.568019439143, 3464.3244567309134, 3512.7541072124704, 3558.4128618777613, 3634.6547078027547, 3669.3395188865725, 1154.9018333441752, 1157.5138441854442, 1182.0661677274857, 1211.5093387178206, 1231.3043130631165, 34879.65120348764, 35234.8238258807, 35363.4695479568, 35442.0, 35845.20370554805, 1235.8208059831275, 1250.118666340228, 1311.5081844308384, 1327.0, 1329.9135556188817, 17985.7302140468, 18411.447656570323, 18651.533711657317, 18799.624007519775, 18853.434396968114, 448545.0, 451066.0, 453063.0, 453477.0, 456525.0, 64910.35089649138, 65450.67274663691, 65599.0, 65638.0, 65668.34331656717, 1433.2260579287067, 1458.0886945658963, 1483.169425121935, 1500.5873384819045, 1527.3585094260438, 32097.518537222426, 34264.486032710025, 34407.48388774221, 34555.65444345524, 34655.01714092381, 53315.4668453326, 53432.73283633557, 53824.0, 53850.0, 53856.73071634617, 296260.0, 297293.0, 297908.0, 298246.0, 298494.0, 28428.289292767848, 31405.0, 31501.36997259996, 31812.681873180973, 31989.200269993435, 46242.0, 46409.0, 46720.766396167804, 47034.529654703016, 47608.04783904372, 38602.6139738599, 39397.80301098476, 39888.002799929076, 40439.19121617492, 40528.797356013034, 37553.81223093867, 37955.0, 38136.427953581275, 38163.045923851016, 38261.234775304896, 43001.78499107484, 43105.0, 43786.0, 44410.33384499171, 44583.777081114386, 34386.48420273648, 36383.45424818683, 36877.815610921774, 37172.256554869295, 37713.81143094267, 29030.41939161247, 29416.55875161917, 29534.55698164572, 29562.852185738935, 29685.257868553457], "value": 19537.20797042649, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.16121950002486, 412.21473093756407, 412.8678822776711, 421.3995057043712, 436.5307294658241, 18446.0, 18797.718034229463, 18957.810421895778, 18995.620087598258, 20031.098600562975, 19172.137253823577, 19268.13293401797, 19441.319553815618, 20302.0, 20305.0, 5799.3620701722775, 5856.648601083927, 5898.970505147468, 5956.076808094752, 5982.282126144869, 5700.857478563028, 5862.003459411911, 5884.529237660999, 5903.0, 5904.763809447617, 5755.510781583549, 5832.504237139827, 5846.21076154718, 5848.532117430616, 5861.3552509223955, 5731.426857314277, 5785.82642520725, 5838.065909454467, 5869.882602347971, 5909.6158749681135, 5192.3769147702515, 5288.497592728685, 5292.073887069748, 5292.655977361459, 5313.256144139824, 23031.53936921252, 23503.17738879131, 23775.405614859596, 23934.760652393426, 24005.279841604606, 2596.792256619466, 2621.30535408117, 2670.4926064047963, 2791.0231419003185, 2911.6651585067566, 14338.64153396163, 14591.197484138369, 14675.412983480648, 14953.252337383195, 15197.924010379988, 2018.1019446346381, 2018.8082132197417, 2097.8216851567636, 2101.7582977957577, 2153.590817744639, 76642.0, 76893.61553192198, 77813.61093194554, 79003.60498197473, 80748.59625701893, 10768.730781730519, 10892.0, 10929.289596176382, 10941.28881622708, 11020.118390528738, 15764.68470630581, 15851.128187949773, 15883.364665413254, 15885.841141588668, 15913.681726365408, 8361.247487726134, 8669.56652167389, 8709.216170544682, 8813.33899957493, 8839.734807955772, 8548.444351117158, 8585.527795971282, 8606.0, 8681.609327580274, 8701.825963480695, 4798.832040878552, 4835.6131509479155, 4875.390576177978, 4915.631327650441, 4923.310736496894, 1930.5173706573357, 1938.1665883669875, 1958.6474434601907, 1962.1856929374435, 1990.7312512810586, 1029.940119760479, 1124.42092322454, 1137.1869113583662, 1174.7063234191453, 1193.5822462138183, 19436.902815486115, 19474.221031158595, 19571.412857614294, 19737.703934440993, 19810.90094549518, 1053.773438710681, 1078.9514471848786, 1118.5134466506934, 1127.5827943660897, 1147.2772153543215, 10823.350598964087, 11068.391238481961, 11140.665780026613, 11266.830997535044, 11303.378314192634, 561508.0, 569986.0, 571664.4250336249, 571803.0, 588216.0, 72736.63631681808, 87420.56289718511, 95293.52353238189, 96945.0, 97301.51349243209, 976.2482888176065, 1077.8437126616598, 1126.5437497813398, 1140.811766058591, 1152.4122697424375, 16320.836791631931, 16643.645383118754, 16966.151692415577, 17269.913650431667, 17324.393646222827, 36751.632483674824, 37617.0, 37753.0, 39006.0, 40861.795691021354, 57460.42539574718, 57546.712266440074, 57557.136642949554, 57960.0, 57979.4202057974, 8700.434471759316, 8820.223877242184, 8835.867461987948, 8929.508877011827, 9119.7264082075, 9659.71020869375, 13338.399772010089, 13608.591742247749, 13637.86362136366, 13866.237356945465, 11465.598704045318, 11545.826812597987, 12029.639110826689, 12061.577844775391, 12080.093992950387, 11518.424078796193, 11561.30632162073, 11608.361540115375, 11698.590549331073, 11717.472713727731, 11615.825762613398, 11856.17006809515, 11953.402329883296, 11977.700557486132, 12044.75910481768, 8606.225439710455, 8788.912110879066, 8794.692185773467, 8859.496877930243, 8913.0, 11579.189456737948, 11653.242539234923, 11888.0, 11910.880891191324, 12023.819642705192], "value": 9571.61911949936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.1401416157382, 1568.4667213147527, 1594.9920250398745, 1781.3676144968535, 1873.7002079667247, 7704.383649308056, 8376.874346884793, 8534.658613655447, 8538.0, 8544.615492302846, 8621.353398495106, 8827.735167944957, 8830.24942879856, 8831.072737362581, 8837.027926928033, 2160.157538559955, 2208.3485371815354, 2209.0611490116635, 2450.4363996280867, 2482.491089326693, 2427.2718184544656, 2490.5766019776684, 2491.700995880497, 2492.8130390220804, 2495.3262619092834, 2408.9879550602222, 2430.064425196303, 2432.84186527876, 2439.2072576412647, 2439.9146029888957, 2115.111653105699, 2330.3707998840387, 2395.580773364663, 2403.8557686538866, 2404.915827946022, 2358.209999650102, 2398.3884109552127, 2405.6992875890514, 2406.3984003999, 2408.8675122868235, 8367.0, 8431.789205269855, 8435.240828325419, 8447.95776021122, 8454.323654107719, 5273.077211487975, 5358.651687640291, 5386.057439947994, 5398.13629819227, 5403.594730395236, 3386.7121294689982, 3478.3565040467342, 3613.963860361389, 3635.5092062571744, 3647.4164133738473, 1138.1122724275078, 1142.8400023996646, 1164.4934453512665, 1180.5454899863614, 1188.6552899659089, 12291.815622765665, 12331.93834030833, 12353.197042192229, 12365.75268494625, 12371.257724536466, 4661.463931647904, 4749.976250118727, 4819.542143496362, 4838.637102217348, 4850.514948505192, 10437.895621043845, 10525.684229473129, 10542.841857372145, 10544.736381590368, 10546.209034322457, 5519.0, 5556.055470570012, 5568.081266590967, 5569.916451253153, 5570.275864137636, 4416.933745993812, 4835.637327200474, 4914.410270767531, 5096.05722941257, 5108.233764935215, 4106.876793696194, 4143.268786326124, 4186.05813691923, 4213.599708027732, 4213.599708027732, 1305.106002388367, 1330.813686083949, 1334.5595953335376, 1341.03445519226, 1345.6770375109902, 1012.6050840172338, 1019.3883669798211, 1021.0555236406294, 1023.4013102335068, 1039.111559616532, 5936.643801371932, 5993.0, 6002.4897883679505, 6020.4280593343565, 6314.810555683337, 965.7344230336573, 992.1715367667933, 1008.1027885182194, 1056.9905740018264, 1081.3619964221148, 3973.5827738087087, 4159.833606655699, 4186.120914607966, 4236.745795252295, 4259.297215959394, 10628.627998020032, 11010.614628487965, 11041.33751974884, 11049.17131215146, 11064.0, 10713.250072495006, 10747.83878241827, 10858.565657373774, 10897.346159230472, 10909.781804364027, 7804.804879878048, 8345.4158208926, 8347.165283471604, 8445.746627601182, 8456.40805143634, 5559.610827242054, 5606.635568688022, 5619.297587801525, 5698.943010569841, 5769.798057067983, 9370.34407591462, 9474.57364418589, 9556.56995435221, 9565.186959108554, 9636.71089867277, 9533.570989305359, 9603.423794572349, 9752.024797520475, 9756.17072548813, 9844.60621575129, 7117.252688467636, 7469.327760501364, 7521.097468303619, 7566.772996810105, 7658.2724641159, 8165.305948994402, 8201.71294004707, 8205.548694821842, 8212.0, 8264.380171487282, 7337.339639432476, 7346.96326518364, 7389.0, 7538.170801211972, 7643.235676432535, 7292.489525733148, 7431.851362972602, 7466.552006879605, 7531.585762783099, 7532.17146113938, 6853.143357080365, 7076.716931322895, 7081.752138675121, 7087.468439867133, 7122.7507037253445, 4912.582430493305, 4967.552920237196, 4979.925301120414, 5035.244713292889, 5076.568491678248, 4974.253861920741, 4976.178930476431, 4986.376702912136, 5081.491850815037, 5100.2349647553165], "value": 4678.68200336292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.776043930786, 337.22270167264463, 345.6906069068184, 346.75900249326713, 348.3294657783766, 6149.569530132887, 6206.255249370076, 6241.625502469844, 6256.781012664552, 6278.811635650938, 6193.411625895544, 6206.9068963965465, 6223.408776166269, 6225.408586184317, 6226.875462490748, 4484.372187893689, 4584.541545845422, 4650.069986002796, 4711.246200607903, 4729.148753224418, 4686.367340409035, 4709.576138147566, 4720.811167553294, 4728.90542189156, 4729.574338309551, 4457.799399027052, 4670.579647831694, 4684.484706682262, 4689.671722979393, 4693.694909830867, 4559.0, 4694.50707675696, 4698.177818881716, 4698.976505117486, 4701.365315682373, 4100.856470023535, 4108.856190033334, 4113.568075352075, 4115.36211887158, 4118.588141185887, 5938.8218353449465, 5941.138534912457, 5942.078977758411, 5945.672987985659, 5949.0, 5482.945170548283, 5494.642848214853, 5494.917576236359, 5497.835064948058, 5499.917501237444, 6393.712282947278, 6475.093486911789, 6516.3157868423605, 6520.152380190592, 6531.542792004561, 4537.909241815179, 4585.0, 4589.219832628428, 4592.173408786417, 4606.378138951266, 6776.05135281061, 6801.761938332134, 6810.897836532456, 6816.7614133505085, 6817.659117044128, 4682.976585117052, 4683.7892294846815, 4689.0, 4692.81228750853, 4697.412823397075, 4748.3114948332295, 4749.928751068736, 4753.358296629911, 4753.619710423158, 4756.762161891892, 5453.863653408696, 5471.452854714496, 5473.261109750212, 5473.589480788957, 5480.095784195642, 6432.839179020469, 6573.0, 6577.144971153815, 6582.24304205013, 6589.769358072444, 1648.4972083514642, 1656.1967445788782, 1666.8999860008196, 1671.1059583122972, 1671.8244584318716, 1046.4296958157822, 1082.880883102858, 1086.201641793297, 1087.494315143462, 1107.197281970581, 6305.3379395163765, 6423.293437721847, 6444.0, 6522.902156467657, 6528.543001989815, 6733.158355205599, 6740.9325906740305, 6797.388235058868, 6823.761168359183, 6835.179778426621, 6393.776217832354, 6393.968030159913, 6396.136521569621, 6413.3266007069515, 6417.74329026843, 3574.8927532174075, 3605.891823245307, 3662.011256960606, 3669.192777588926, 3671.706263498914, 7109.324614161646, 7111.288871112847, 7116.893246601305, 7126.144862616519, 7152.713891444388, 6933.168019837551, 6955.374016338554, 6971.895421568681, 6972.093627828452, 6979.336962988508, 7064.50548461613, 7085.964570177116, 7095.609741464165, 7102.396296314768, 7104.786856394317, 6648.368405001517, 6775.830604234933, 6789.422899053438, 6789.694463749044, 6797.830054248683, 6639.236487803964, 6706.731730730716, 6709.630970296485, 6715.7985260442265, 6717.395434410926, 7057.0, 7083.964580177066, 7089.397401220954, 7099.645017748989, 7101.715931362688, 4759.6430267729365, 4769.022350418225, 4769.332293478847, 4771.379720636295, 4773.11697335994, 6752.189737231563, 6757.763478278237, 6766.96616516934, 6774.898376524257, 6788.898166527407, 6413.294537600954, 6541.901871472027, 6574.276829548841, 6585.176852893388, 6620.735170593122, 6519.054737063005, 6553.705083271359, 6605.636689982097, 6624.635645039569, 6626.768063117768, 6525.3800888915475, 6531.281559028408, 6531.869362612626, 6543.149390579194, 6545.14913061299, 6691.36432038975, 6695.5982641039745, 6695.866082678416, 6699.5310328276555, 6708.429783468265, 6420.967895160681, 6523.836904077246, 6537.477001839937, 6538.673066346759, 6546.770863019771], "value": 4963.860365318488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8601137806572, 851.5401683091131, 852.7015544559403, 914.6387177065059, 924.8716565789734, 14240.287985600731, 14334.498292559763, 14380.640483987892, 14385.352659130338, 14427.63930901728, 13205.735885282313, 13248.271345076017, 13257.668558286048, 13259.668508287297, 13261.27063011534, 742.6101296819172, 879.5250564695057, 893.1470445724318, 903.9548022598876, 906.1527471813843, 875.4222213339198, 878.8198419324024, 882.2809410330592, 883.0507204754882, 884.1600479544427, 940.8212439636482, 943.0286804591248, 943.4433684126365, 943.5329511891623, 944.4710961861346, 784.3254800871246, 928.9303302252358, 942.4157022646003, 943.9622415103388, 943.9952800236024, 694.4791406445166, 694.6492021529147, 695.0651373902093, 695.1727444341268, 695.4922906278395, 14150.433982640681, 14212.573622791333, 14256.857431425657, 14278.571642850731, 14285.142891426443, 14735.852641473555, 14987.70024599502, 15091.47179848711, 15091.849081509154, 15479.380824767108, 11305.26515776472, 11325.0, 11507.0, 11786.057115430745, 11836.940815295955, 3974.7615143091216, 4001.6198461146437, 4057.6550993165615, 4124.4019617155345, 4133.235351459959, 56580.0, 57103.42896571023, 57115.14327285094, 57326.0, 57538.7123064382, 11533.826992595117, 11543.249688770204, 11565.421728913521, 11691.941540292244, 11864.94067529674, 21709.67435488469, 21791.564168716854, 21823.12707491714, 21830.126794928343, 21859.453513661967, 8406.789830254293, 8664.8700269496, 8819.073997230327, 8839.955800221087, 8994.955025224832, 4808.7595620219545, 4930.5069493050405, 4982.90034199314, 5010.473900240422, 5082.567981721521, 3665.248624032067, 3720.516332876763, 3727.8881633551036, 3736.4582135590185, 3736.850525978985, 627.2347735762363, 627.4823270801606, 656.4420242793587, 697.3828162076497, 724.8767709489294, 670.4301343857779, 671.4762485261504, 687.8658661561047, 702.1118285369013, 770.1605250277113, 9311.44131352121, 9362.672306469241, 9426.245900327956, 9468.857967130498, 9506.90493095074, 710.1939298895687, 782.9451938364374, 804.3886646148969, 820.2114344795544, 835.7075023741642, 4416.712913660602, 4499.887502812456, 4552.0, 4575.931361029588, 4614.861554153381, 67209.0, 68768.6561567199, 68770.3122968764, 69174.30825691679, 69369.0, 55099.72450137723, 58670.7066464665, 58853.41146588479, 59010.40989590049, 59606.0, 53844.0, 53980.46019539754, 54526.72736636292, 54624.45375546273, 55008.724956374965, 9667.854982175413, 9801.950990245003, 9930.900690992998, 9936.850947235653, 10047.598096076368, 37682.0, 39404.0, 40427.0, 41360.58639413567, 41823.37264941089, 51143.744281278356, 51971.0, 52422.0, 52735.20897186622, 53352.1997170035, 12562.43469043877, 12750.298733569372, 12773.61679149627, 12806.0, 12846.935765321114, 13731.754557616725, 13750.587482375544, 13868.791968120688, 13973.021888468116, 14158.150510969375, 12581.370931453208, 13023.544175953795, 13251.80122298147, 13444.0, 13667.726645466835, 12615.558455454015, 12983.091183617435, 13133.73732525325, 13235.0, 13405.0, 12318.337024501578, 12406.565770198, 12449.004079673785, 13022.609321720363, 13039.217646941213, 10502.579896804042, 10732.892671073188, 10971.177161713063, 11084.722881927693, 11299.71750706206, 11192.38441885704, 11348.319100853974, 11569.247998880046, 11577.826332605186, 11626.18616696857], "value": 7165.592365618425, "unit": "score"}], "name": "dromaeo_css", "value": 7456.805490654956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 109.0, 114.0, 111.0, 111.0, 107.0, 111.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 156.0, 183.0, 127.0, 152.0, 155.0, 127.0, 178.0, 126.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 174.0, 76.0, 74.0, 76.0, 75.0, 161.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 92.0, 93.0, 93.0, 144.0, 92.0, 92.0, 154.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 74.0, 54.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 71.0, 73.0, 73.0, 72.0, 72.0, 72.0, 72.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 134.0, 122.0, 112.0, 110.0, 111.0, 114.0, 119.0, 128.0, 114.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 158.0, 163.0, 162.0, 159.0, 158.0, 155.0, 158.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1508.0999999999997, "alertThreshold": 2.0}]} 21:59:12 INFO - Return code: 0 21:59:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:59:12 ERROR - # TBPL SUCCESS # 21:59:12 INFO - Running post-action listener: _resource_record_post_action 21:59:12 INFO - Running post-run listener: _resource_record_post_run 21:59:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500379648; Read time: 20; Write time: 470976 21:59:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248729600; Read time: 0; Write time: 328300 21:59:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251650048; Read time: 20; Write time: 142676 21:59:13 INFO - Running post-run listener: _upload_blobber_files 21:59:13 INFO - Blob upload gear active. 21:59:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:59:13 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 21:59:13 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'] 21:59:13 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 21:59:13 INFO - (blobuploader) - INFO - Open directory for files ... 21:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:14 INFO - (blobuploader) - INFO - Done attempting. 21:59:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:59:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:59:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:59:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:59:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:59:15 INFO - (blobuploader) - INFO - Done attempting. 21:59:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:59:15 INFO - Return code: 0 21:59:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:59:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:59:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de909d4d103f6624953917ca4c38e78f2590031f370ebac859fcbf84a6f80b3a3e03142981be53ff8ddcb1f55d4f9ebd39797b8c18520d6efabbe484b49ef174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32fd3bf4551b4393d03bdefa6df91288e00f4a75edb37ea258e5d373e2c43af4fc9cd18e82b23e39840512d37bd3478608662b7e77e72b3e19ef5240c2e46aaf"} 21:59:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:59:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:59:15 INFO - Contents: 21:59:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de909d4d103f6624953917ca4c38e78f2590031f370ebac859fcbf84a6f80b3a3e03142981be53ff8ddcb1f55d4f9ebd39797b8c18520d6efabbe484b49ef174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32fd3bf4551b4393d03bdefa6df91288e00f4a75edb37ea258e5d373e2c43af4fc9cd18e82b23e39840512d37bd3478608662b7e77e72b3e19ef5240c2e46aaf"} 21:59:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:59:15 INFO - Copying logs to upload dir... 21:59:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:59:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.412684 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-18 21:59:15.306060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 21:59:15.313897) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 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/de909d4d103f6624953917ca4c38e78f2590031f370ebac859fcbf84a6f80b3a3e03142981be53ff8ddcb1f55d4f9ebd39797b8c18520d6efabbe484b49ef174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32fd3bf4551b4393d03bdefa6df91288e00f4a75edb37ea258e5d373e2c43af4fc9cd18e82b23e39840512d37bd3478608662b7e77e72b3e19ef5240c2e46aaf"} build_url:https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/PjdbeiHeS9uXFunndPM1MQ/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/de909d4d103f6624953917ca4c38e78f2590031f370ebac859fcbf84a6f80b3a3e03142981be53ff8ddcb1f55d4f9ebd39797b8c18520d6efabbe484b49ef174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32fd3bf4551b4393d03bdefa6df91288e00f4a75edb37ea258e5d373e2c43af4fc9cd18e82b23e39840512d37bd3478608662b7e77e72b3e19ef5240c2e46aaf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 21:59:15.343644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:59:15.343976) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1463630478.750411-1664046463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:59:15.395056) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 21:59:15.395371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 21:59:15.398901) ========= ========= Total master_lag: 0.27 =========