builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1461753572.98 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:32.976229) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:32.976805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:32.977085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.003142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.003399) ========= 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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 03:39: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% 218M=0s 2016-04-27 03:39:33 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.141841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.142134) ========= 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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.191377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.191689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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 8551b253f4061db31e4be7829c2f70c2610caf42 --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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 03:39:33,367 truncating revision to first 12 chars 2016-04-27 03:39:33,367 Setting DEBUG logging. 2016-04-27 03:39:33,367 attempt 1/10 2016-04-27 03:39:33,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:39:33,616 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.747300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.747604) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.748044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.748308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:39:33.761930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-27 03:39:33.762298) ========= /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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:34 INFO - MultiFileLogger online at 20160427 03:39:34 in /builds/slave/test 03:39: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 03:39:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:34 INFO - {'append_to_log': False, 03:39:34 INFO - 'base_work_dir': '/builds/slave/test', 03:39:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:34 INFO - 'branch': 'Mozilla-Aurora', 03:39:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:34 INFO - 'config_files': ('talos/linux_config.py',), 03:39:34 INFO - 'default_actions': ('clobber', 03:39:34 INFO - 'read-buildbot-config', 03:39:34 INFO - 'download-and-extract', 03:39:34 INFO - 'populate-webroot', 03:39:34 INFO - 'create-virtualenv', 03:39:34 INFO - 'install', 03:39:34 INFO - 'run-tests'), 03:39:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:34 INFO - 'download_minidump_stackwalk': True, 03:39:34 INFO - 'download_symbols': 'ondemand', 03:39:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:34 INFO - 'installer_path': 'installer.exe', 03:39:34 INFO - 'log_level': 'info', 03:39:34 INFO - 'log_name': 'talos', 03:39:34 INFO - 'log_to_console': True, 03:39:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:34 INFO - 'opt_config_files': (), 03:39:34 INFO - 'pip_index': False, 03:39:34 INFO - 'sps_profile': False, 03:39:34 INFO - 'sps_profile_interval': 0, 03:39:34 INFO - 'suite': 'dromaeojs', 03:39:34 INFO - 'system_bits': '32', 03:39:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:34 INFO - 'title': 'talos-linux64-ix-016', 03:39:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:34 INFO - 'use_talos_json': True, 03:39:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:34 INFO - 'work_dir': 'build'} 03:39:34 INFO - ##### 03:39:34 INFO - ##### Running clobber step. 03:39:34 INFO - ##### 03:39:34 INFO - Running pre-action listener: _resource_record_pre_action 03:39:34 INFO - Running main action method: clobber 03:39:34 INFO - rmtree: /builds/slave/test/build 03:39:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:34 INFO - Running post-action listener: _resource_record_post_action 03:39:34 INFO - ##### 03:39:34 INFO - ##### Running read-buildbot-config step. 03:39:34 INFO - ##### 03:39:34 INFO - Running pre-action listener: _resource_record_pre_action 03:39:34 INFO - Running main action method: read_buildbot_config 03:39:34 INFO - Using buildbot properties: 03:39:34 INFO - { 03:39:34 INFO - "project": "", 03:39:34 INFO - "product": "firefox", 03:39:34 INFO - "script_repo_revision": "production", 03:39:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:39:34 INFO - "repository": "", 03:39:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:39:34 INFO - "buildid": "20160425062348", 03:39:34 INFO - "pgo_build": "True", 03:39:34 INFO - "basedir": "/builds/slave/test", 03:39:34 INFO - "buildnumber": 293, 03:39:34 INFO - "slavename": "talos-linux64-ix-016", 03:39:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:34 INFO - "platform": "ubuntu64_hw", 03:39:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:34 INFO - "branch": "mozilla-aurora", 03:39:34 INFO - "repo_path": "releases/mozilla-aurora", 03:39:34 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:39:34 INFO - "stage_platform": "linux64-pgo", 03:39:34 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:39:34 INFO - "slavebuilddir": "test" 03:39:34 INFO - } 03:39:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:39:34 INFO - Running post-action listener: _resource_record_post_action 03:39:34 INFO - ##### 03:39:34 INFO - ##### Running download-and-extract step. 03:39:34 INFO - ##### 03:39:34 INFO - Running pre-action listener: _resource_record_pre_action 03:39:34 INFO - Running main action method: download_and_extract 03:39:34 INFO - mkdir: /builds/slave/test/build/tests 03:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:34 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:39:35 INFO - Downloaded 1448 bytes. 03:39:35 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:39:35 INFO - Using the following test package requirements: 03:39:35 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:35 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:39:35 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:39:35 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'jsshell-linux-x86_64.zip'], 03:39:35 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:39:35 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:35 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:39:35 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:39:35 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:39:35 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:39:35 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:39:35 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:39:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:39: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')]} 03:39:35 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:38 INFO - Downloaded 23359918 bytes. 03:39:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:40 INFO - Return code: 0 03:39:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:40 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:43 INFO - Downloaded 23359918 bytes. 03:39:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:45 INFO - Return code: 0 03:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:45 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:39:46 INFO - Downloaded 10845194 bytes. 03:39:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:39:46 INFO - Return code: 0 03:39:46 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')]} 03:39:46 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:39:47 INFO - Downloaded 60835591 bytes. 03:39:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:47 INFO - mkdir: /builds/slave/test/properties 03:39:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:47 INFO - Contents: 03:39:47 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:39:48 INFO - Running post-action listener: _resource_record_post_action 03:39:48 INFO - Running post-action listener: set_extra_try_arguments 03:39:48 INFO - ##### 03:39:48 INFO - ##### Running populate-webroot step. 03:39:48 INFO - ##### 03:39:48 INFO - Running pre-action listener: _resource_record_pre_action 03:39:48 INFO - Running main action method: populate_webroot 03:39:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:48 INFO - '--tppagecycles', 03:39:48 INFO - '7'], 03:39:48 INFO - 'tests': ['tsvgm']}}, 03:39:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:39:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:39:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'tests': ['damp', 'tps']}, 03:39:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['damp', 'tps']}, 03:39:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:39:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:48 INFO - 'other': {'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'other_l64': {'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:39:48 INFO - 'ts_paint', 03:39:48 INFO - 'tpaint', 03:39:48 INFO - 'sessionrestore', 03:39:48 INFO - 'sessionrestore_no_auto_restore', 03:39:48 INFO - 'tabpaint']}, 03:39:48 INFO - 'svgr': {'tests': ['tsvgx', 03:39:48 INFO - 'tsvgr_opacity', 03:39:48 INFO - 'tart', 03:39:48 INFO - 'tscrollx', 03:39:48 INFO - 'cart']}, 03:39:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['tsvgx', 03:39:48 INFO - 'tsvgr_opacity', 03:39:48 INFO - 'tart', 03:39:48 INFO - 'tscrollx', 03:39:48 INFO - 'cart']}, 03:39:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'tests': ['tp5o']}, 03:39:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'talos_options': ['--e10s'], 03:39:48 INFO - 'tests': ['tp5o']}, 03:39:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'talos_options': ['--xperf_path', 03:39:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:48 INFO - 'tests': ['tp5n']}, 03:39:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:48 INFO - 'talos_options': ['--e10s', 03:39:48 INFO - '--xperf_path', 03:39:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:48 INFO - 'tests': ['tp5n']}}, 03:39:48 INFO - 'talos.zip': {'path': '', 03:39:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:48 INFO - Running post-action listener: _resource_record_post_action 03:39:48 INFO - ##### 03:39:48 INFO - ##### Running create-virtualenv step. 03:39:48 INFO - ##### 03:39:48 INFO - Running pre-action listener: _resource_record_pre_action 03:39:48 INFO - Running main action method: create_virtualenv 03:39:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:48 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 03:39:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:48 INFO - Using real prefix '/usr' 03:39:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:51 INFO - Installing pip.................done. 03:39:51 INFO - Return code: 0 03:39:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:51 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')]} 03:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:51 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')]} 03:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:51 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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:39:51 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 03:39:51 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 03:39:51 INFO - Using env: {'DISPLAY': ':0', 03:39:51 INFO - 'HOME': '/home/cltbld', 03:39:51 INFO - 'LANG': 'en_US.UTF-8', 03:39:51 INFO - 'LANGUAGE': 'en_US:en', 03:39:51 INFO - 'LOGNAME': 'cltbld', 03:39:51 INFO - 'MAIL': '/var/mail/cltbld', 03:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:51 INFO - 'MOZ_NO_REMOTE': '1', 03:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:51 INFO - 'NO_EM_RESTART': '1', 03:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:51 INFO - 'PWD': '/builds/slave/test', 03:39:51 INFO - 'SHELL': '/bin/bash', 03:39:51 INFO - 'SHLVL': '1', 03:39:51 INFO - 'TERM': 'linux', 03:39:51 INFO - 'TMOUT': '86400', 03:39:51 INFO - 'USER': 'cltbld', 03:39:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:51 INFO - '_': '/tools/buildbot/bin/python'} 03:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:51 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 03:39:51 INFO - Cleaning up... 03:39:51 INFO - Return code: 0 03:39:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:39:51 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')]} 03:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:51 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')]} 03:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:51 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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:39:51 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 03:39:51 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 03:39:51 INFO - Using env: {'DISPLAY': ':0', 03:39:51 INFO - 'HOME': '/home/cltbld', 03:39:51 INFO - 'LANG': 'en_US.UTF-8', 03:39:51 INFO - 'LANGUAGE': 'en_US:en', 03:39:51 INFO - 'LOGNAME': 'cltbld', 03:39:51 INFO - 'MAIL': '/var/mail/cltbld', 03:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:51 INFO - 'MOZ_NO_REMOTE': '1', 03:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:51 INFO - 'NO_EM_RESTART': '1', 03:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:51 INFO - 'PWD': '/builds/slave/test', 03:39:51 INFO - 'SHELL': '/bin/bash', 03:39:51 INFO - 'SHLVL': '1', 03:39:51 INFO - 'TERM': 'linux', 03:39:51 INFO - 'TMOUT': '86400', 03:39:51 INFO - 'USER': 'cltbld', 03:39:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:51 INFO - '_': '/tools/buildbot/bin/python'} 03:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:51 INFO - Downloading/unpacking psutil>=0.7.1 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:51 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 03:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:53 INFO - Installing collected packages: psutil 03:39:53 INFO - Running setup.py install for psutil 03:39:53 INFO - building 'psutil._psutil_linux' extension 03:39:53 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 03:39:53 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 03:39:53 INFO - building 'psutil._psutil_posix' extension 03:39:53 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 03:39:53 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 03:39:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:53 INFO - Successfully installed psutil 03:39:53 INFO - Cleaning up... 03:39:54 INFO - Return code: 0 03:39:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:39:54 INFO - Using env: {'DISPLAY': ':0', 03:39:54 INFO - 'HOME': '/home/cltbld', 03:39:54 INFO - 'LANG': 'en_US.UTF-8', 03:39:54 INFO - 'LANGUAGE': 'en_US:en', 03:39:54 INFO - 'LOGNAME': 'cltbld', 03:39:54 INFO - 'MAIL': '/var/mail/cltbld', 03:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:54 INFO - 'MOZ_NO_REMOTE': '1', 03:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:54 INFO - 'NO_EM_RESTART': '1', 03:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:54 INFO - 'PWD': '/builds/slave/test', 03:39:54 INFO - 'SHELL': '/bin/bash', 03:39:54 INFO - 'SHLVL': '1', 03:39:54 INFO - 'TERM': 'linux', 03:39:54 INFO - 'TMOUT': '86400', 03:39:54 INFO - 'USER': 'cltbld', 03:39:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:54 INFO - '_': '/tools/buildbot/bin/python'} 03:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:39:56 INFO - Installing collected packages: mozsystemmonitor 03:39:56 INFO - Running setup.py install for mozsystemmonitor 03:39:56 INFO - Successfully installed mozsystemmonitor 03:39:56 INFO - Cleaning up... 03:39:56 INFO - Return code: 0 03:39:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:39:56 INFO - Using env: {'DISPLAY': ':0', 03:39:56 INFO - 'HOME': '/home/cltbld', 03:39:56 INFO - 'LANG': 'en_US.UTF-8', 03:39:56 INFO - 'LANGUAGE': 'en_US:en', 03:39:56 INFO - 'LOGNAME': 'cltbld', 03:39:56 INFO - 'MAIL': '/var/mail/cltbld', 03:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:56 INFO - 'MOZ_NO_REMOTE': '1', 03:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:56 INFO - 'NO_EM_RESTART': '1', 03:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:56 INFO - 'PWD': '/builds/slave/test', 03:39:56 INFO - 'SHELL': '/bin/bash', 03:39:56 INFO - 'SHLVL': '1', 03:39:56 INFO - 'TERM': 'linux', 03:39:56 INFO - 'TMOUT': '86400', 03:39:56 INFO - 'USER': 'cltbld', 03:39:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:56 INFO - '_': '/tools/buildbot/bin/python'} 03:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:00 INFO - Downloading docopt-0.6.1.tar.gz 03:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:00 INFO - Running setup.py install for blobuploader 03:40:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:00 INFO - Running setup.py install for requests 03:40:00 INFO - Running setup.py install for docopt 03:40:00 INFO - Successfully installed blobuploader requests docopt 03:40:00 INFO - Cleaning up... 03:40:00 INFO - Return code: 0 03:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:00 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')]} 03:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:00 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')]} 03:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:00 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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:40:00 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 03:40:00 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 03:40:00 INFO - Using env: {'DISPLAY': ':0', 03:40:00 INFO - 'HOME': '/home/cltbld', 03:40:00 INFO - 'LANG': 'en_US.UTF-8', 03:40:00 INFO - 'LANGUAGE': 'en_US:en', 03:40:00 INFO - 'LOGNAME': 'cltbld', 03:40:00 INFO - 'MAIL': '/var/mail/cltbld', 03:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:00 INFO - 'MOZ_NO_REMOTE': '1', 03:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:00 INFO - 'NO_EM_RESTART': '1', 03:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:00 INFO - 'PWD': '/builds/slave/test', 03:40:00 INFO - 'SHELL': '/bin/bash', 03:40:00 INFO - 'SHLVL': '1', 03:40:00 INFO - 'TERM': 'linux', 03:40:00 INFO - 'TMOUT': '86400', 03:40:00 INFO - 'USER': 'cltbld', 03:40:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:00 INFO - '_': '/tools/buildbot/bin/python'} 03:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:00 INFO - Running setup.py (path:/tmp/pip-pqZrcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:01 INFO - Running setup.py (path:/tmp/pip-18IHC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:01 INFO - Running setup.py (path:/tmp/pip-YhdTfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:01 INFO - Running setup.py (path:/tmp/pip-jIvQ32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:01 INFO - Running setup.py (path:/tmp/pip-zz0TiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:01 INFO - Running setup.py (path:/tmp/pip-iSumKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:01 INFO - Running setup.py (path:/tmp/pip-XZAPi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:01 INFO - Running setup.py (path:/tmp/pip-tiAkmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:01 INFO - Running setup.py (path:/tmp/pip-8NGBVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:01 INFO - Running setup.py (path:/tmp/pip-DgXmd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:01 INFO - Running setup.py (path:/tmp/pip-pMbfUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:01 INFO - Running setup.py (path:/tmp/pip-Gx8bOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:01 INFO - Running setup.py (path:/tmp/pip-2B0HJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:01 INFO - Running setup.py (path:/tmp/pip-GSnwgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:01 INFO - Running setup.py (path:/tmp/pip-QLe4gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:02 INFO - Running setup.py (path:/tmp/pip-soVI9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:02 INFO - Running setup.py (path:/tmp/pip-PgBj_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:02 INFO - Running setup.py install for manifestparser 03:40:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Running setup.py install for mozcrash 03:40:02 INFO - Running setup.py install for mozdebug 03:40:02 INFO - Running setup.py install for mozdevice 03:40:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Running setup.py install for mozfile 03:40:02 INFO - Running setup.py install for mozhttpd 03:40:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Running setup.py install for mozinfo 03:40:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Running setup.py install for mozInstall 03:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:02 INFO - Running setup.py install for mozleak 03:40:03 INFO - Running setup.py install for mozlog 03:40:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Running setup.py install for moznetwork 03:40:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Running setup.py install for mozprocess 03:40:03 INFO - Running setup.py install for mozprofile 03:40:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Running setup.py install for mozrunner 03:40:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Running setup.py install for mozscreenshot 03:40:03 INFO - Running setup.py install for moztest 03:40:03 INFO - Running setup.py install for mozversion 03:40:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:03 INFO - Cleaning up... 03:40:03 INFO - Return code: 0 03:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:03 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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:40:03 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 03:40:03 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 03:40:03 INFO - Using env: {'DISPLAY': ':0', 03:40:03 INFO - 'HOME': '/home/cltbld', 03:40:03 INFO - 'LANG': 'en_US.UTF-8', 03:40:03 INFO - 'LANGUAGE': 'en_US:en', 03:40:03 INFO - 'LOGNAME': 'cltbld', 03:40:03 INFO - 'MAIL': '/var/mail/cltbld', 03:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:03 INFO - 'MOZ_NO_REMOTE': '1', 03:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:03 INFO - 'NO_EM_RESTART': '1', 03:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:03 INFO - 'PWD': '/builds/slave/test', 03:40:03 INFO - 'SHELL': '/bin/bash', 03:40:03 INFO - 'SHLVL': '1', 03:40:03 INFO - 'TERM': 'linux', 03:40:03 INFO - 'TMOUT': '86400', 03:40:03 INFO - 'USER': 'cltbld', 03:40:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:03 INFO - '_': '/tools/buildbot/bin/python'} 03:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:04 INFO - Running setup.py (path:/tmp/pip-gaIduD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:04 INFO - Running setup.py (path:/tmp/pip-DmcaJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:04 INFO - Running setup.py (path:/tmp/pip-MAYnQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:04 INFO - Running setup.py (path:/tmp/pip-6N7k9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:04 INFO - Running setup.py (path:/tmp/pip-oSr29H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:04 INFO - Running setup.py (path:/tmp/pip-EtsuAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:04 INFO - Running setup.py (path:/tmp/pip-_WHuJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:04 INFO - Running setup.py (path:/tmp/pip-RMbwQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:04 INFO - Running setup.py (path:/tmp/pip-B8ctds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:04 INFO - Running setup.py (path:/tmp/pip-IFt4hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:04 INFO - Running setup.py (path:/tmp/pip-_AFVHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:04 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)) 03:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:05 INFO - Running setup.py (path:/tmp/pip-4kZa5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:05 INFO - Running setup.py (path:/tmp/pip-KOl6hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:05 INFO - Running setup.py (path:/tmp/pip-G2p6IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:05 INFO - Running setup.py (path:/tmp/pip-UwFHh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:05 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)) 03:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:05 INFO - Running setup.py (path:/tmp/pip-nQCCoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:05 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)) 03:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:05 INFO - Running setup.py (path:/tmp/pip-aCuh8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:05 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)) 03:40:05 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)) 03:40:05 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)) 03:40:05 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)) 03:40:05 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)) 03:40:05 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)) 03:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:07 INFO - Downloading blessings-1.6.tar.gz 03:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:07 INFO - Installing collected packages: blessings 03:40:07 INFO - Running setup.py install for blessings 03:40:07 INFO - Successfully installed blessings 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:07 INFO - Reading from file tmpfile_stdout 03:40:07 INFO - Current package versions: 03:40:07 INFO - argparse == 1.2.1 03:40:07 INFO - blessings == 1.6 03:40:07 INFO - blobuploader == 1.2.4 03:40:07 INFO - docopt == 0.6.1 03:40:07 INFO - manifestparser == 1.1 03:40:07 INFO - mozInstall == 1.12 03:40:07 INFO - mozcrash == 0.17 03:40:07 INFO - mozdebug == 0.1 03:40:07 INFO - mozdevice == 0.48 03:40:07 INFO - mozfile == 1.2 03:40:07 INFO - mozhttpd == 0.7 03:40:07 INFO - mozinfo == 0.9 03:40:07 INFO - mozleak == 0.1 03:40:07 INFO - mozlog == 3.1 03:40:07 INFO - moznetwork == 0.27 03:40:07 INFO - mozprocess == 0.22 03:40:07 INFO - mozprofile == 0.28 03:40:07 INFO - mozrunner == 6.11 03:40:07 INFO - mozscreenshot == 0.1 03:40:07 INFO - mozsystemmonitor == 0.0 03:40:07 INFO - moztest == 0.7 03:40:07 INFO - mozversion == 1.4 03:40:07 INFO - psutil == 3.1.1 03:40:07 INFO - requests == 1.2.3 03:40:07 INFO - wsgiref == 0.1.2 03:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 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 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:40:07 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 03:40:07 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 03:40:07 INFO - Using env: {'DISPLAY': ':0', 03:40:07 INFO - 'HOME': '/home/cltbld', 03:40:07 INFO - 'LANG': 'en_US.UTF-8', 03:40:07 INFO - 'LANGUAGE': 'en_US:en', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MAIL': '/var/mail/cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SHLVL': '1', 03:40:07 INFO - 'TERM': 'linux', 03:40:07 INFO - 'TMOUT': '86400', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - '_': '/tools/buildbot/bin/python'} 03:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:08 INFO - Cleaning up... 03:40:08 INFO - Return code: 0 03:40:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:08 INFO - Using env: {'DISPLAY': ':0', 03:40:08 INFO - 'HOME': '/home/cltbld', 03:40:08 INFO - 'LANG': 'en_US.UTF-8', 03:40:08 INFO - 'LANGUAGE': 'en_US:en', 03:40:08 INFO - 'LOGNAME': 'cltbld', 03:40:08 INFO - 'MAIL': '/var/mail/cltbld', 03:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:08 INFO - 'MOZ_NO_REMOTE': '1', 03:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:08 INFO - 'NO_EM_RESTART': '1', 03:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:08 INFO - 'PWD': '/builds/slave/test', 03:40:08 INFO - 'SHELL': '/bin/bash', 03:40:08 INFO - 'SHLVL': '1', 03:40:08 INFO - 'TERM': 'linux', 03:40:08 INFO - 'TMOUT': '86400', 03:40:08 INFO - 'USER': 'cltbld', 03:40:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:08 INFO - '_': '/tools/buildbot/bin/python'} 03:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:08 INFO - Downloading/unpacking jsonschema 03:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:10 INFO - Downloading/unpacking functools32 (from jsonschema) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:10 INFO - warning: no files found matching '*.txt' 03:40:10 INFO - no previously-included directories found matching 'build' 03:40:10 INFO - no previously-included directories found matching 'dist' 03:40:10 INFO - no previously-included directories found matching '.git*' 03:40:10 INFO - Installing collected packages: jsonschema, functools32 03:40:10 INFO - Running setup.py install for functools32 03:40:10 INFO - warning: no files found matching '*.txt' 03:40:10 INFO - no previously-included directories found matching 'build' 03:40:10 INFO - no previously-included directories found matching 'dist' 03:40:10 INFO - no previously-included directories found matching '.git*' 03:40:10 INFO - Successfully installed jsonschema functools32 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f981499ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1947410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, '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': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', '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 03:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:40:10 INFO - Using env: {'DISPLAY': ':0', 03:40:10 INFO - 'HOME': '/home/cltbld', 03:40:10 INFO - 'LANG': 'en_US.UTF-8', 03:40:10 INFO - 'LANGUAGE': 'en_US:en', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MAIL': '/var/mail/cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SHLVL': '1', 03:40:10 INFO - 'TERM': 'linux', 03:40:10 INFO - 'TMOUT': '86400', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - '_': '/tools/buildbot/bin/python'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 INFO - Downloading/unpacking flake8 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:13 INFO - no previously-included directories found matching 'docs/_build' 03:40:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:13 INFO - Running setup.py install for pep8 03:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:13 INFO - no previously-included directories found matching 'docs/_build' 03:40:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:13 INFO - Cleaning up... 03:40:13 INFO - Return code: 0 03:40:13 INFO - Running post-action listener: _resource_record_post_action 03:40:13 INFO - Running post-action listener: _start_resource_monitoring 03:40:13 INFO - Starting resource monitoring. 03:40:13 INFO - ##### 03:40:13 INFO - ##### Running install step. 03:40:13 INFO - ##### 03:40:13 INFO - Running pre-action listener: _resource_record_pre_action 03:40:13 INFO - Running main action method: install 03:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:13 INFO - Reading from file tmpfile_stdout 03:40:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:13 INFO - Reading from file tmpfile_stdout 03:40:13 INFO - Output received: 03:40:13 INFO - Usage: mozinstall [options] installer 03:40:13 INFO - Options: 03:40:13 INFO - -h, --help show this help message and exit 03:40:13 INFO - -d DEST, --destination=DEST 03:40:13 INFO - Directory to install application into. [default: 03:40:13 INFO - "/builds/slave/test"] 03:40:13 INFO - --app=APP Application being installed. [default: firefox] 03:40:13 INFO - mkdir: /builds/slave/test/build/application 03:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:40:29 INFO - Reading from file tmpfile_stdout 03:40:29 INFO - Output received: 03:40:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:29 INFO - Running post-action listener: _resource_record_post_action 03:40:29 INFO - ##### 03:40:29 INFO - ##### Running run-tests step. 03:40:29 INFO - ##### 03:40:29 INFO - Running pre-action listener: _resource_record_pre_action 03:40:29 INFO - Running main action method: run_tests 03:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:29 INFO - Python 2.7.3 03:40:29 INFO - Return code: 0 03:40:29 INFO - grabbing minidump binary from tooltool 03:40:29 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')]} 03:40:29 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 0x19d6160>, '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 0x19d7060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d74f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:29 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 03:40:29 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 03:40:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:29 INFO - Return code: 0 03:40:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:40:30 INFO - Return code: 0 03:40:30 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:40:30 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 03:40:30 INFO - Using env: {'DISPLAY': ':0', 03:40:30 INFO - 'HOME': '/home/cltbld', 03:40:30 INFO - 'LANG': 'en_US.UTF-8', 03:40:30 INFO - 'LANGUAGE': 'en_US:en', 03:40:30 INFO - 'LOGNAME': 'cltbld', 03:40:30 INFO - 'MAIL': '/var/mail/cltbld', 03:40:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:30 INFO - 'MOZ_NO_REMOTE': '1', 03:40:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:30 INFO - 'NO_EM_RESTART': '1', 03:40:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:30 INFO - 'PWD': '/builds/slave/test', 03:40:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:30 INFO - 'SHELL': '/bin/bash', 03:40:30 INFO - 'SHLVL': '1', 03:40:30 INFO - 'TERM': 'linux', 03:40:30 INFO - 'TMOUT': '86400', 03:40:30 INFO - 'USER': 'cltbld', 03:40:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694', 03:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:30 INFO - '_': '/tools/buildbot/bin/python'} 03:40:30 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:40:30 INFO - mozversion application_buildid: 20160425062348 03:40:30 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:40:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:30 INFO - mozversion application_name: Firefox 03:40:30 INFO - mozversion application_remotingname: firefox-dev 03:40:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:30 INFO - mozversion application_vendor: Mozilla 03:40:30 INFO - mozversion application_version: 47.0a2 03:40:30 INFO - mozversion platform_buildid: 20160425062348 03:40:30 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:40:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:30 INFO - mozversion platform_version: 47.0a2 03:40:30 INFO - using testdate: 1461753630 03:40:30 INFO - actual date: 1461753630 03:40:30 INFO - starting webserver on 'localhost:46645' 03:40:30 INFO - SUITE-START | Running 2 tests 03:40:30 INFO - TEST-START | dromaeo_css 03:40:30 INFO - operating with platform_type : linux_ 03:40:30 INFO - Initialising browser for dromaeo_css test... 03:40:30 INFO - TEST-INFO | started process 15636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmramMT/profile http://localhost:46645/getInfo.html) 03:40:34 INFO - PROCESS | 15636 | __metrics Screen width/height:1600/1200 03:40:34 INFO - PROCESS | 15636 | colorDepth:24 03:40:34 INFO - PROCESS | 15636 | Browser inner width/height: 1024/697 03:40:34 INFO - PROCESS | 15636 | __metrics 03:40:35 INFO - PROCESS | 15636 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:36 INFO - TEST-INFO | 15636: exit 0 03:40:36 INFO - Browser initialized. 03:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:36 INFO - TEST-INFO | started process 15729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmramMT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:48 INFO - PROCESS | 15729 | RSS: Main: 142131200 03:40:48 INFO - PROCESS | 15729 | 03:41:39 INFO - PROCESS | 15729 | 1461753699661 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] 03:43:48 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46645/tests/dromaeo/cssquery-ext.html) 03:43:49 INFO - PROCESS | 15729 | RSS: Main: 244310016 03:43:49 INFO - PROCESS | 15729 | 03:46:51 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-ext.html (next: http://localhost:46645/tests/dromaeo/cssquery-jquery.html) 03:46:51 INFO - PROCESS | 15729 | RSS: Main: 218701824 03:46:51 INFO - PROCESS | 15729 | 03:49:53 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46645/tests/dromaeo/cssquery-mootools.html) 03:49:54 INFO - PROCESS | 15729 | RSS: Main: 224247808 03:49:54 INFO - PROCESS | 15729 | 03:52:55 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46645/tests/dromaeo/cssquery-prototype.html) 03:52:56 INFO - PROCESS | 15729 | RSS: Main: 204234752 03:52:56 INFO - PROCESS | 15729 | 03:55:58 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46645/tests/dromaeo/cssquery-yui.html) 03:55:59 INFO - PROCESS | 15729 | RSS: Main: 204136448 03:55:59 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:46645/tests/dromaeo/cssquery-yui.html (next: http://localhost:46645/tests/dromaeo/cssquery-dojo.html) 03:59:01 INFO - PROCESS | 15729 | RSS: Main: 251625472 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | __start_tp_report 03:59:01 INFO - PROCESS | 15729 | _x_x_mozilla_page_load 03:59:01 INFO - PROCESS | 15729 | _x_x_mozilla_page_load_details 03:59:01 INFO - PROCESS | 15729 | |i|pagename|runs| 03:59:01 INFO - PROCESS | 15729 | |0;dojo.html;3288.473844184931;3326;3347.447671134263;3348.2968576598896;3382.3066271414364;5356.38401583818;5367.302250707403;5385.973070134649;5388.461153884615;5423.2136340230645;5368.114261146916;5375.650582712121;5389.946100538993;5400.540954018913;5407.594430417715;4787.8563643090765;4901.215805471125;4937.210046392569;4950.925736113961;4983.651144419892;4944.60443164546;4956.0583489137125;4969.627277954168;5046.848594542152;5057.342545469084;5046.772895219724;5085.771140298695;5106.617003724717;5121.078205922932;5121.155009423459;4972.651914365996;5028.899422011539;5043.596512279046;5051.217061355477;5052.64631475795;4836.322914791932;4905.975470122662;4947.109520286347;4991.950080499221;5007.924881126786;5345.893082138375;5373.570114390839;5379.085555455582;5412.972935135338;5419.295491586068;5913;5945.167676525247;5946.583739138262;5948.107783832416;5951.4048595140575;5749.942500574983;5837.678927658977;5933.3473317934995;5963.821085367446;5973.641581505123;5498.120300751901;5519.227308176899;5531.308586426697;5538.390777014525;5539.806106786324;5783.595148339576;6046.758129674852;6070.505510266055;6074.179985701874;6082.482988945989;5723.227364305849;5832.562557808096;5862.325832529228;5864.472197502245;5891.116332550066;5870.354261031283;5895;5896.056630939115;5913.822585322448;5915.852103697356;5676.545876329884;5849.122631605208;5863.3257175424515;5874.765009399662;5880;5775.364709881909;5805.506531944832;5835.649861008353;5857.121431785181;5866.266716660418;4493.977530112394;4500.099980004013;4518.638508919278;4518.909621807546;4552.226121559343;3978.8607398740905;4069.2471892699946;4091.652209562161;4096.713230073926;4123.134141830189;5579.6652200868075;5625.128105143709;5627.493525582717;5649;5673.631213971079;5810.680412577349;5853.356130825606;5858.326292476335;5862.472377485961;5862.794802181903;5419.430959749169;5540.529055030368;5541.168824676331;5549.19536667181;5555.916661250085;5050.646454748133;5081.7967281309075;5084.44071152173;5089.847304580869;5109.310243117206;6006.789762358297;6019.4883434908525;6064.181335519736;6081.939180608138;6084.117802918552;5657.179708942098;5885.882282354243;5911.852203694942;5913.113033045078;5976.342602313829;6125.693715314305;6128.050152226412;6132.41742034506;6134.4172303631085;6134.693265336626;5862.824115276549;5878.676672782867;5883;5892.469677728854;5892.5285977122585;5717.971410143089;5809.302883653989;5931.9406805931385;5940.79207227745;5963.582549221513;5774.105013722879;5790.334111577223;5812.854678633068;5814.592978491465;5816.76732930678;5816.447437493432;5818.679972601378;5822.592418530662;5824.883502329845;5828.184054232495;5337.25278461008;5590.636608620427;5632.070708333079;5695.430456954271;5711.971440142939;5863.2670916135485;5881.38245484218;5887.852803679771;5890.14592884038;5915.08316210988;5431.293931788842;5757.596968212352;5767.826965191051;5769.451902069297;5771.826845194651 03:59:01 INFO - PROCESS | 15729 | |1;ext.html;562.1006389776355;595.217289264617;639.6737663791466;642.0305338938203;644.1915396177799;29843.95546155885;37882;38524.80737596308;38608.80695596518;38623.806880965625;42648;43475;43508.129837403314;43516.3472547912;43600.3459948101;7984.3213326867;8113.8782918256275;8622.870656940151;8818.162274583936;10137.341072830279;10127.544260508257;10284.382937023765;10284.640037598685;10296.639617613386;10301.27891047627;10267.281290309682;10325.896741032606;10330.070293673567;10344.5344959477;10347.896521034807;10184.439855807928;10252.589896404135;10264.384136951732;10265.794684106313;10268.383896966207;10522.42126683032;10659.786804263871;10707.411092389915;10709.357438553712;10713.303635263683;41280.1743965119;41873;41875.371869421986;41885.371719424234;41918;3788.6969042476535;3821.789801560913;3878.45701601776;3955.663768579674;4246.087091275391;32221.51667724986;32331.838340808146;32649.51025734616;32676.019719408458;33830;3781.867634632802;3828.5214348206473;3836;3855.325318069327;3926.5288165420334;292443;293565;293880;294488.527557363;294838;44732.77633611811;44925.10149796986;44948.52783096896;59580;60774;41268;41287.793561032006;41391.379129313085;41527.37708934368;41532;14930.10419374841;15844.44544440939;16006.199690015686;16017.038977661145;16022.19889005545;12791.04067194964;12890.67773305675;12897.742045159044;12917;12918.547850825176;14569.490067847575;14665.48670796517;14676.779848302283;14741.189234591986;14796.852031479762;5800;5835;5861.794837180678;5862.443067908542;5920.467157955804;1090.6237348114887;1121.3664279681955;1132.2074547816562;1143.805553055966;1146.2148428326623;29799.404011920073;29943.85028074846;31508.36983260322;31814.2046448836;32657.836710816293;1069.3583849690124;1091.4051841746268;1108.545496346494;1123.2642619084513;1209.2260952990093;14173.503927362493;14251.358688859027;14415.49545765914;14569.781453278209;14736.778948315783;428754;434183;435363;437544;438116;54417.45582544203;54819;54849.45150548523;54900.45099548953;55042;1354.2754626274896;1436.0163288147653;1488.1220080152762;1500.5723368840047;1506.6082818467057;28413;29287.267818304714;29339.706602933697;29360.85319573474;30072;45132.32301515414;45765.77117114393;45791.313130302406;45800.770996144805;45836.31245531253;245658;250825;250844;251094;251466;29233.707662923098;33189.51078669158;33350.16624584405;33649.495257571645;33770.83114584412;38245.23509529849;38756.6124338753;39009.80495097506;39327;39711.40432893567;33052.1736956578;33511.83244083764;33582.32835343328;33792.66207337895;33843.15392115217;41645.79177104095;41854.790726047395;41964.37053444262;42171.3674294892;42697.22468039567;35571.28857422785;36158.4576231362;36183.63816361803;36392.45411318779;36556.81721591375;31799.364012720078;33817.3236535263;34744.13139671528;35193;35501.82249088738;24042.87978560096;24710.629340560266;24923.252302430956;25478.872605636854;25519.744802551737 03:59:01 INFO - PROCESS | 15729 | |2;jquery.html;373.5461414381526;390.48651023903574;392.55052964355815;393.22142158526117;404.933186024306;16766.993980361185;18249.915555643864;18383.264669413224;18414.723779143325;18425.723614145765;17695.823041769578;17875.374361897302;18469.81530184698;18492.2603095876;18526.536836579093;4389.297712366022;5606.187102870082;5823.155642431845;5825.359210486843;5829.154772557977;4410.669199810011;6056.727447264883;6330.936690633103;6372.1397611322345;6374.713137908805;6056.636601803883;6238.220222472191;6242.625442473443;6326.557141000132;6428;6265.4361107500545;6289.622622642656;6313.936860631404;6315.557910946236;6343;3906.8046597670286;4048.1903619276263;5294.285271488377;5470.835874923759;5480.80817171401;20452.079656415495;20467.692984605244;20848.687269690967;22206.555868882533;22243.44391390212;2339.836211465198;2351.588472017407;2393.234165067179;2394.1022116706235;2431.756824317572;12850.871491285154;12912.418941147671;13099.410526526233;13168.012399070012;13461.865381346159;1815.3736960748652;1892.9526761831064;1907.8759880607715;1923.7691477022706;1936.8741031833026;62547.6872615634;64022.67988660074;64228.67885660588;64553;64788;10078.848817267746;10165.28842980999;10354.948225258826;10377.117944974761;10632.043116119432;14664.120152790867;14759.409623615149;14776.556703298918;14803.407863685332;14822.184779836996;8007.119216886138;8249.216324449168;8265.421420500506;8280;8315.708950186714;7996.24035716606;8063.153368896299;8092.595370231583;8113.310368618615;8113.797155071171;5623.156526521055;6141.723622436912;6263.4362907337645;6322.683865806784;6348.365163483615;1753.1321995612;1802.9909850450927;1914.2917120665443;1958.7453631027875;2032.5873517904913;1045.2474218562622;1088.6788397422622;1106.3804269609045;1142.4116579961326;1169.783590035829;17890.463286101436;18055.548611284823;18333.564755122516;18854.05729713509;19210.327638532584;1048.623432547197;1057.5981127171626;1058.0847566854616;1083.6261489786011;1135.199684222621;10599.682009539727;10842.186835987333;10969.23215374932;11023.215650464907;11084.337349397654;397002;420709;432845;434295;435289;73281;73698;74061;74467.62766186243;75010.62494687492;1104.5305745058317;1132.4903793292885;1133.9262947908524;1144.6966553863233;1159.7448561316496;15455.459058932884;15576.532704018897;15622.9218853905;15732.764008539652;15790.289436975594;31883.840580796947;32417.837910810296;33097.50353744648;33133.502997454576;33206;44542.55457445384;48325;50550.494495054576;51133.744331279595;51243.48756512536;8329.541875196923;8544.829103418022;8610;8623.698170564001;8654.913450865412;9999.500024998866;12257.632271031527;12745.235285882876;13129.343532823512;13272.402741876831;5653.406392328746;7205.819854503679;9975.102240798364;10519.948005199725;10708.518116684612;10950.178736594627;11231.887681123084;11243.325400475998;11395.658130256106;11421.771564568828;11034.503447344729;11465.656030319104;11543.595974140864;11610.5355785771;11749.882501175221;8599.699010534852;8634.56827158652;8722.825543489222;8731.602943529006;8798.47209167452;11465.312081274817;11593.768124637629;11640.417979100841;11644.35956022427;11776.528938842694 03:59:01 INFO - PROCESS | 15729 | |3;mootools.html;1472.7349077166118;1593.5378740165352;1614.241306585905;1849.1031849552965;1940.2530025940018;8040.396970227234;8217.30152937001;8224.259816616503;8224.835503289938;8230.91769082309;8260.215279548449;8430;8431.578421078952;8441.029281632615;8447.662093516252;2023.3120738948755;2343.5430091132193;2348.765123487655;2379.8453100548495;2408.1089996701244;2344.296710986706;2360.0441821062495;2361.2798096580536;2362.433016076138;2363.83453158279;2276.8747718875456;2347.835651504395;2351.8353715239855;2353.341064501942;2354.81161507079;2329.685492458513;2335.754745751697;2390.0200917623865;2400.183937461254;2408.4340180057584;2323.9419014524774;2327.9650805237934;2333.0084713996653;2366.786989170983;2377.358113309414;8528.658853645848;8537.060923298432;8599;8614.913850861474;8617.224449799485;4907.901841963177;5007.54932056113;5046.394432668103;5049.343585333883;5055.545000949895;3097.225693576606;3105.720485156347;3143.528470729386;3309.96690033099;3315.436375816117;1046.7016900183412;1057.7249915022073;1063.6702622187147;1066.0299127793671;1074.5648012554927;11137;11369.2609980351;11389.974902258753;11392.202545821796;11407.429628518625;4272.807723652443;4284.507281662586;4348.391225228471;4377.846775362847;4388.5830846069575;9250.352475326663;9283.071692830797;9285.442873427615;9287.349885508085;9292.16370526656;4448.621867141264;4983;5025.422076461181;5038.79844806211;5040.521150490697;4475.530069342737;4548.88627784308;4583.152116858392;4585.28928016158;4609.078184363141;3565.4295312749837;3646.2707458507875;3672.6510981456718;3687;3708.8145592720257;1073.4471747050275;1076.0315715855636;1087.478010554938;1087.8477013218155;1120.8991190792867;1389.305347326337;1408.6971301170297;1422.9857701423061;1425.7148570285983;1442.978355324671;7894.250046245597;8003.5197888126895;8053.436259461781;8059.234372734581;8072.394570407126;523.1459963013938;539.5252178083261;544.3848451250062;546.3089192171906;550.0429253099578;5956.315023772235;5988.011978023577;5992.550558708114;6028.306744724413;6053.213082299273;9841.852372214422;10253.897461025294;10320.277580569287;10413.791724165625;10426.478676066166;9950.054744799232;10061.899381006242;10161.339512931636;10239.078482936571;10290.279680422449;7972.083210430875;8029.076656184497;8097.271245587807;8118.75643730689;8139.4709343892455;7596.316331530189;7702.383809295355;7716.614169291625;7716.884246736416;7725.49784264021;8958.328125390752;9008.684696035869;9065.68270110543;9094.999550049357;9292.814143716952;9011.279097672039;9309.255259579353;9408.905910940803;9514.191293739832;9600.519974001132;6301.4328710416285;6811.114555107804;6971.8257043572285;7099.964500177466;7218;7947.602619869099;7956.204379562229;7970.601469926596;8013.038435387791;8031.116577176623;6921.653917304216;7063.258357872555;7139.393151581966;7177.066981292399;7234.095738032746;7077.292270772881;7102.467314951503;7136.286371362822;7243.203247642649;7275.1997280298065;7316.926830731624;7556.962215188889;7560.3573696236435;7567.9243207567215;7571.394288457021;6910.723571057302;7006.439484841302;7008.334208250208;7012.964935175291;7014.0531028310525;6694.6317952511135;6728.73085076611;6774.830629234309;6782.525223234524;6798.218204906499 03:59:01 INFO - PROCESS | 15729 | |4;prototype.html;362.7968337730871;363.19008610797937;365.6855104610035;369.3167639866248;371.21673269401566;6027;6028.728707208175;6033.668148251844;6070.119832624272;6083.604565703226;6012.038073908176;6018.06719958406;6022.638641681502;6027.156198132265;6028.698565071751;4505.819767209324;4562.361269422284;4582.404287442628;4682.719036857799;4718.646101542381;4661.160991021615;4686.53134686532;4688.5545873142;4692.178868697982;4697.107549565571;4640.978984623377;4645.279981602857;4651.279051746985;4660.976695116519;4662.300654901758;4480.731156130626;4556.453225612914;4567.063751930847;4603.930941035887;4613.884652883671;4037.1320166164414;4078.2251372239475;4084.4485994390675;4091.40674602184;4095.508538975312;5622.240997465331;5667.178259152441;5740.08158694611;5747.281589801275;5751.741171647286;5401.756920938567;5415.431379705153;5447.45525447456;5449.509544141047;5452.100403433429;6303.401176888234;6326.810195694136;6425.775097871552;6441.194850643669;6445.419912207877;4372.868813935587;4485.058137791068;4495.168393847149;4495.34817451471;4592.74739889306;6627.039079333518;6642.734290628369;6658.4340331071435;6660.800175994728;6670.7331706731675;4615.746133962597;4619.491855895849;4620.075984803053;4626.0979109073405;4628.722276663411;4705.6470764692785;4705.835295764632;4707.976460117678;4709.529047095263;4713;5394.109971854678;5396.244525766396;5397.2443857859935;5405.108157154104;5407.351117865881;6306.1171435998995;6418.326075761977;6419.839504012343;6443.5167362448;6445.129907462527;1645.9012459252483;1653.4378311374192;1660.7259802132755;1666.558362034062;1667.316400275881;1043;1063.1388575254068;1088.1729885287239;1102.1183053557122;1119.311623351633;6154.169187159766;6181.134641150243;6182.752689892444;6187.133801267826;6193.194884664965;6540;6582;6584.341565843377;6587.571807832475;6612.603243805387;6120.755169793248;6166.4758495527485;6172.4136207060255;6182.381761823782;6184.257889053342;3519.8416071276856;3549.165946002687;3556.524042522324;3559.110222444389;3560.928781424409;6552.901706474407;6750.527463077636;6751.594904305757;6754.425873800684;6763.391294783493;6701.430378417889;6705.731770729214;6715.630640314829;6723.596584204964;6724.092247546617;6721.294264102296;6721.798346049529;6727.562708423937;6730.192376914703;6743.190817101881;6559.6064236145985;6562.901556476752;6564.212294524687;6572.14562106923;6575.769848055295;6330.778422755181;6456.7740129095255;6457.418832305115;6458.709358078804;6533.118029066205;6681.866362672622;6698.363655452724;6717.56335838169;6722.092517510269;6732.427743641845;4637.443506779208;4642.303654451859;4644.8374306899095;4646.628269738345;4648.1168577970075;6542.247641521096;6547.410733033859;6548.214214294315;6549.60702357841;6550.7707230246715;6185.876282474415;6356.459700925288;6368.840778980377;6370.203724534434;6375.713092910737;6286.088517165077;6329.683515824098;6331.493480521455;6335.3981371769605;6339.302676705466;6147.309489890137;6151.876962460815;6161.938380616316;6164.506839452743;6168.907466388097;6297.937020629735;6355.046742988588;6355.52333574993;6363.745450182126;6372.617642941438;6100.8779824404155;6212.502999759918;6229.501639868709;6240.438360547572;6242.375762423721 03:59:01 INFO - PROCESS | 15729 | |5;yui.html;711.1111111111111;759.2255898983037;773.7369294439891;804.4489524675596;855.5636625321084;14028;14133.152010879328;14232.786508202385;14248.358823852926;14270.785938210922;13339.666508337272;13360.398782054806;13377.93311033446;13414.128081674684;13425.865741342608;907.4555266839893;941.6045260990367;941.9340646154772;942.29328003997;942.420411446962;927.0729270729271;934.7055677461578;937.2221056523069;937.7514958535993;937.9108984646448;959.1080295325345;961.3078583419926;961.5240455974302;961.8845738511353;962.3263715399214;896.7982204004047;949.5537097564134;950.3870003847514;950.8193443245796;951.4053716427198;660.8843452395812;664.773976847874;665.8834703926842;684.9212340580847;712.1596516110988;14459.710805783825;14474.782878256834;14488.927555362261;14537.927310363486;14576.708465830625;11947.402629868471;11982.460789264416;12164.08769342294;12199.695007624792;12411.503539858395;10079.89920100797;10129.290949633529;10282.280240383176;10632.946835265851;11104;3391.4573668213216;3418.6239513653477;3424.2637832866053;3427.108951672583;3428.9828550857087;42874.78562607167;45641.77179114083;46033.76983115097;50975.235371469455;51408.48591514074;9524.095210954949;9572.946667990918;9635.518224088908;9776.169025632758;9792.755181120387;18192.363267285582;18197.36309229197;18198.272069117353;18200.1809918554;18256.178471968793;7331.156916954512;7506.399488040944;7682.577458239851;7689.307962283421;7766.961165194138;3831.616838316146;3896.493455850721;3948.9012774680286;3959.6436320730695;4009;3194.6965038321323;3220.2754380264723;3222.5971753530807;3224.0972527692284;3228.1122691260093;599.6881621556853;611.1291409741101;615.6183166436838;630.2216762298558;636.3350298937621;630.0769372868677;634.3244444666416;650.440621065883;667.1926968368232;740.9592472414068;8221.630026648816;8411.285040771603;8469.491830490191;8502.362322825813;8633.352498562634;639.5523133806354;640.4268179978986;649.1009951217598;654.1332734127301;659.1562799616498;3751.4747935289083;3947.802609869495;4045.37296719009;4056.14820887611;4231.809568569422;60128;60715.39284607097;60915.39084609097;60930;61159;47442.525574744504;53823;55145.44854551483;55528.16707749387;55781.44218557762;50899;52630.21054684183;52915.12509798669;53586.73206633942;53678.926421471355;8831.470111793313;8859.512726800089;8925.196732294125;8979.14698103679;9030.819383612159;38032.80983595064;38122.618773811904;39022.4146637795;39621;39714.2057158861;44577;47765.52234477611;48174.75912620555;48572.75713621551;48729.26906096482;11766.117541184274;11922.582709605122;12057.15599907998;12058.819117713067;12136.514539418324;12955.935220323838;13035.47858085666;13039.608811735663;13371.732565348833;13606;11221.831672524755;11390.601328953448;11552.306861588331;11631.941840290745;11655;11421;11517;11583.362915039754;11806.173567850168;11838.704032399259;11475.426228688366;11543.769124617293;11826.34955077479;12026.75946481048;12038.939805301268;10322.380657160595;10424.530896109845;10478.895211047791;10705.411202383631;10826.51280692355;10251.84622230682;10423.635172768916;10426.791464170523;10538.262321637412;10553.947230263799 03:59:01 INFO - PROCESS | 15729 | __end_tp_report 03:59:01 INFO - PROCESS | 15729 | __start_cc_report 03:59:01 INFO - PROCESS | 15729 | _x_x_mozilla_cycle_collect,777 03:59:01 INFO - PROCESS | 15729 | __end_cc_report 03:59:01 INFO - PROCESS | 15729 | __startTimestamp1461754741839__endTimestamp 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | ------- Summary: start ------- 03:59:01 INFO - PROCESS | 15729 | Number of tests: 6 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#0] dojo.html Cycles:165 Average:5470.04 Median:5711.97 stddev:605.54 (10.6%) stddev-sans-first:582.72 03:59:01 INFO - PROCESS | 15729 | Values: 3288.5 3326.0 3347.4 3348.3 3382.3 5356.4 5367.3 5386.0 5388.5 5423.2 5368.1 5375.7 5389.9 5400.5 5407.6 4787.9 4901.2 4937.2 4950.9 4983.7 4944.6 4956.1 4969.6 5046.8 5057.3 5046.8 5085.8 5106.6 5121.1 5121.2 4972.7 5028.9 5043.6 5051.2 5052.6 4836.3 4906.0 4947.1 4992.0 5007.9 5345.9 5373.6 5379.1 5413.0 5419.3 5913.0 5945.2 5946.6 5948.1 5951.4 5749.9 5837.7 5933.3 5963.8 5973.6 5498.1 5519.2 5531.3 5538.4 5539.8 5783.6 6046.8 6070.5 6074.2 6082.5 5723.2 5832.6 5862.3 5864.5 5891.1 5870.4 5895.0 5896.1 5913.8 5915.9 5676.5 5849.1 5863.3 5874.8 5880.0 5775.4 5805.5 5835.6 5857.1 5866.3 4494.0 4500.1 4518.6 4518.9 4552.2 3978.9 4069.2 4091.7 4096.7 4123.1 5579.7 5625.1 5627.5 5649.0 5673.6 5810.7 5853.4 5858.3 5862.5 5862.8 5419.4 5540.5 5541.2 5549.2 5555.9 5050.6 5081.8 5084.4 5089.8 5109.3 6006.8 6019.5 6064.2 6081.9 6084.1 5657.2 5885.9 5911.9 5913.1 5976.3 6125.7 6128.1 6132.4 6134.4 6134.7 5862.8 5878.7 5883.0 5892.5 5892.5 5718.0 5809.3 5931.9 5940.8 5963.6 5774.1 5790.3 5812.9 5814.6 5816.8 5816.4 5818.7 5822.6 5824.9 5828.2 5337.3 5590.6 5632.1 5695.4 5712.0 5863.3 5881.4 5887.9 5890.1 5915.1 5431.3 5757.6 5767.8 5769.5 5771.8 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#1] ext.html Cycles:180 Average:48750.42 Median:33431.00 stddev:88387.80 (264.4%) stddev-sans-first:88561.70 03:59:01 INFO - PROCESS | 15729 | Values: 562.1 595.2 639.7 642.0 644.2 29844.0 37882.0 38524.8 38608.8 38623.8 42648.0 43475.0 43508.1 43516.3 43600.3 7984.3 8113.9 8622.9 8818.2 10137.3 10127.5 10284.4 10284.6 10296.6 10301.3 10267.3 10325.9 10330.1 10344.5 10347.9 10184.4 10252.6 10264.4 10265.8 10268.4 10522.4 10659.8 10707.4 10709.4 10713.3 41280.2 41873.0 41875.4 41885.4 41918.0 3788.7 3821.8 3878.5 3955.7 4246.1 32221.5 32331.8 32649.5 32676.0 33830.0 3781.9 3828.5 3836.0 3855.3 3926.5 292443.0 293565.0 293880.0 294488.5 294838.0 44732.8 44925.1 44948.5 59580.0 60774.0 41268.0 41287.8 41391.4 41527.4 41532.0 14930.1 15844.4 16006.2 16017.0 16022.2 12791.0 12890.7 12897.7 12917.0 12918.5 14569.5 14665.5 14676.8 14741.2 14796.9 5800.0 5835.0 5861.8 5862.4 5920.5 1090.6 1121.4 1132.2 1143.8 1146.2 29799.4 29943.9 31508.4 31814.2 32657.8 1069.4 1091.4 1108.5 1123.3 1209.2 14173.5 14251.4 14415.5 14569.8 14736.8 428754.0 434183.0 435363.0 437544.0 438116.0 54417.5 54819.0 54849.5 54900.5 55042.0 1354.3 1436.0 1488.1 1500.6 1506.6 28413.0 29287.3 29339.7 29360.9 30072.0 45132.3 45765.8 45791.3 45800.8 45836.3 245658.0 250825.0 250844.0 251094.0 251466.0 29233.7 33189.5 33350.2 33649.5 33770.8 38245.2 38756.6 39009.8 39327.0 39711.4 33052.2 33511.8 33582.3 33792.7 33843.2 41645.8 41854.8 41964.4 42171.4 42697.2 35571.3 36158.5 36183.6 36392.5 36556.8 31799.4 33817.3 34744.1 35193.0 35501.8 24042.9 24710.6 24923.3 25478.9 25519.7 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#2] jquery.html Cycles:180 Average:25516.40 Median:12291.64 stddev:69535.96 (565.7%) stddev-sans-first:69705.40 03:59:01 INFO - PROCESS | 15729 | Values: 373.5 390.5 392.6 393.2 404.9 16767.0 18249.9 18383.3 18414.7 18425.7 17695.8 17875.4 18469.8 18492.3 18526.5 4389.3 5606.2 5823.2 5825.4 5829.2 4410.7 6056.7 6330.9 6372.1 6374.7 6056.6 6238.2 6242.6 6326.6 6428.0 6265.4 6289.6 6313.9 6315.6 6343.0 3906.8 4048.2 5294.3 5470.8 5480.8 20452.1 20467.7 20848.7 22206.6 22243.4 2339.8 2351.6 2393.2 2394.1 2431.8 12850.9 12912.4 13099.4 13168.0 13461.9 1815.4 1893.0 1907.9 1923.8 1936.9 62547.7 64022.7 64228.7 64553.0 64788.0 10078.8 10165.3 10354.9 10377.1 10632.0 14664.1 14759.4 14776.6 14803.4 14822.2 8007.1 8249.2 8265.4 8280.0 8315.7 7996.2 8063.2 8092.6 8113.3 8113.8 5623.2 6141.7 6263.4 6322.7 6348.4 1753.1 1803.0 1914.3 1958.7 2032.6 1045.2 1088.7 1106.4 1142.4 1169.8 17890.5 18055.5 18333.6 18854.1 19210.3 1048.6 1057.6 1058.1 1083.6 1135.2 10599.7 10842.2 10969.2 11023.2 11084.3 397002.0 420709.0 432845.0 434295.0 435289.0 73281.0 73698.0 74061.0 74467.6 75010.6 1104.5 1132.5 1133.9 1144.7 1159.7 15455.5 15576.5 15622.9 15732.8 15790.3 31883.8 32417.8 33097.5 33133.5 33206.0 44542.6 48325.0 50550.5 51133.7 51243.5 8329.5 8544.8 8610.0 8623.7 8654.9 9999.5 12257.6 12745.2 13129.3 13272.4 5653.4 7205.8 9975.1 10519.9 10708.5 10950.2 11231.9 11243.3 11395.7 11421.8 11034.5 11465.7 11543.6 11610.5 11749.9 8599.7 8634.6 8722.8 8731.6 8798.5 11465.3 11593.8 11640.4 11644.4 11776.5 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#3] mootools.html Cycles:180 Average:5777.75 Median:545.35 stddev:3075.59 (564.0%) stddev-sans-first:3067.20 03:59:01 INFO - PROCESS | 15729 | Values: 1472.7 1593.5 1614.2 1849.1 1940.3 8040.4 8217.3 8224.3 8224.8 8230.9 8260.2 8430.0 8431.6 8441.0 8447.7 2023.3 2343.5 2348.8 2379.8 2408.1 2344.3 2360.0 2361.3 2362.4 2363.8 2276.9 2347.8 2351.8 2353.3 2354.8 2329.7 2335.8 2390.0 2400.2 2408.4 2323.9 2328.0 2333.0 2366.8 2377.4 8528.7 8537.1 8599.0 8614.9 8617.2 4907.9 5007.5 5046.4 5049.3 5055.5 3097.2 3105.7 3143.5 3310.0 3315.4 1046.7 1057.7 1063.7 1066.0 1074.6 11137.0 11369.3 11390.0 11392.2 11407.4 4272.8 4284.5 4348.4 4377.8 4388.6 9250.4 9283.1 9285.4 9287.3 9292.2 4448.6 4983.0 5025.4 5038.8 5040.5 4475.5 4548.9 4583.2 4585.3 4609.1 3565.4 3646.3 3672.7 3687.0 3708.8 1073.4 1076.0 1087.5 1087.8 1120.9 1389.3 1408.7 1423.0 1425.7 1443.0 7894.3 8003.5 8053.4 8059.2 8072.4 523.1 539.5 544.4 546.3 550.0 5956.3 5988.0 5992.6 6028.3 6053.2 9841.9 10253.9 10320.3 10413.8 10426.5 9950.1 10061.9 10161.3 10239.1 10290.3 7972.1 8029.1 8097.3 8118.8 8139.5 7596.3 7702.4 7716.6 7716.9 7725.5 8958.3 9008.7 9065.7 9095.0 9292.8 9011.3 9309.3 9408.9 9514.2 9600.5 6301.4 6811.1 6971.8 7100.0 7218.0 7947.6 7956.2 7970.6 8013.0 8031.1 6921.7 7063.3 7139.4 7177.1 7234.1 7077.3 7102.5 7136.3 7243.2 7275.2 7316.9 7557.0 7560.4 7567.9 7571.4 6910.7 7006.4 7008.3 7013.0 7014.1 6694.6 6728.7 6774.8 6782.5 6798.2 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#4] prototype.html Cycles:180 Average:5346.97 Median:6110.82 stddev:1581.82 (25.9%) stddev-sans-first:1541.39 03:59:01 INFO - PROCESS | 15729 | Values: 362.8 363.2 365.7 369.3 371.2 6027.0 6028.7 6033.7 6070.1 6083.6 6012.0 6018.1 6022.6 6027.2 6028.7 4505.8 4562.4 4582.4 4682.7 4718.6 4661.2 4686.5 4688.6 4692.2 4697.1 4641.0 4645.3 4651.3 4661.0 4662.3 4480.7 4556.5 4567.1 4603.9 4613.9 4037.1 4078.2 4084.4 4091.4 4095.5 5622.2 5667.2 5740.1 5747.3 5751.7 5401.8 5415.4 5447.5 5449.5 5452.1 6303.4 6326.8 6425.8 6441.2 6445.4 4372.9 4485.1 4495.2 4495.3 4592.7 6627.0 6642.7 6658.4 6660.8 6670.7 4615.7 4619.5 4620.1 4626.1 4628.7 4705.6 4705.8 4708.0 4709.5 4713.0 5394.1 5396.2 5397.2 5405.1 5407.4 6306.1 6418.3 6419.8 6443.5 6445.1 1645.9 1653.4 1660.7 1666.6 1667.3 1043.0 1063.1 1088.2 1102.1 1119.3 6154.2 6181.1 6182.8 6187.1 6193.2 6540.0 6582.0 6584.3 6587.6 6612.6 6120.8 6166.5 6172.4 6182.4 6184.3 3519.8 3549.2 3556.5 3559.1 3560.9 6552.9 6750.5 6751.6 6754.4 6763.4 6701.4 6705.7 6715.6 6723.6 6724.1 6721.3 6721.8 6727.6 6730.2 6743.2 6559.6 6562.9 6564.2 6572.1 6575.8 6330.8 6456.8 6457.4 6458.7 6533.1 6681.9 6698.4 6717.6 6722.1 6732.4 4637.4 4642.3 4644.8 4646.6 4648.1 6542.2 6547.4 6548.2 6549.6 6550.8 6185.9 6356.5 6368.8 6370.2 6375.7 6286.1 6329.7 6331.5 6335.4 6339.3 6147.3 6151.9 6161.9 6164.5 6168.9 6297.9 6355.0 6355.5 6363.7 6372.6 6100.9 6212.5 6229.5 6240.4 6242.4 03:59:01 INFO - PROCESS | 15729 | 03:59:01 INFO - PROCESS | 15729 | [#5] yui.html Cycles:180 Average:14478.50 Median:43725.89 stddev:16983.52 (38.8%) stddev-sans-first:16999.70 03:59:01 INFO - PROCESS | 15729 | Values: 711.1 759.2 773.7 804.4 855.6 14028.0 14133.2 14232.8 14248.4 14270.8 13339.7 13360.4 13377.9 13414.1 13425.9 907.5 941.6 941.9 942.3 942.4 927.1 934.7 937.2 937.8 937.9 959.1 961.3 961.5 961.9 962.3 896.8 949.6 950.4 950.8 951.4 660.9 664.8 665.9 684.9 712.2 14459.7 14474.8 14488.9 14537.9 14576.7 11947.4 11982.5 12164.1 12199.7 12411.5 10079.9 10129.3 10282.3 10632.9 11104.0 3391.5 3418.6 3424.3 3427.1 3429.0 42874.8 45641.8 46033.8 50975.2 51408.5 9524.1 9572.9 9635.5 9776.2 9792.8 18192.4 18197.4 18198.3 18200.2 18256.2 7331.2 7506.4 7682.6 7689.3 7767.0 3831.6 3896.5 3948.9 3959.6 4009.0 3194.7 3220.3 3222.6 3224.1 3228.1 599.7 611.1 615.6 630.2 636.3 630.1 634.3 650.4 667.2 741.0 8221.6 8411.3 8469.5 8502.4 8633.4 639.6 640.4 649.1 654.1 659.2 3751.5 3947.8 4045.4 4056.1 4231.8 60128.0 60715.4 60915.4 60930.0 61159.0 47442.5 53823.0 55145.4 55528.2 55781.4 50899.0 52630.2 52915.1 53586.7 53678.9 8831.5 8859.5 8925.2 8979.1 9030.8 38032.8 38122.6 39022.4 39621.0 39714.2 44577.0 47765.5 48174.8 48572.8 48729.3 11766.1 11922.6 12057.2 12058.8 12136.5 12955.9 13035.5 13039.6 13371.7 13606.0 11221.8 11390.6 11552.3 11631.9 11655.0 11421.0 11517.0 11583.4 11806.2 11838.7 11475.4 11543.8 11826.3 12026.8 12038.9 10322.4 10424.5 10478.9 10705.4 10826.5 10251.8 10423.6 10426.8 10538.3 10553.9 03:59:01 INFO - PROCESS | 15729 | -------- Summary: end -------- 03:59:01 INFO - PROCESS | 15729 | 03:59:02 INFO - TEST-INFO | 15729: exit 0 03:59:02 INFO - TEST-OK | dromaeo_css | took 1112019ms 03:59:02 INFO - TEST-START | kraken 03:59:02 INFO - operating with platform_type : linux_ 03:59:02 INFO - Initialising browser for kraken test... 03:59:02 INFO - TEST-INFO | started process 15930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ZElno/profile http://localhost:46645/getInfo.html) 03:59:06 INFO - PROCESS | 15930 | __metrics Screen width/height:1600/1200 03:59:06 INFO - PROCESS | 15930 | colorDepth:24 03:59:06 INFO - PROCESS | 15930 | Browser inner width/height: 1024/697 03:59:06 INFO - PROCESS | 15930 | __metrics 03:59:07 INFO - PROCESS | 15930 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:08 INFO - TEST-INFO | 15930: exit 0 03:59:08 INFO - Browser initialized. 03:59:08 INFO - Running cycle 1/1 for kraken test... 03:59:08 INFO - TEST-INFO | started process 16019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ZElno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:20 INFO - PROCESS | 16019 | RSS: Main: 141893632 03:59:20 INFO - PROCESS | 16019 | 03:59:22 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46645/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:23 INFO - PROCESS | 16019 | RSS: Main: 178311168 03:59:23 INFO - PROCESS | 16019 | 03:59:26 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46645/tests/kraken/driver.html?testName=audio-dft) 03:59:26 INFO - PROCESS | 16019 | RSS: Main: 175808512 03:59:26 INFO - PROCESS | 16019 | 03:59:29 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46645/tests/kraken/driver.html?testName=audio-fft) 03:59:30 INFO - PROCESS | 16019 | RSS: Main: 172609536 03:59:30 INFO - PROCESS | 16019 | 03:59:32 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46645/tests/kraken/driver.html?testName=audio-oscillator) 03:59:32 INFO - PROCESS | 16019 | RSS: Main: 173744128 03:59:32 INFO - PROCESS | 16019 | 03:59:34 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46645/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:35 INFO - PROCESS | 16019 | RSS: Main: 171999232 03:59:35 INFO - PROCESS | 16019 | 03:59:38 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46645/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:39 INFO - PROCESS | 16019 | RSS: Main: 171315200 03:59:39 INFO - PROCESS | 16019 | 03:59:42 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46645/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:42 INFO - PROCESS | 16019 | RSS: Main: 171913216 03:59:42 INFO - PROCESS | 16019 | 03:59:45 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46645/tests/kraken/driver.html?testName=json-parse-financial) 03:59:46 INFO - PROCESS | 16019 | RSS: Main: 171663360 03:59:46 INFO - PROCESS | 16019 | 03:59:47 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46645/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:48 INFO - PROCESS | 16019 | RSS: Main: 175960064 03:59:48 INFO - PROCESS | 16019 | 03:59:50 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:50 INFO - PROCESS | 16019 | RSS: Main: 173580288 03:59:50 INFO - PROCESS | 16019 | 03:59:52 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:53 INFO - PROCESS | 16019 | RSS: Main: 180150272 03:59:53 INFO - PROCESS | 16019 | 03:59:55 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:56 INFO - PROCESS | 16019 | RSS: Main: 186994688 03:59:56 INFO - PROCESS | 16019 | 03:59:58 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:59 INFO - PROCESS | 16019 | RSS: Main: 186503168 03:59:59 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | Cycle 1(1): loaded http://localhost:46645/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46645/tests/kraken/driver.html?testName=ai-astar) 04:00:01 INFO - PROCESS | 16019 | RSS: Main: 248483840 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | __start_tp_report 04:00:01 INFO - PROCESS | 16019 | _x_x_mozilla_page_load 04:00:01 INFO - PROCESS | 16019 | _x_x_mozilla_page_load_details 04:00:01 INFO - PROCESS | 16019 | |i|pagename|runs| 04:00:01 INFO - PROCESS | 16019 | |0;ai-astar;110;112;106;110;110;111;102;111;111;112 04:00:01 INFO - PROCESS | 16019 | |1;audio-beat-detection;170;126;156;161;127;156;150;127;172;126 04:00:01 INFO - PROCESS | 16019 | |2;audio-dft;163;160;159;160;160;161;160;170;160;159 04:00:01 INFO - PROCESS | 16019 | |3;audio-fft;74;76;75;157;76;73;74;76;158;75 04:00:01 INFO - PROCESS | 16019 | |4;audio-oscillator;93;92;147;92;93;91;136;93;92;136 04:00:01 INFO - PROCESS | 16019 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;116;119;117 04:00:01 INFO - PROCESS | 16019 | |6;imaging-darkroom;147;146;146;145;146;145;145;146;146;146 04:00:01 INFO - PROCESS | 16019 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 04:00:01 INFO - PROCESS | 16019 | |8;json-parse-financial;57;57;57;56;59;56;57;67;54;57 04:00:01 INFO - PROCESS | 16019 | |9;json-stringify-tinderbox;63;65;63;64;66;64;64;64;63;63 04:00:01 INFO - PROCESS | 16019 | |10;stanford-crypto-aes;77;78;79;78;85;77;78;77;77;77 04:00:01 INFO - PROCESS | 16019 | |11;stanford-crypto-ccm;116;113;114;115;113;115;127;116;111;123 04:00:01 INFO - PROCESS | 16019 | |12;stanford-crypto-pbkdf2;147;135;145;146;143;134;144;147;149;146 04:00:01 INFO - PROCESS | 16019 | |13;stanford-crypto-sha256-iterative;66;70;67;65;66;66;66;68;64;64 04:00:01 INFO - PROCESS | 16019 | __end_tp_report 04:00:01 INFO - PROCESS | 16019 | __start_cc_report 04:00:01 INFO - PROCESS | 16019 | _x_x_mozilla_cycle_collect,1054 04:00:01 INFO - PROCESS | 16019 | __end_cc_report 04:00:01 INFO - PROCESS | 16019 | __startTimestamp1461754801303__endTimestamp 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | ------- Summary: start ------- 04:00:01 INFO - PROCESS | 16019 | Number of tests: 14 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:3.32 04:00:01 INFO - PROCESS | 16019 | Values: 110.0 112.0 106.0 110.0 110.0 111.0 102.0 111.0 111.0 112.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:156.00 stddev:18.86 (12.1%) stddev-sans-first:18.10 04:00:01 INFO - PROCESS | 16019 | Values: 170.0 126.0 156.0 161.0 127.0 156.0 150.0 127.0 172.0 126.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#2] audio-dft Cycles:10 Average:161.20 Median:160.00 stddev:3.29 (2.1%) stddev-sans-first:3.43 04:00:01 INFO - PROCESS | 16019 | Values: 163.0 160.0 159.0 160.0 160.0 161.0 160.0 170.0 160.0 159.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:34.85 (46.5%) stddev-sans-first:36.39 04:00:01 INFO - PROCESS | 16019 | Values: 74.0 76.0 75.0 157.0 76.0 73.0 74.0 76.0 158.0 75.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:92.00 stddev:23.09 (25.1%) stddev-sans-first:23.97 04:00:01 INFO - PROCESS | 16019 | Values: 93.0 92.0 147.0 92.0 93.0 91.0 136.0 93.0 92.0 136.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:00:01 INFO - PROCESS | 16019 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 119.0 117.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 04:00:01 INFO - PROCESS | 16019 | Values: 147.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:00:01 INFO - PROCESS | 16019 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.50 (6.1%) stddev-sans-first:3.70 04:00:01 INFO - PROCESS | 16019 | Values: 57.0 57.0 57.0 56.0 59.0 56.0 57.0 67.0 54.0 57.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 04:00:01 INFO - PROCESS | 16019 | Values: 63.0 65.0 63.0 64.0 66.0 64.0 64.0 64.0 63.0 63.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:2.45 (3.1%) stddev-sans-first:2.55 04:00:01 INFO - PROCESS | 16019 | Values: 77.0 78.0 79.0 78.0 85.0 77.0 78.0 77.0 77.0 77.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:4.92 (4.3%) stddev-sans-first:5.22 04:00:01 INFO - PROCESS | 16019 | Values: 116.0 113.0 114.0 115.0 113.0 115.0 127.0 116.0 111.0 123.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:146.00 stddev:5.08 (3.5%) stddev-sans-first:5.24 04:00:01 INFO - PROCESS | 16019 | Values: 147.0 135.0 145.0 146.0 143.0 134.0 144.0 147.0 149.0 146.0 04:00:01 INFO - PROCESS | 16019 | 04:00:01 INFO - PROCESS | 16019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 04:00:01 INFO - PROCESS | 16019 | Values: 66.0 70.0 67.0 65.0 66.0 66.0 66.0 68.0 64.0 64.0 04:00:01 INFO - PROCESS | 16019 | -------- Summary: end -------- 04:00:01 INFO - PROCESS | 16019 | 04:00:02 INFO - TEST-INFO | 16019: exit 0 04:00:02 INFO - TEST-OK | kraken | took 59913ms 04:00:02 INFO - SUITE-END | took 1171s 04:00:02 INFO - Completed test suite (00:19:31) 04:00:02 INFO - javascript benchmark 04:00:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3288.473844184931, 3326.0, 3347.447671134263, 3348.2968576598896, 3382.3066271414364, 5356.38401583818, 5367.302250707403, 5385.973070134649, 5388.461153884615, 5423.2136340230645, 5368.114261146916, 5375.650582712121, 5389.946100538993, 5400.540954018913, 5407.594430417715, 4787.8563643090765, 4901.215805471125, 4937.210046392569, 4950.925736113961, 4983.651144419892, 4944.60443164546, 4956.0583489137125, 4969.627277954168, 5046.848594542152, 5057.342545469084, 5046.772895219724, 5085.771140298695, 5106.617003724717, 5121.078205922932, 5121.155009423459, 4972.651914365996, 5028.899422011539, 5043.596512279046, 5051.217061355477, 5052.64631475795, 4836.322914791932, 4905.975470122662, 4947.109520286347, 4991.950080499221, 5007.924881126786, 5345.893082138375, 5373.570114390839, 5379.085555455582, 5412.972935135338, 5419.295491586068, 5913.0, 5945.167676525247, 5946.583739138262, 5948.107783832416, 5951.4048595140575, 5749.942500574983, 5837.678927658977, 5933.3473317934995, 5963.821085367446, 5973.641581505123, 5498.120300751901, 5519.227308176899, 5531.308586426697, 5538.390777014525, 5539.806106786324, 5783.595148339576, 6046.758129674852, 6070.505510266055, 6074.179985701874, 6082.482988945989, 5723.227364305849, 5832.562557808096, 5862.325832529228, 5864.472197502245, 5891.116332550066, 5870.354261031283, 5895.0, 5896.056630939115, 5913.822585322448, 5915.852103697356, 5676.545876329884, 5849.122631605208, 5863.3257175424515, 5874.765009399662, 5880.0, 5775.364709881909, 5805.506531944832, 5835.649861008353, 5857.121431785181, 5866.266716660418, 4493.977530112394, 4500.099980004013, 4518.638508919278, 4518.909621807546, 4552.226121559343, 3978.8607398740905, 4069.2471892699946, 4091.652209562161, 4096.713230073926, 4123.134141830189, 5579.6652200868075, 5625.128105143709, 5627.493525582717, 5649.0, 5673.631213971079, 5810.680412577349, 5853.356130825606, 5858.326292476335, 5862.472377485961, 5862.794802181903, 5419.430959749169, 5540.529055030368, 5541.168824676331, 5549.19536667181, 5555.916661250085, 5050.646454748133, 5081.7967281309075, 5084.44071152173, 5089.847304580869, 5109.310243117206, 6006.789762358297, 6019.4883434908525, 6064.181335519736, 6081.939180608138, 6084.117802918552, 5657.179708942098, 5885.882282354243, 5911.852203694942, 5913.113033045078, 5976.342602313829, 6125.693715314305, 6128.050152226412, 6132.41742034506, 6134.4172303631085, 6134.693265336626, 5862.824115276549, 5878.676672782867, 5883.0, 5892.469677728854, 5892.5285977122585, 5717.971410143089, 5809.302883653989, 5931.9406805931385, 5940.79207227745, 5963.582549221513, 5774.105013722879, 5790.334111577223, 5812.854678633068, 5814.592978491465, 5816.76732930678, 5816.447437493432, 5818.679972601378, 5822.592418530662, 5824.883502329845, 5828.184054232495, 5337.25278461008, 5590.636608620427, 5632.070708333079, 5695.430456954271, 5711.971440142939, 5863.2670916135485, 5881.38245484218, 5887.852803679771, 5890.14592884038, 5915.08316210988, 5431.293931788842, 5757.596968212352, 5767.826965191051, 5769.451902069297, 5771.826845194651], "unit": "score", "name": "dojo.html", "value": 5431.273250441764}, {"lowerIsBetter": false, "replicates": [562.1006389776355, 595.217289264617, 639.6737663791466, 642.0305338938203, 644.1915396177799, 29843.95546155885, 37882.0, 38524.80737596308, 38608.80695596518, 38623.806880965625, 42648.0, 43475.0, 43508.129837403314, 43516.3472547912, 43600.3459948101, 7984.3213326867, 8113.8782918256275, 8622.870656940151, 8818.162274583936, 10137.341072830279, 10127.544260508257, 10284.382937023765, 10284.640037598685, 10296.639617613386, 10301.27891047627, 10267.281290309682, 10325.896741032606, 10330.070293673567, 10344.5344959477, 10347.896521034807, 10184.439855807928, 10252.589896404135, 10264.384136951732, 10265.794684106313, 10268.383896966207, 10522.42126683032, 10659.786804263871, 10707.411092389915, 10709.357438553712, 10713.303635263683, 41280.1743965119, 41873.0, 41875.371869421986, 41885.371719424234, 41918.0, 3788.6969042476535, 3821.789801560913, 3878.45701601776, 3955.663768579674, 4246.087091275391, 32221.51667724986, 32331.838340808146, 32649.51025734616, 32676.019719408458, 33830.0, 3781.867634632802, 3828.5214348206473, 3836.0, 3855.325318069327, 3926.5288165420334, 292443.0, 293565.0, 293880.0, 294488.527557363, 294838.0, 44732.77633611811, 44925.10149796986, 44948.52783096896, 59580.0, 60774.0, 41268.0, 41287.793561032006, 41391.379129313085, 41527.37708934368, 41532.0, 14930.10419374841, 15844.44544440939, 16006.199690015686, 16017.038977661145, 16022.19889005545, 12791.04067194964, 12890.67773305675, 12897.742045159044, 12917.0, 12918.547850825176, 14569.490067847575, 14665.48670796517, 14676.779848302283, 14741.189234591986, 14796.852031479762, 5800.0, 5835.0, 5861.794837180678, 5862.443067908542, 5920.467157955804, 1090.6237348114887, 1121.3664279681955, 1132.2074547816562, 1143.805553055966, 1146.2148428326623, 29799.404011920073, 29943.85028074846, 31508.36983260322, 31814.2046448836, 32657.836710816293, 1069.3583849690124, 1091.4051841746268, 1108.545496346494, 1123.2642619084513, 1209.2260952990093, 14173.503927362493, 14251.358688859027, 14415.49545765914, 14569.781453278209, 14736.778948315783, 428754.0, 434183.0, 435363.0, 437544.0, 438116.0, 54417.45582544203, 54819.0, 54849.45150548523, 54900.45099548953, 55042.0, 1354.2754626274896, 1436.0163288147653, 1488.1220080152762, 1500.5723368840047, 1506.6082818467057, 28413.0, 29287.267818304714, 29339.706602933697, 29360.85319573474, 30072.0, 45132.32301515414, 45765.77117114393, 45791.313130302406, 45800.770996144805, 45836.31245531253, 245658.0, 250825.0, 250844.0, 251094.0, 251466.0, 29233.707662923098, 33189.51078669158, 33350.16624584405, 33649.495257571645, 33770.83114584412, 38245.23509529849, 38756.6124338753, 39009.80495097506, 39327.0, 39711.40432893567, 33052.1736956578, 33511.83244083764, 33582.32835343328, 33792.66207337895, 33843.15392115217, 41645.79177104095, 41854.790726047395, 41964.37053444262, 42171.3674294892, 42697.22468039567, 35571.28857422785, 36158.4576231362, 36183.63816361803, 36392.45411318779, 36556.81721591375, 31799.364012720078, 33817.3236535263, 34744.13139671528, 35193.0, 35501.82249088738, 24042.87978560096, 24710.629340560266, 24923.252302430956, 25478.872605636854, 25519.744802551737], "unit": "score", "name": "ext.html", "value": 18850.849355700415}, {"lowerIsBetter": false, "replicates": [373.5461414381526, 390.48651023903574, 392.55052964355815, 393.22142158526117, 404.933186024306, 16766.993980361185, 18249.915555643864, 18383.264669413224, 18414.723779143325, 18425.723614145765, 17695.823041769578, 17875.374361897302, 18469.81530184698, 18492.2603095876, 18526.536836579093, 4389.297712366022, 5606.187102870082, 5823.155642431845, 5825.359210486843, 5829.154772557977, 4410.669199810011, 6056.727447264883, 6330.936690633103, 6372.1397611322345, 6374.713137908805, 6056.636601803883, 6238.220222472191, 6242.625442473443, 6326.557141000132, 6428.0, 6265.4361107500545, 6289.622622642656, 6313.936860631404, 6315.557910946236, 6343.0, 3906.8046597670286, 4048.1903619276263, 5294.285271488377, 5470.835874923759, 5480.80817171401, 20452.079656415495, 20467.692984605244, 20848.687269690967, 22206.555868882533, 22243.44391390212, 2339.836211465198, 2351.588472017407, 2393.234165067179, 2394.1022116706235, 2431.756824317572, 12850.871491285154, 12912.418941147671, 13099.410526526233, 13168.012399070012, 13461.865381346159, 1815.3736960748652, 1892.9526761831064, 1907.8759880607715, 1923.7691477022706, 1936.8741031833026, 62547.6872615634, 64022.67988660074, 64228.67885660588, 64553.0, 64788.0, 10078.848817267746, 10165.28842980999, 10354.948225258826, 10377.117944974761, 10632.043116119432, 14664.120152790867, 14759.409623615149, 14776.556703298918, 14803.407863685332, 14822.184779836996, 8007.119216886138, 8249.216324449168, 8265.421420500506, 8280.0, 8315.708950186714, 7996.24035716606, 8063.153368896299, 8092.595370231583, 8113.310368618615, 8113.797155071171, 5623.156526521055, 6141.723622436912, 6263.4362907337645, 6322.683865806784, 6348.365163483615, 1753.1321995612, 1802.9909850450927, 1914.2917120665443, 1958.7453631027875, 2032.5873517904913, 1045.2474218562622, 1088.6788397422622, 1106.3804269609045, 1142.4116579961326, 1169.783590035829, 17890.463286101436, 18055.548611284823, 18333.564755122516, 18854.05729713509, 19210.327638532584, 1048.623432547197, 1057.5981127171626, 1058.0847566854616, 1083.6261489786011, 1135.199684222621, 10599.682009539727, 10842.186835987333, 10969.23215374932, 11023.215650464907, 11084.337349397654, 397002.0, 420709.0, 432845.0, 434295.0, 435289.0, 73281.0, 73698.0, 74061.0, 74467.62766186243, 75010.62494687492, 1104.5305745058317, 1132.4903793292885, 1133.9262947908524, 1144.6966553863233, 1159.7448561316496, 15455.459058932884, 15576.532704018897, 15622.9218853905, 15732.764008539652, 15790.289436975594, 31883.840580796947, 32417.837910810296, 33097.50353744648, 33133.502997454576, 33206.0, 44542.55457445384, 48325.0, 50550.494495054576, 51133.744331279595, 51243.48756512536, 8329.541875196923, 8544.829103418022, 8610.0, 8623.698170564001, 8654.913450865412, 9999.500024998866, 12257.632271031527, 12745.235285882876, 13129.343532823512, 13272.402741876831, 5653.406392328746, 7205.819854503679, 9975.102240798364, 10519.948005199725, 10708.518116684612, 10950.178736594627, 11231.887681123084, 11243.325400475998, 11395.658130256106, 11421.771564568828, 11034.503447344729, 11465.656030319104, 11543.595974140864, 11610.5355785771, 11749.882501175221, 8599.699010534852, 8634.56827158652, 8722.825543489222, 8731.602943529006, 8798.47209167452, 11465.312081274817, 11593.768124637629, 11640.417979100841, 11644.35956022427, 11776.528938842694], "unit": "score", "name": "jquery.html", "value": 8967.75798404029}, {"lowerIsBetter": false, "replicates": [1472.7349077166118, 1593.5378740165352, 1614.241306585905, 1849.1031849552965, 1940.2530025940018, 8040.396970227234, 8217.30152937001, 8224.259816616503, 8224.835503289938, 8230.91769082309, 8260.215279548449, 8430.0, 8431.578421078952, 8441.029281632615, 8447.662093516252, 2023.3120738948755, 2343.5430091132193, 2348.765123487655, 2379.8453100548495, 2408.1089996701244, 2344.296710986706, 2360.0441821062495, 2361.2798096580536, 2362.433016076138, 2363.83453158279, 2276.8747718875456, 2347.835651504395, 2351.8353715239855, 2353.341064501942, 2354.81161507079, 2329.685492458513, 2335.754745751697, 2390.0200917623865, 2400.183937461254, 2408.4340180057584, 2323.9419014524774, 2327.9650805237934, 2333.0084713996653, 2366.786989170983, 2377.358113309414, 8528.658853645848, 8537.060923298432, 8599.0, 8614.913850861474, 8617.224449799485, 4907.901841963177, 5007.54932056113, 5046.394432668103, 5049.343585333883, 5055.545000949895, 3097.225693576606, 3105.720485156347, 3143.528470729386, 3309.96690033099, 3315.436375816117, 1046.7016900183412, 1057.7249915022073, 1063.6702622187147, 1066.0299127793671, 1074.5648012554927, 11137.0, 11369.2609980351, 11389.974902258753, 11392.202545821796, 11407.429628518625, 4272.807723652443, 4284.507281662586, 4348.391225228471, 4377.846775362847, 4388.5830846069575, 9250.352475326663, 9283.071692830797, 9285.442873427615, 9287.349885508085, 9292.16370526656, 4448.621867141264, 4983.0, 5025.422076461181, 5038.79844806211, 5040.521150490697, 4475.530069342737, 4548.88627784308, 4583.152116858392, 4585.28928016158, 4609.078184363141, 3565.4295312749837, 3646.2707458507875, 3672.6510981456718, 3687.0, 3708.8145592720257, 1073.4471747050275, 1076.0315715855636, 1087.478010554938, 1087.8477013218155, 1120.8991190792867, 1389.305347326337, 1408.6971301170297, 1422.9857701423061, 1425.7148570285983, 1442.978355324671, 7894.250046245597, 8003.5197888126895, 8053.436259461781, 8059.234372734581, 8072.394570407126, 523.1459963013938, 539.5252178083261, 544.3848451250062, 546.3089192171906, 550.0429253099578, 5956.315023772235, 5988.011978023577, 5992.550558708114, 6028.306744724413, 6053.213082299273, 9841.852372214422, 10253.897461025294, 10320.277580569287, 10413.791724165625, 10426.478676066166, 9950.054744799232, 10061.899381006242, 10161.339512931636, 10239.078482936571, 10290.279680422449, 7972.083210430875, 8029.076656184497, 8097.271245587807, 8118.75643730689, 8139.4709343892455, 7596.316331530189, 7702.383809295355, 7716.614169291625, 7716.884246736416, 7725.49784264021, 8958.328125390752, 9008.684696035869, 9065.68270110543, 9094.999550049357, 9292.814143716952, 9011.279097672039, 9309.255259579353, 9408.905910940803, 9514.191293739832, 9600.519974001132, 6301.4328710416285, 6811.114555107804, 6971.8257043572285, 7099.964500177466, 7218.0, 7947.602619869099, 7956.204379562229, 7970.601469926596, 8013.038435387791, 8031.116577176623, 6921.653917304216, 7063.258357872555, 7139.393151581966, 7177.066981292399, 7234.095738032746, 7077.292270772881, 7102.467314951503, 7136.286371362822, 7243.203247642649, 7275.1997280298065, 7316.926830731624, 7556.962215188889, 7560.3573696236435, 7567.9243207567215, 7571.394288457021, 6910.723571057302, 7006.439484841302, 7008.334208250208, 7012.964935175291, 7014.0531028310525, 6694.6317952511135, 6728.73085076611, 6774.830629234309, 6782.525223234524, 6798.218204906499], "unit": "score", "name": "mootools.html", "value": 4639.583175944765}, {"lowerIsBetter": false, "replicates": [362.7968337730871, 363.19008610797937, 365.6855104610035, 369.3167639866248, 371.21673269401566, 6027.0, 6028.728707208175, 6033.668148251844, 6070.119832624272, 6083.604565703226, 6012.038073908176, 6018.06719958406, 6022.638641681502, 6027.156198132265, 6028.698565071751, 4505.819767209324, 4562.361269422284, 4582.404287442628, 4682.719036857799, 4718.646101542381, 4661.160991021615, 4686.53134686532, 4688.5545873142, 4692.178868697982, 4697.107549565571, 4640.978984623377, 4645.279981602857, 4651.279051746985, 4660.976695116519, 4662.300654901758, 4480.731156130626, 4556.453225612914, 4567.063751930847, 4603.930941035887, 4613.884652883671, 4037.1320166164414, 4078.2251372239475, 4084.4485994390675, 4091.40674602184, 4095.508538975312, 5622.240997465331, 5667.178259152441, 5740.08158694611, 5747.281589801275, 5751.741171647286, 5401.756920938567, 5415.431379705153, 5447.45525447456, 5449.509544141047, 5452.100403433429, 6303.401176888234, 6326.810195694136, 6425.775097871552, 6441.194850643669, 6445.419912207877, 4372.868813935587, 4485.058137791068, 4495.168393847149, 4495.34817451471, 4592.74739889306, 6627.039079333518, 6642.734290628369, 6658.4340331071435, 6660.800175994728, 6670.7331706731675, 4615.746133962597, 4619.491855895849, 4620.075984803053, 4626.0979109073405, 4628.722276663411, 4705.6470764692785, 4705.835295764632, 4707.976460117678, 4709.529047095263, 4713.0, 5394.109971854678, 5396.244525766396, 5397.2443857859935, 5405.108157154104, 5407.351117865881, 6306.1171435998995, 6418.326075761977, 6419.839504012343, 6443.5167362448, 6445.129907462527, 1645.9012459252483, 1653.4378311374192, 1660.7259802132755, 1666.558362034062, 1667.316400275881, 1043.0, 1063.1388575254068, 1088.1729885287239, 1102.1183053557122, 1119.311623351633, 6154.169187159766, 6181.134641150243, 6182.752689892444, 6187.133801267826, 6193.194884664965, 6540.0, 6582.0, 6584.341565843377, 6587.571807832475, 6612.603243805387, 6120.755169793248, 6166.4758495527485, 6172.4136207060255, 6182.381761823782, 6184.257889053342, 3519.8416071276856, 3549.165946002687, 3556.524042522324, 3559.110222444389, 3560.928781424409, 6552.901706474407, 6750.527463077636, 6751.594904305757, 6754.425873800684, 6763.391294783493, 6701.430378417889, 6705.731770729214, 6715.630640314829, 6723.596584204964, 6724.092247546617, 6721.294264102296, 6721.798346049529, 6727.562708423937, 6730.192376914703, 6743.190817101881, 6559.6064236145985, 6562.901556476752, 6564.212294524687, 6572.14562106923, 6575.769848055295, 6330.778422755181, 6456.7740129095255, 6457.418832305115, 6458.709358078804, 6533.118029066205, 6681.866362672622, 6698.363655452724, 6717.56335838169, 6722.092517510269, 6732.427743641845, 4637.443506779208, 4642.303654451859, 4644.8374306899095, 4646.628269738345, 4648.1168577970075, 6542.247641521096, 6547.410733033859, 6548.214214294315, 6549.60702357841, 6550.7707230246715, 6185.876282474415, 6356.459700925288, 6368.840778980377, 6370.203724534434, 6375.713092910737, 6286.088517165077, 6329.683515824098, 6331.493480521455, 6335.3981371769605, 6339.302676705466, 6147.309489890137, 6151.876962460815, 6161.938380616316, 6164.506839452743, 6168.907466388097, 6297.937020629735, 6355.046742988588, 6355.52333574993, 6363.745450182126, 6372.617642941438, 6100.8779824404155, 6212.502999759918, 6229.501639868709, 6240.438360547572, 6242.375762423721], "unit": "score", "name": "prototype.html", "value": 4840.695180538183}, {"lowerIsBetter": false, "replicates": [711.1111111111111, 759.2255898983037, 773.7369294439891, 804.4489524675596, 855.5636625321084, 14028.0, 14133.152010879328, 14232.786508202385, 14248.358823852926, 14270.785938210922, 13339.666508337272, 13360.398782054806, 13377.93311033446, 13414.128081674684, 13425.865741342608, 907.4555266839893, 941.6045260990367, 941.9340646154772, 942.29328003997, 942.420411446962, 927.0729270729271, 934.7055677461578, 937.2221056523069, 937.7514958535993, 937.9108984646448, 959.1080295325345, 961.3078583419926, 961.5240455974302, 961.8845738511353, 962.3263715399214, 896.7982204004047, 949.5537097564134, 950.3870003847514, 950.8193443245796, 951.4053716427198, 660.8843452395812, 664.773976847874, 665.8834703926842, 684.9212340580847, 712.1596516110988, 14459.710805783825, 14474.782878256834, 14488.927555362261, 14537.927310363486, 14576.708465830625, 11947.402629868471, 11982.460789264416, 12164.08769342294, 12199.695007624792, 12411.503539858395, 10079.89920100797, 10129.290949633529, 10282.280240383176, 10632.946835265851, 11104.0, 3391.4573668213216, 3418.6239513653477, 3424.2637832866053, 3427.108951672583, 3428.9828550857087, 42874.78562607167, 45641.77179114083, 46033.76983115097, 50975.235371469455, 51408.48591514074, 9524.095210954949, 9572.946667990918, 9635.518224088908, 9776.169025632758, 9792.755181120387, 18192.363267285582, 18197.36309229197, 18198.272069117353, 18200.1809918554, 18256.178471968793, 7331.156916954512, 7506.399488040944, 7682.577458239851, 7689.307962283421, 7766.961165194138, 3831.616838316146, 3896.493455850721, 3948.9012774680286, 3959.6436320730695, 4009.0, 3194.6965038321323, 3220.2754380264723, 3222.5971753530807, 3224.0972527692284, 3228.1122691260093, 599.6881621556853, 611.1291409741101, 615.6183166436838, 630.2216762298558, 636.3350298937621, 630.0769372868677, 634.3244444666416, 650.440621065883, 667.1926968368232, 740.9592472414068, 8221.630026648816, 8411.285040771603, 8469.491830490191, 8502.362322825813, 8633.352498562634, 639.5523133806354, 640.4268179978986, 649.1009951217598, 654.1332734127301, 659.1562799616498, 3751.4747935289083, 3947.802609869495, 4045.37296719009, 4056.14820887611, 4231.809568569422, 60128.0, 60715.39284607097, 60915.39084609097, 60930.0, 61159.0, 47442.525574744504, 53823.0, 55145.44854551483, 55528.16707749387, 55781.44218557762, 50899.0, 52630.21054684183, 52915.12509798669, 53586.73206633942, 53678.926421471355, 8831.470111793313, 8859.512726800089, 8925.196732294125, 8979.14698103679, 9030.819383612159, 38032.80983595064, 38122.618773811904, 39022.4146637795, 39621.0, 39714.2057158861, 44577.0, 47765.52234477611, 48174.75912620555, 48572.75713621551, 48729.26906096482, 11766.117541184274, 11922.582709605122, 12057.15599907998, 12058.819117713067, 12136.514539418324, 12955.935220323838, 13035.47858085666, 13039.608811735663, 13371.732565348833, 13606.0, 11221.831672524755, 11390.601328953448, 11552.306861588331, 11631.941840290745, 11655.0, 11421.0, 11517.0, 11583.362915039754, 11806.173567850168, 11838.704032399259, 11475.426228688366, 11543.769124617293, 11826.34955077479, 12026.75946481048, 12038.939805301268, 10322.380657160595, 10424.530896109845, 10478.895211047791, 10705.411202383631, 10826.51280692355, 10251.84622230682, 10423.635172768916, 10426.791464170523, 10538.262321637412, 10553.947230263799], "unit": "score", "name": "yui.html", "value": 6578.119471018355}], "name": "dromaeo_css", "value": 7168.14903123155}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 110.0, 110.0, 111.0, 102.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [170.0, 126.0, 156.0, 161.0, 127.0, 156.0, 150.0, 127.0, 172.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 159.0, 160.0, 160.0, 161.0, 160.0, 170.0, 160.0, 159.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 75.0, 157.0, 76.0, 73.0, 74.0, 76.0, 158.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 147.0, 92.0, 93.0, 91.0, 136.0, 93.0, 92.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 119.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 59.0, 56.0, 57.0, 67.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 64.0, 66.0, 64.0, 64.0, 64.0, 63.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 78.0, 85.0, 77.0, 78.0, 77.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [116.0, 113.0, 114.0, 115.0, 113.0, 115.0, 127.0, 116.0, 111.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [147.0, 135.0, 145.0, 146.0, 143.0, 134.0, 144.0, 147.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 67.0, 65.0, 66.0, 66.0, 66.0, 68.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1499.5}]} 04:00:02 INFO - Return code: 0 04:00:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:00:02 INFO - # TBPL SUCCESS # 04:00:02 INFO - Running post-action listener: _resource_record_post_action 04:00:02 INFO - Running post-run listener: _resource_record_post_run 04:00:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 65536; Write bytes: 498581504; Read time: 156; Write time: 529336 04:00:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245399552; Read time: 0; Write time: 346068 04:00:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 65536; Write bytes: 253181952; Read time: 156; Write time: 183268 04:00:03 INFO - Running post-run listener: _upload_blobber_files 04:00:03 INFO - Blob upload gear active. 04:00:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:03 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 04:00:03 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'] 04:00:03 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 04:00:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:04 INFO - (blobuploader) - INFO - Done attempting. 04:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:05 INFO - (blobuploader) - INFO - Done attempting. 04:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:05 INFO - Return code: 0 04:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36f748e8d35a2bd1bb8089fc211b6c45597d604c44e99c59f3a7914376b84829ebfea2e990260fdd510c8cedf1df976b42fefa22c193346fefc8a442d1168e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/142049dfd2882245249e78d6ceac6f5c09674769cf86f8fde31f76e40531f35345841c5a3de881a77a1bfbfd5156ab197b264f8d233916b0593a2eb53169afe8"} 04:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:05 INFO - Contents: 04:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36f748e8d35a2bd1bb8089fc211b6c45597d604c44e99c59f3a7914376b84829ebfea2e990260fdd510c8cedf1df976b42fefa22c193346fefc8a442d1168e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/142049dfd2882245249e78d6ceac6f5c09674769cf86f8fde31f76e40531f35345841c5a3de881a77a1bfbfd5156ab197b264f8d233916b0593a2eb53169afe8"} 04:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:05 INFO - Copying logs to upload dir... 04:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.803519 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-27 04:00:05.792214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:05.799532) ========= 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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 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/36f748e8d35a2bd1bb8089fc211b6c45597d604c44e99c59f3a7914376b84829ebfea2e990260fdd510c8cedf1df976b42fefa22c193346fefc8a442d1168e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/142049dfd2882245249e78d6ceac6f5c09674769cf86f8fde31f76e40531f35345841c5a3de881a77a1bfbfd5156ab197b264f8d233916b0593a2eb53169afe8"} build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36f748e8d35a2bd1bb8089fc211b6c45597d604c44e99c59f3a7914376b84829ebfea2e990260fdd510c8cedf1df976b42fefa22c193346fefc8a442d1168e2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/142049dfd2882245249e78d6ceac6f5c09674769cf86f8fde31f76e40531f35345841c5a3de881a77a1bfbfd5156ab197b264f8d233916b0593a2eb53169afe8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:05.828528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:05.828897) ========= 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=00204705a9daa57ed339a427000001b9-1461753425.936988-1369614694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:00:05.889039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:00:05.889379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:00:05.889711) ========= ========= Total master_lag: 0.36 =========