builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1464291750.49 results: success (0) buildid: 20160526100254 builduid: 1e85406e622c42658dbcf3a29055aacc revision: 3a217924ee0636422a9b14e96f774d9cf7404ac9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.489584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.490021) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.490293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.579328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.579696) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 12:42:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2016-05-26 12:42:30 (42.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.690526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.690879) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016418 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.757034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:30.757394) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a217924ee0636422a9b14e96f774d9cf7404ac9 --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 3a217924ee0636422a9b14e96f774d9cf7404ac9 --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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 12:42:30,910 truncating revision to first 12 chars 2016-05-26 12:42:30,910 Setting DEBUG logging. 2016-05-26 12:42:30,910 attempt 1/10 2016-05-26 12:42:30,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a217924ee06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 12:42:31,220 unpacking tar archive at: mozilla-aurora-3a217924ee06/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:31.433283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:31.433585) ========= script_repo_revision: 3a217924ee0636422a9b14e96f774d9cf7404ac9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:31.437062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:31.437336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 12:42:31.462016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-26 12:42:31.462333) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:42:31 INFO - MultiFileLogger online at 20160526 12:42:31 in /builds/slave/test 12:42:31 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 12:42:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:31 INFO - {'append_to_log': False, 12:42:31 INFO - 'base_work_dir': '/builds/slave/test', 12:42:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:42:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:31 INFO - 'branch': 'Mozilla-Aurora', 12:42:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:31 INFO - 'config_files': ('talos/linux_config.py',), 12:42:31 INFO - 'default_actions': ('clobber', 12:42:31 INFO - 'read-buildbot-config', 12:42:31 INFO - 'download-and-extract', 12:42:31 INFO - 'populate-webroot', 12:42:31 INFO - 'create-virtualenv', 12:42:31 INFO - 'install', 12:42:31 INFO - 'run-tests'), 12:42:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:31 INFO - 'download_minidump_stackwalk': True, 12:42:31 INFO - 'download_symbols': 'ondemand', 12:42:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:42:31 INFO - 'tooltool.py': '/tools/tooltool.py', 12:42:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:42:31 INFO - '/tools/misc-python/virtualenv.py')}, 12:42:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:31 INFO - 'installer_path': 'installer.exe', 12:42:31 INFO - 'log_level': 'info', 12:42:31 INFO - 'log_name': 'talos', 12:42:31 INFO - 'log_to_console': True, 12:42:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:42:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:42:31 INFO - 'opt_config_files': (), 12:42:31 INFO - 'pip_index': False, 12:42:31 INFO - 'sps_profile': False, 12:42:31 INFO - 'sps_profile_interval': 0, 12:42:31 INFO - 'suite': 'dromaeojs', 12:42:31 INFO - 'system_bits': '32', 12:42:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:31 INFO - 'title': 'talos-linux64-ix-012', 12:42:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:31 INFO - 'use_talos_json': True, 12:42:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:31 INFO - 'work_dir': 'build'} 12:42:31 INFO - ##### 12:42:31 INFO - ##### Running clobber step. 12:42:31 INFO - ##### 12:42:31 INFO - Running pre-action listener: _resource_record_pre_action 12:42:31 INFO - Running main action method: clobber 12:42:31 INFO - rmtree: /builds/slave/test/build 12:42:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:32 INFO - Running post-action listener: _resource_record_post_action 12:42:32 INFO - ##### 12:42:32 INFO - ##### Running read-buildbot-config step. 12:42:32 INFO - ##### 12:42:32 INFO - Running pre-action listener: _resource_record_pre_action 12:42:32 INFO - Running main action method: read_buildbot_config 12:42:32 INFO - Using buildbot properties: 12:42:32 INFO - { 12:42:32 INFO - "project": "", 12:42:32 INFO - "product": "firefox", 12:42:32 INFO - "script_repo_revision": "production", 12:42:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:42:32 INFO - "repository": "", 12:42:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:42:32 INFO - "buildid": "20160526100254", 12:42:32 INFO - "pgo_build": "True", 12:42:32 INFO - "basedir": "/builds/slave/test", 12:42:32 INFO - "buildnumber": 521, 12:42:32 INFO - "slavename": "talos-linux64-ix-012", 12:42:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:42:32 INFO - "platform": "ubuntu64_hw", 12:42:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:42:32 INFO - "branch": "mozilla-aurora", 12:42:32 INFO - "repo_path": "releases/mozilla-aurora", 12:42:32 INFO - "revision": "3a217924ee0636422a9b14e96f774d9cf7404ac9", 12:42:32 INFO - "stage_platform": "linux64-pgo", 12:42:32 INFO - "builduid": "1e85406e622c42658dbcf3a29055aacc", 12:42:32 INFO - "slavebuilddir": "test" 12:42:32 INFO - } 12:42:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 12:42:32 INFO - Running post-action listener: _resource_record_post_action 12:42:32 INFO - ##### 12:42:32 INFO - ##### Running download-and-extract step. 12:42:32 INFO - ##### 12:42:32 INFO - Running pre-action listener: _resource_record_pre_action 12:42:32 INFO - Running main action method: download_and_extract 12:42:32 INFO - mkdir: /builds/slave/test/build/tests 12:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:32 INFO - https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:42:40 INFO - Downloaded 1361 bytes. 12:42:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 12:42:40 INFO - Using the following test package requirements: 12:42:40 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:42:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:42:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:42:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'jsshell-linux-x86_64.zip'], 12:42:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:42:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 12:42:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:42:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:42:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:42:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 12:42:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:42:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:42: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')]} 12:42:40 INFO - https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:42:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:42:51 INFO - Downloaded 24136564 bytes. 12:42:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:42:52 INFO - Return code: 0 12:42:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:52 INFO - https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:42:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 12:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:42:53 INFO - Downloaded 24136564 bytes. 12:42:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:42:55 INFO - Return code: 0 12:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:42:55 INFO - https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:42:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:42:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:42:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 12:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:42:56 INFO - Downloaded 10840145 bytes. 12:42:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:42:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:42:56 INFO - Return code: 0 12:42: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')]} 12:42:56 INFO - https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:42:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:42:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:42:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:42:58 INFO - Downloaded 62730641 bytes. 12:42:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:42:58 INFO - mkdir: /builds/slave/test/properties 12:42:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:42:58 INFO - Writing to file /builds/slave/test/properties/build_url 12:42:58 INFO - Contents: 12:42:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 12:42:59 INFO - Running post-action listener: _resource_record_post_action 12:42:59 INFO - Running post-action listener: set_extra_try_arguments 12:42:59 INFO - ##### 12:42:59 INFO - ##### Running populate-webroot step. 12:42:59 INFO - ##### 12:42:59 INFO - Running pre-action listener: _resource_record_pre_action 12:42:59 INFO - Running main action method: populate_webroot 12:42:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:42:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:42:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:42:59 INFO - '--tppagecycles', 12:42:59 INFO - '7'], 12:42:59 INFO - 'tests': ['tsvgm']}}, 12:42:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:42:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:42:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:42:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:42:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:42:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['damp', 'tps']}, 12:42:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'tests': ['damp', 'tps']}, 12:42:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['dromaeo_dom']}, 12:42:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:42:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'other-e10s': {'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['a11yr', 12:42:59 INFO - 'ts_paint', 12:42:59 INFO - 'tpaint', 12:42:59 INFO - 'sessionrestore', 12:42:59 INFO - 'sessionrestore_no_auto_restore', 12:42:59 INFO - 'tabpaint']}, 12:42:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['tsvgx', 12:42:59 INFO - 'tsvgr_opacity', 12:42:59 INFO - 'tart', 12:42:59 INFO - 'tscrollx', 12:42:59 INFO - 'cart']}, 12:42:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:42:59 INFO - 'tsvgr_opacity', 12:42:59 INFO - 'tart', 12:42:59 INFO - 'tscrollx', 12:42:59 INFO - 'cart']}, 12:42:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'talos_options': ['--disable-e10s'], 12:42:59 INFO - 'tests': ['tp5o']}, 12:42:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'tests': ['tp5o']}, 12:42:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'talos_options': ['--disable-e10s', 12:42:59 INFO - '--xperf_path', 12:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:59 INFO - 'tests': ['tp5n']}, 12:42:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:42:59 INFO - 'talos_options': ['--xperf_path', 12:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:42:59 INFO - 'tests': ['tp5n']}}, 12:42:59 INFO - 'talos.zip': {'path': '', 12:42:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:42:59 INFO - Running post-action listener: _resource_record_post_action 12:42:59 INFO - ##### 12:42:59 INFO - ##### Running create-virtualenv step. 12:42:59 INFO - ##### 12:42:59 INFO - Running pre-action listener: _resource_record_pre_action 12:42:59 INFO - Running main action method: create_virtualenv 12:42:59 INFO - Creating virtualenv /builds/slave/test/build/venv 12:42:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:42:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:42:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:42:59 INFO - Using real prefix '/usr' 12:42:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:00 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:01 INFO - Installing pip.................done. 12:43:01 INFO - Return code: 0 12:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:43:02 INFO - Using env: {'DISPLAY': ':0', 12:43:02 INFO - 'HOME': '/home/cltbld', 12:43:02 INFO - 'LANG': 'en_US.UTF-8', 12:43:02 INFO - 'LANGUAGE': 'en_US:en', 12:43:02 INFO - 'LOGNAME': 'cltbld', 12:43:02 INFO - 'MAIL': '/var/mail/cltbld', 12:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:02 INFO - 'MOZ_NO_REMOTE': '1', 12:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:02 INFO - 'NO_EM_RESTART': '1', 12:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:02 INFO - 'PWD': '/builds/slave/test', 12:43:02 INFO - 'SHELL': '/bin/bash', 12:43:02 INFO - 'SHLVL': '1', 12:43:02 INFO - 'TERM': 'linux', 12:43:02 INFO - 'TMOUT': '86400', 12:43:02 INFO - 'USER': 'cltbld', 12:43:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:02 INFO - '_': '/tools/buildbot/bin/python'} 12:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:43:02 INFO - Cleaning up... 12:43:02 INFO - Return code: 0 12:43:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:43:02 INFO - Using env: {'DISPLAY': ':0', 12:43:02 INFO - 'HOME': '/home/cltbld', 12:43:02 INFO - 'LANG': 'en_US.UTF-8', 12:43:02 INFO - 'LANGUAGE': 'en_US:en', 12:43:02 INFO - 'LOGNAME': 'cltbld', 12:43:02 INFO - 'MAIL': '/var/mail/cltbld', 12:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:02 INFO - 'MOZ_NO_REMOTE': '1', 12:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:02 INFO - 'NO_EM_RESTART': '1', 12:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:02 INFO - 'PWD': '/builds/slave/test', 12:43:02 INFO - 'SHELL': '/bin/bash', 12:43:02 INFO - 'SHLVL': '1', 12:43:02 INFO - 'TERM': 'linux', 12:43:02 INFO - 'TMOUT': '86400', 12:43:02 INFO - 'USER': 'cltbld', 12:43:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:02 INFO - '_': '/tools/buildbot/bin/python'} 12:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:02 INFO - Downloading/unpacking psutil>=0.7.1 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:04 INFO - Installing collected packages: psutil 12:43:04 INFO - Running setup.py install for psutil 12:43:04 INFO - building 'psutil._psutil_linux' extension 12:43:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:43:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:43:04 INFO - building 'psutil._psutil_posix' extension 12:43:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:43:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:04 INFO - Successfully installed psutil 12:43:04 INFO - Cleaning up... 12:43:05 INFO - Return code: 0 12:43:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:43:05 INFO - Using env: {'DISPLAY': ':0', 12:43:05 INFO - 'HOME': '/home/cltbld', 12:43:05 INFO - 'LANG': 'en_US.UTF-8', 12:43:05 INFO - 'LANGUAGE': 'en_US:en', 12:43:05 INFO - 'LOGNAME': 'cltbld', 12:43:05 INFO - 'MAIL': '/var/mail/cltbld', 12:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:05 INFO - 'MOZ_NO_REMOTE': '1', 12:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:05 INFO - 'NO_EM_RESTART': '1', 12:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:05 INFO - 'PWD': '/builds/slave/test', 12:43:05 INFO - 'SHELL': '/bin/bash', 12:43:05 INFO - 'SHLVL': '1', 12:43:05 INFO - 'TERM': 'linux', 12:43:05 INFO - 'TMOUT': '86400', 12:43:05 INFO - 'USER': 'cltbld', 12:43:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:05 INFO - '_': '/tools/buildbot/bin/python'} 12:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:07 INFO - Installing collected packages: mozsystemmonitor 12:43:07 INFO - Running setup.py install for mozsystemmonitor 12:43:07 INFO - Successfully installed mozsystemmonitor 12:43:07 INFO - Cleaning up... 12:43:07 INFO - Return code: 0 12:43:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:43:07 INFO - Using env: {'DISPLAY': ':0', 12:43:07 INFO - 'HOME': '/home/cltbld', 12:43:07 INFO - 'LANG': 'en_US.UTF-8', 12:43:07 INFO - 'LANGUAGE': 'en_US:en', 12:43:07 INFO - 'LOGNAME': 'cltbld', 12:43:07 INFO - 'MAIL': '/var/mail/cltbld', 12:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:07 INFO - 'MOZ_NO_REMOTE': '1', 12:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:07 INFO - 'NO_EM_RESTART': '1', 12:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:07 INFO - 'PWD': '/builds/slave/test', 12:43:07 INFO - 'SHELL': '/bin/bash', 12:43:07 INFO - 'SHLVL': '1', 12:43:07 INFO - 'TERM': 'linux', 12:43:07 INFO - 'TMOUT': '86400', 12:43:07 INFO - 'USER': 'cltbld', 12:43:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:07 INFO - '_': '/tools/buildbot/bin/python'} 12:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:07 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:10 INFO - Downloading docopt-0.6.1.tar.gz 12:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:10 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:10 INFO - Running setup.py install for blobuploader 12:43:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:10 INFO - Running setup.py install for requests 12:43:10 INFO - Running setup.py install for docopt 12:43:10 INFO - Successfully installed blobuploader requests docopt 12:43:10 INFO - Cleaning up... 12:43:10 INFO - Return code: 0 12:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:10 INFO - Using env: {'DISPLAY': ':0', 12:43:10 INFO - 'HOME': '/home/cltbld', 12:43:10 INFO - 'LANG': 'en_US.UTF-8', 12:43:10 INFO - 'LANGUAGE': 'en_US:en', 12:43:10 INFO - 'LOGNAME': 'cltbld', 12:43:10 INFO - 'MAIL': '/var/mail/cltbld', 12:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:10 INFO - 'MOZ_NO_REMOTE': '1', 12:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:10 INFO - 'NO_EM_RESTART': '1', 12:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:10 INFO - 'PWD': '/builds/slave/test', 12:43:10 INFO - 'SHELL': '/bin/bash', 12:43:10 INFO - 'SHLVL': '1', 12:43:10 INFO - 'TERM': 'linux', 12:43:10 INFO - 'TMOUT': '86400', 12:43:10 INFO - 'USER': 'cltbld', 12:43:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:10 INFO - '_': '/tools/buildbot/bin/python'} 12:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:11 INFO - Running setup.py (path:/tmp/pip-s7zh1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:11 INFO - Running setup.py (path:/tmp/pip-L4R4gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:11 INFO - Running setup.py (path:/tmp/pip-fkHxzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:11 INFO - Running setup.py (path:/tmp/pip-7azTeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:11 INFO - Running setup.py (path:/tmp/pip-koIoGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:11 INFO - Running setup.py (path:/tmp/pip-YKqOiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:11 INFO - Running setup.py (path:/tmp/pip-CLhYDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:11 INFO - Running setup.py (path:/tmp/pip-GdPcfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:11 INFO - Running setup.py (path:/tmp/pip-kjX8Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:11 INFO - Running setup.py (path:/tmp/pip-VD1xd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:11 INFO - Running setup.py (path:/tmp/pip-Ju2Rfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:11 INFO - Running setup.py (path:/tmp/pip-CH7tou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:11 INFO - Running setup.py (path:/tmp/pip-tDLtTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:12 INFO - Running setup.py (path:/tmp/pip-xbtlMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:12 INFO - Running setup.py (path:/tmp/pip-zG7gt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:12 INFO - Running setup.py (path:/tmp/pip-eSD_DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:12 INFO - Running setup.py (path:/tmp/pip-vl60xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:12 INFO - Running setup.py install for manifestparser 12:43:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozcrash 12:43:12 INFO - Running setup.py install for mozdebug 12:43:12 INFO - Running setup.py install for mozdevice 12:43:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozfile 12:43:12 INFO - Running setup.py install for mozhttpd 12:43:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozinfo 12:43:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:12 INFO - Running setup.py install for mozInstall 12:43:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for mozleak 12:43:13 INFO - Running setup.py install for mozlog 12:43:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for moznetwork 12:43:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for mozprocess 12:43:13 INFO - Running setup.py install for mozprofile 12:43:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for mozrunner 12:43:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:13 INFO - Running setup.py install for mozscreenshot 12:43:13 INFO - Running setup.py install for moztest 12:43:13 INFO - Running setup.py install for mozversion 12:43:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:14 INFO - Cleaning up... 12:43:14 INFO - Return code: 0 12:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:14 INFO - Using env: {'DISPLAY': ':0', 12:43:14 INFO - 'HOME': '/home/cltbld', 12:43:14 INFO - 'LANG': 'en_US.UTF-8', 12:43:14 INFO - 'LANGUAGE': 'en_US:en', 12:43:14 INFO - 'LOGNAME': 'cltbld', 12:43:14 INFO - 'MAIL': '/var/mail/cltbld', 12:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:14 INFO - 'MOZ_NO_REMOTE': '1', 12:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:14 INFO - 'NO_EM_RESTART': '1', 12:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:14 INFO - 'PWD': '/builds/slave/test', 12:43:14 INFO - 'SHELL': '/bin/bash', 12:43:14 INFO - 'SHLVL': '1', 12:43:14 INFO - 'TERM': 'linux', 12:43:14 INFO - 'TMOUT': '86400', 12:43:14 INFO - 'USER': 'cltbld', 12:43:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:14 INFO - '_': '/tools/buildbot/bin/python'} 12:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:14 INFO - Running setup.py (path:/tmp/pip-lRel7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:14 INFO - Running setup.py (path:/tmp/pip-cEXjOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:14 INFO - Running setup.py (path:/tmp/pip-jOA_po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:14 INFO - Running setup.py (path:/tmp/pip-ElMeYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:14 INFO - Running setup.py (path:/tmp/pip-KGxXfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:14 INFO - Running setup.py (path:/tmp/pip-5AuF7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 INFO - Running setup.py (path:/tmp/pip-b1ijfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 INFO - Running setup.py (path:/tmp/pip-EW380u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:14 INFO - Running setup.py (path:/tmp/pip-wyqIB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:14 INFO - Running setup.py (path:/tmp/pip-lP31PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:14 INFO - Running setup.py (path:/tmp/pip-REpd7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:15 INFO - Running setup.py (path:/tmp/pip-eAU_xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:15 INFO - Running setup.py (path:/tmp/pip-wEBNup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:15 INFO - Running setup.py (path:/tmp/pip-wWnyNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:15 INFO - Running setup.py (path:/tmp/pip-OmRbEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:15 INFO - Running setup.py (path:/tmp/pip-GfFodU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:15 INFO - Running setup.py (path:/tmp/pip-n7SnjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:17 INFO - Downloading blessings-1.6.tar.gz 12:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:17 INFO - Installing collected packages: blessings 12:43:17 INFO - Running setup.py install for blessings 12:43:17 INFO - Successfully installed blessings 12:43:17 INFO - Cleaning up... 12:43:17 INFO - Return code: 0 12:43:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:18 INFO - Reading from file tmpfile_stdout 12:43:18 INFO - Current package versions: 12:43:18 INFO - argparse == 1.2.1 12:43:18 INFO - blessings == 1.6 12:43:18 INFO - blobuploader == 1.2.4 12:43:18 INFO - docopt == 0.6.1 12:43:18 INFO - manifestparser == 1.1 12:43:18 INFO - mozInstall == 1.12 12:43:18 INFO - mozcrash == 0.17 12:43:18 INFO - mozdebug == 0.1 12:43:18 INFO - mozdevice == 0.48 12:43:18 INFO - mozfile == 1.2 12:43:18 INFO - mozhttpd == 0.7 12:43:18 INFO - mozinfo == 0.9 12:43:18 INFO - mozleak == 0.1 12:43:18 INFO - mozlog == 3.1 12:43:18 INFO - moznetwork == 0.27 12:43:18 INFO - mozprocess == 0.22 12:43:18 INFO - mozprofile == 0.28 12:43:18 INFO - mozrunner == 6.11 12:43:18 INFO - mozscreenshot == 0.1 12:43:18 INFO - mozsystemmonitor == 0.0 12:43:18 INFO - moztest == 0.7 12:43:18 INFO - mozversion == 1.4 12:43:18 INFO - psutil == 3.1.1 12:43:18 INFO - requests == 1.2.3 12:43:18 INFO - wsgiref == 0.1.2 12:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:18 INFO - Using env: {'DISPLAY': ':0', 12:43:18 INFO - 'HOME': '/home/cltbld', 12:43:18 INFO - 'LANG': 'en_US.UTF-8', 12:43:18 INFO - 'LANGUAGE': 'en_US:en', 12:43:18 INFO - 'LOGNAME': 'cltbld', 12:43:18 INFO - 'MAIL': '/var/mail/cltbld', 12:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:18 INFO - 'MOZ_NO_REMOTE': '1', 12:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:18 INFO - 'NO_EM_RESTART': '1', 12:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:18 INFO - 'PWD': '/builds/slave/test', 12:43:18 INFO - 'SHELL': '/bin/bash', 12:43:18 INFO - 'SHLVL': '1', 12:43:18 INFO - 'TERM': 'linux', 12:43:18 INFO - 'TMOUT': '86400', 12:43:18 INFO - 'USER': 'cltbld', 12:43:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:18 INFO - '_': '/tools/buildbot/bin/python'} 12:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:18 INFO - Cleaning up... 12:43:18 INFO - Return code: 0 12:43:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:43:18 INFO - Using env: {'DISPLAY': ':0', 12:43:18 INFO - 'HOME': '/home/cltbld', 12:43:18 INFO - 'LANG': 'en_US.UTF-8', 12:43:18 INFO - 'LANGUAGE': 'en_US:en', 12:43:18 INFO - 'LOGNAME': 'cltbld', 12:43:18 INFO - 'MAIL': '/var/mail/cltbld', 12:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:18 INFO - 'MOZ_NO_REMOTE': '1', 12:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:18 INFO - 'NO_EM_RESTART': '1', 12:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:18 INFO - 'PWD': '/builds/slave/test', 12:43:18 INFO - 'SHELL': '/bin/bash', 12:43:18 INFO - 'SHLVL': '1', 12:43:18 INFO - 'TERM': 'linux', 12:43:18 INFO - 'TMOUT': '86400', 12:43:18 INFO - 'USER': 'cltbld', 12:43:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:18 INFO - '_': '/tools/buildbot/bin/python'} 12:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:18 INFO - Downloading/unpacking jsonschema 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:20 INFO - Downloading/unpacking functools32 (from jsonschema) 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:20 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:20 INFO - warning: no files found matching '*.txt' 12:43:20 INFO - no previously-included directories found matching 'build' 12:43:20 INFO - no previously-included directories found matching 'dist' 12:43:20 INFO - no previously-included directories found matching '.git*' 12:43:20 INFO - Installing collected packages: jsonschema, functools32 12:43:20 INFO - Running setup.py install for functools32 12:43:20 INFO - warning: no files found matching '*.txt' 12:43:20 INFO - no previously-included directories found matching 'build' 12:43:20 INFO - no previously-included directories found matching 'dist' 12:43:20 INFO - no previously-included directories found matching '.git*' 12:43:20 INFO - Successfully installed jsonschema functools32 12:43:20 INFO - Cleaning up... 12:43:20 INFO - Return code: 0 12:43:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26097c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:43:20 INFO - Using env: {'DISPLAY': ':0', 12:43:20 INFO - 'HOME': '/home/cltbld', 12:43:20 INFO - 'LANG': 'en_US.UTF-8', 12:43:20 INFO - 'LANGUAGE': 'en_US:en', 12:43:20 INFO - 'LOGNAME': 'cltbld', 12:43:20 INFO - 'MAIL': '/var/mail/cltbld', 12:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:20 INFO - 'MOZ_NO_REMOTE': '1', 12:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:20 INFO - 'NO_EM_RESTART': '1', 12:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:20 INFO - 'PWD': '/builds/slave/test', 12:43:20 INFO - 'SHELL': '/bin/bash', 12:43:20 INFO - 'SHLVL': '1', 12:43:20 INFO - 'TERM': 'linux', 12:43:20 INFO - 'TMOUT': '86400', 12:43:20 INFO - 'USER': 'cltbld', 12:43:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:20 INFO - '_': '/tools/buildbot/bin/python'} 12:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:21 INFO - Downloading/unpacking flake8 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:43:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:43:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:23 INFO - no previously-included directories found matching 'docs/_build' 12:43:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:43:23 INFO - Running setup.py install for pep8 12:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:23 INFO - no previously-included directories found matching 'docs/_build' 12:43:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:43:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:43:23 INFO - Cleaning up... 12:43:23 INFO - Return code: 0 12:43:23 INFO - Running post-action listener: _resource_record_post_action 12:43:23 INFO - Running post-action listener: _start_resource_monitoring 12:43:24 INFO - Starting resource monitoring. 12:43:24 INFO - ##### 12:43:24 INFO - ##### Running install step. 12:43:24 INFO - ##### 12:43:24 INFO - Running pre-action listener: _resource_record_pre_action 12:43:24 INFO - Running main action method: install 12:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:24 INFO - Reading from file tmpfile_stdout 12:43:24 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:24 INFO - Reading from file tmpfile_stdout 12:43:24 INFO - Output received: 12:43:24 INFO - Usage: mozinstall [options] installer 12:43:24 INFO - Options: 12:43:24 INFO - -h, --help show this help message and exit 12:43:24 INFO - -d DEST, --destination=DEST 12:43:24 INFO - Directory to install application into. [default: 12:43:24 INFO - "/builds/slave/test"] 12:43:24 INFO - --app=APP Application being installed. [default: firefox] 12:43:24 INFO - mkdir: /builds/slave/test/build/application 12:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:43:39 INFO - Reading from file tmpfile_stdout 12:43:39 INFO - Output received: 12:43:39 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:39 INFO - Running post-action listener: _resource_record_post_action 12:43:39 INFO - ##### 12:43:39 INFO - ##### Running run-tests step. 12:43:39 INFO - ##### 12:43:39 INFO - Running pre-action listener: _resource_record_pre_action 12:43:39 INFO - Running main action method: run_tests 12:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:39 INFO - Python 2.7.3 12:43:39 INFO - Return code: 0 12:43:39 INFO - grabbing minidump binary from tooltool 12:43:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea410>, '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 0x21eb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:43:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:43:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:39 INFO - Return code: 0 12:43:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:43:40 INFO - Return code: 0 12:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:43:40 INFO - Using env: {'DISPLAY': ':0', 12:43:40 INFO - 'HOME': '/home/cltbld', 12:43:40 INFO - 'LANG': 'en_US.UTF-8', 12:43:40 INFO - 'LANGUAGE': 'en_US:en', 12:43:40 INFO - 'LOGNAME': 'cltbld', 12:43:40 INFO - 'MAIL': '/var/mail/cltbld', 12:43:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:40 INFO - 'MOZ_NO_REMOTE': '1', 12:43:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:40 INFO - 'NO_EM_RESTART': '1', 12:43:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:40 INFO - 'PWD': '/builds/slave/test', 12:43:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:40 INFO - 'SHELL': '/bin/bash', 12:43:40 INFO - 'SHLVL': '1', 12:43:40 INFO - 'TERM': 'linux', 12:43:40 INFO - 'TMOUT': '86400', 12:43:40 INFO - 'USER': 'cltbld', 12:43:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781', 12:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:40 INFO - '_': '/tools/buildbot/bin/python'} 12:43:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:43:41 INFO - mozversion application_buildid: 20160526100254 12:43:41 INFO - mozversion application_changeset: 3a217924ee0636422a9b14e96f774d9cf7404ac9 12:43:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:43:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:41 INFO - mozversion application_name: Firefox 12:43:41 INFO - mozversion application_remotingname: firefox-dev 12:43:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:41 INFO - mozversion application_vendor: Mozilla 12:43:41 INFO - mozversion application_version: 48.0a2 12:43:41 INFO - mozversion platform_buildid: 20160526100254 12:43:41 INFO - mozversion platform_changeset: 3a217924ee0636422a9b14e96f774d9cf7404ac9 12:43:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:41 INFO - mozversion platform_version: 48.0a2 12:43:41 INFO - using testdate: 1464291821 12:43:41 INFO - actual date: 1464291821 12:43:41 INFO - starting webserver on 'localhost:48481' 12:43:41 INFO - SUITE-START | Running 2 tests 12:43:41 INFO - TEST-START | dromaeo_css 12:43:41 INFO - operating with platform_type : linux_ 12:43:41 INFO - Initialising browser for dromaeo_css test... 12:43:41 INFO - TEST-INFO | started process 20387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqtYG1/profile http://localhost:48481/getInfo.html) 12:43:44 INFO - PROCESS | 20387 | __metrics Screen width/height:1600/1200 12:43:44 INFO - PROCESS | 20387 | colorDepth:24 12:43:44 INFO - PROCESS | 20387 | Browser inner width/height: 1024/697 12:43:44 INFO - PROCESS | 20387 | __metrics 12:43:45 ERROR - PROCESS | 20387 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:43:46 INFO - TEST-INFO | 20387: exit 0 12:43:46 INFO - Browser initialized. 12:43:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:43:46 INFO - TEST-INFO | started process 20478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqtYG1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:57 INFO - PROCESS | 20478 | RSS: Main: 141422592 12:43:57 INFO - PROCESS | 20478 | 12:44:49 INFO - PROCESS | 20478 | 1464291889019 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:46:56 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48481/tests/dromaeo/cssquery-ext.html) 12:46:57 INFO - PROCESS | 20478 | RSS: Main: 256925696 12:46:57 INFO - PROCESS | 20478 | 12:49:59 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-ext.html (next: http://localhost:48481/tests/dromaeo/cssquery-jquery.html) 12:50:00 INFO - PROCESS | 20478 | RSS: Main: 223936512 12:50:00 INFO - PROCESS | 20478 | 12:53:02 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48481/tests/dromaeo/cssquery-mootools.html) 12:53:02 INFO - PROCESS | 20478 | RSS: Main: 218095616 12:53:02 INFO - PROCESS | 20478 | 12:56:04 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48481/tests/dromaeo/cssquery-prototype.html) 12:56:05 INFO - PROCESS | 20478 | RSS: Main: 226054144 12:56:05 INFO - PROCESS | 20478 | 12:59:07 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48481/tests/dromaeo/cssquery-yui.html) 12:59:08 INFO - PROCESS | 20478 | RSS: Main: 186261504 12:59:08 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | Cycle 1(1): loaded http://localhost:48481/tests/dromaeo/cssquery-yui.html (next: http://localhost:48481/tests/dromaeo/cssquery-dojo.html) 13:02:10 INFO - PROCESS | 20478 | RSS: Main: 253018112 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | __start_tp_report 13:02:10 INFO - PROCESS | 20478 | _x_x_mozilla_page_load 13:02:10 INFO - PROCESS | 20478 | _x_x_mozilla_page_load_details 13:02:10 INFO - PROCESS | 20478 | |i|pagename|runs| 13:02:10 INFO - PROCESS | 20478 | |0;dojo.html;3350.3801796667617;3425.862965481381;3426.4175090234658;3440.707539859112;3462.394081035818;5709.1436284557285;5712.485876271135;5714.200011998323;5718.056520674089;5721.456461636149;5719.1421286807;5744.454276843703;5745.339285982113;5755.165501002352;5758.42415758424;4946.060248552763;5139.126348520751;5265.973670131644;5298.390685071208;5327.094393953037;5147.613928955325;5188.481151884819;5191.039657663345;5196.428392876781;5203.089459344618;5135.871603209931;5166.948330516684;5217.817376391827;5222.451642577532;5234.084035293828;5203.531682148606;5230.895382092356;5231.110711179109;5233.921491177635;5263.947360526384;4999.32509111269;5010.7494625268955;5087.313212716273;5114.3862736471865;5135.948640513584;5554.694491802989;5564.304461942257;5606.383297837235;5609.046462101453;5610.803621873215;6079.908801367983;6112.174856394375;6116.296625887991;6121.418465245794;6122.326544080148;5962.910556341659;6012.6392416455155;6036.486898613623;6057.242844644419;6134.877302453926;5640.464155905182;5647.661140331593;5669.149627555858;5672.971635141798;5684.744186511575;6071.939719442051;6191.876162476725;6207.224096987877;6212.192414986023;6218.036204388327;6044.607100538451;6086.421789929949;6095.712861415753;6111.755529778848;6124;6112.205413296243;6115.755369785159;6119.388061193934;6121.632702037892;6127.325994140641;5942.049272116441;5983.371745966698;6080.604760690541;6088.360722124202;6089.543284253698;5967.46292833647;5994.550408719363;6000.939990600038;6004.039353703386;6031.728572214261;4556.476005259371;4564.7032942858605;4569.817207311737;4571.9314210286875;4586.770661466913;4019.979900100481;4086.1827634473225;4096.508418989681;4116.91766164675;4137.027798467418;5675.31896172462;5696;5698.458646428583;5698.572607054488;5739.540836733051;5949.553783466257;6000.069989151689;6007.098935159674;6007.549433792483;6018.4282493163955;5699.943000570024;5714.971425142848;5764.971175144097;5875.618084824473;5881.264841894763;4991.3511243538105;4993.90012199754;5009.499050094962;5009.874753131128;5011.448740638527;6219.036049412348;6220.813375598739;6221.47117495018;6232.127502149703;6244.781432649836;5999.970000149971;6110.315755985069;6175.69121543912;6185.381461853958;6192.133101365723;6136.325004249618;6140.8771824564155;6151.384861513813;6157.0456579230295;6160.229971253593;5778.739956702043;5809.215755872903;5811.94188058114;5816.651000939957;5880.588358815013;6073.5748497604745;6130.049842274455;6138.904709091533;6143.72682107623;6147.938520614915;5960;5991.88016239664;5996.940030599812;5999.130126131599;6002.129691194839;5758.280214973129;5840.474357307863;5913.674747888907;5933.228680271537;5971.970140149271;5827.708614569339;5850.473457388855;5851.239338886088;5855.590108692521;5886.676232807236;5940.910886336795;5965.731542080704;5968.671723055274;5970.373110823301;5971.104334349709;5755.65466072037;5824;5826.300843898759;5830.650160990354;5849.268841394825 13:02:10 INFO - PROCESS | 20478 | |1;ext.html;606.3512042114936;639.7409049335018;663.8605892762516;664.9102371179889;669.1602039440502;33807.32385352292;34523.65476345236;34584;34598.135046623844;34599.48100778484;42675.78662106693;43309;43366.783166084206;43412;43447;8713.302935765123;8889.333300002494;8894.199522043014;8932.46405215689;8989;8447.535385553792;8807.295416366675;8912.153345432205;8913;10723.946380268128;10645.14838812897;10735.83896241557;10740.409277489734;10742.355458672504;10745.83881241782;10375.066244038035;10558;10559.155267578652;10563.841542376871;10568.682939511827;8344.582770861492;10082.848757268646;10327.27709060366;10485.423301718403;10504.317219380791;40515.39226911599;40983;41268.1746365074;41285.174296514204;41349.58650413487;3483.6864682178725;3626.582942961567;3675.9081022974374;3813.9618603813883;4044.9393259100843;31658.683413165803;31726.524102138486;32204.355912881612;32209;32314.838425807957;4198.118395137025;4309.267424537805;4318.2227199104145;4337.9132417351475;4348.717333373353;336920;341543;341897;343683;344501;69271;69921;69944;69962;69977.65011174911;72726.27273727302;74277.62861185659;74402.25597744061;74459.25540744631;74521.25478745143;18012.459626211235;18091.185896634684;18222.544436388933;18223.271069157352;18253.361132360304;14171.433142674177;14315.498957536436;14353.210573418562;14398.496052638317;14481;18958.74976405635;21287.78712212889;21943.231986880382;21965;22006.44983875384;7881.763547093597;7907.5650839203245;7956.164602716632;8219.95890020546;8281.792955176048;1084.8969347911936;1086.9673909782719;1103.0458653264868;1136.5999029731804;1136.8976792088586;33473.83263083669;34147.14632134217;34161.65838341635;34406.48390274148;35215.11962200965;1213.0538180219444;1218.1003176362365;1294.2428679222571;1312.7440149171011;1320.8216890719823;17785.46643600694;18029.639407211784;18201.544961376072;18236.36172733948;18271.451856444062;537462;538975;543441;544059;544169;64395.67802161053;64846.675766620865;64889;65035.67482162559;65068.67465662641;1456.919869407193;1495.439210296139;1501.226868162897;1516.226724370557;1529.319452843474;30065;30443.225326590742;31301.84349078331;31634.209144771565;31887;49310.75344623254;50936.23595645994;50996.74501627468;51059.23411148761;51063;254080;255513;255675;256045;256057;31080.533791992686;31836.204094896886;32120.196995074377;32210.516842246918;32234.516482253253;51692.22461663153;52444;52941.7352913233;53072.73463632657;53968.46031539791;42929.57070429256;43198.568014319455;43532.12935741331;43875.341869871336;44727.32909006302;37485;38082.42876356912;38457.615423845404;38473;39018;39775.2044959105;44818.77590612026;45778.084438311715;46069.30896036629;46184.53815461802;33189.17027074342;33874.661253388134;34794.65205348015;34806.47790283097;34928.47607285842;27266;27413.45173096567;27532.311692207055;27565.448691026468;27757.167284981482 13:02:10 INFO - PROCESS | 20478 | |2;jquery.html;436.74450446488805;438.69729886378417;441.17500274486713;441.82989549023625;453.8976098367657;19076.33232836849;19480.805191948057;19614.90192549037;20909.581808363822;21397.465063373384;19948.501287467785;20485.897570512163;20488.487787805312;20525.589488210226;20629.484262893435;5033.572146367554;5287.41838397776;5290.259363689087;5293.947060529384;5297.046531624306;4054.6958978076764;5228.901930594579;5303.965726683298;5627.240322556443;5888.558358123137;5884.646921184722;5901.852453688649;5902.055671092626;5902.793402230923;5909.911351329733;5659.462351076682;5798.10129429939;5819.185314056035;5843.328017278025;5872.5889187756875;3938.9803050984847;4088.7342322748927;5504.422035686235;5664.971675141598;5694;14306.356213970397;14351.712965740731;19076.14157362908;22799.658005129935;23018.88490557553;2579.8452092874486;2585.9353516162246;2624.0815714499963;2629;2630.1977896741487;10252.179825614008;10484.213683973732;10860.837087443695;14196.645083872883;15567.45513907019;2016.5462770876582;2036.6944958256381;2090.811826935583;2097.517570958673;2152.3650523095725;82238.9999999994;83560.58219708923;84993;85194;86286.56856715739;11663.300201987908;11746.236494627821;11800.350980696145;11918.821217681741;12515.87484125147;16793.748093778602;17115.486535403958;17185;17192.22634981429;17195.57011074708;9056.637734490547;9174.449533028039;9291.72124836256;9332.813343733087;9377.765555861159;9147.313951453667;9203.217726493323;9260.351775375793;9337.13257348533;9344;5028;5102.642815002914;5145.845624631267;5190.351206099238;5206.505381988705;1848.8428483579046;2009.2164056018164;2042.101475350841;2091.801278878504;2092.382747089612;967.2842096848423;1045.268312181476;1065.3607835298915;1073.4686330266568;1103.6688993301977;19254.074592540634;19379.612407751767;19380.612387752448;19489.80510194908;19596.844347121805;1033.9379637221791;1040.70339953113;1058.1799105692996;1097.1332647208776;1140.9372484513265;10618.575256989789;11019.889801102046;11076.544459494875;11142.26417353474;11229.10167186623;567816;651674;660587;672762;672858;60787.69606151941;71957;99229;100544;109738;1093.4478088565384;1124.4321617583068;1132.0094916947671;1133.960311389114;1151.8963293303643;16667.74998375001;16895.155242237593;17222.224999875285;17278.30886764515;17447.56381090483;42107.57892421159;42387.57612423836;43466;43945.34081988837;44163.77918110389;58962.41037589569;63398.36601633925;63533;63553.364466356594;63695;8882.15619516145;8935.508547029976;8957.820843582962;9078.273738100805;9136.26909847224;8184.2224988625985;10024.699259022242;10611.31026483276;12917.547885823951;14045.789313160516;11921.701957451132;11944;11998.700032499257;12103.334316612318;12125.333106679218;11634.592789252336;11652.825207622061;11695;11981.880181198076;12259.264444133381;12541.686457838627;12633;12643.051771117387;12669.93665031669;12678.302693351954;8086.959565202136;8567.785805354915;9042.3670343078;9093.272538196796;9377;8853.557322133996;11715.941420292844;12344.567940122053;12399.442025109072;12854.55009074678 13:02:10 INFO - PROCESS | 20478 | |3;mootools.html;1391.6381740747402;1551.0383562191441;1551.798266225391;1742.1637613945306;1866.7106598477233;8128;8434.451760635555;8445.95777021114;8450.619722112504;8466.534340611272;8266.132056134109;8484.19400156984;8496.32029437645;8504.61729222185;8511.829763404729;2149.151085321305;2208.7018252535863;2210.9778902211015;2428.332208642624;2458.7787099161073;2391.1033362489065;2460.200434858678;2463.876806159694;2464.0267094497663;2465.8767061646936;2360.5396947595227;2365.207655435431;2373.4303767095944;2375.7386687464364;2416.7824895759377;2109.98945005274;2365.7161140663056;2374.4301367671806;2384.0702126170895;2384.344305316043;2344.367020904346;2378.595638741418;2388.677528533643;2392.043182726906;2392.8923198455936;8351.95824020876;8410.957945210295;8422.28410585101;8425.662973481054;8429.83140337196;5181.870453238699;5279.683219006872;5280.867978300535;5294.57643388528;5297.682139071668;3311.602607687069;3382.8477718502727;3466.7053300469493;3474.0099071764425;3486.3898817707054;1097.319661809683;1105.7180418993187;1116.5920617748368;1127.937963412012;1171.9003884669814;12340;12446.937765311206;12451.688707782287;12458.81311780324;12481.31352775597;4640.350350950802;4644.615767222084;4652.906941861212;4687.437507499122;4711.128441238382;10383.792324153626;10443.634472793416;10448.42533660656;10473.162147028219;10526.947365263124;5232.630753321019;5293.523582877559;5355.812546560852;5362.302900622894;5367.812126575551;4342.848000319974;4673.228917228687;4848.418189817245;4958.975205123951;4968.428630707443;4051.756894586334;4143.399207114951;4174.91650166995;4251.06476575153;4254.31930891056;1357.511295933463;1357.633438971472;1362.7410791949499;1366.2075995922341;1381.716748066644;874.4665753890122;1009.2430676992255;1009.3842755918884;1026.1688032693542;1028.8456731490337;5644.407337229614;5715.571332150105;5735.397783232784;5841.240638716939;5906.793262235801;420.4492115328929;437.6105266312984;438.01228230340377;442.11576846307383;448.44169009582623;3639.8544058237376;3794.5446546414605;3831.5976822433245;3844.8077596120083;3868.5357757069332;10576.947115264375;10694.679159625224;11053.668389948314;11100.500477478532;11105.333679979227;10690.144788416908;10812.513436895359;10814.29707069038;10817.621383251706;10845.078168355778;8273.669053237803;8297.8340433191;8345.332373410112;8353.415260931677;8370.497770133812;5772.278465191851;5796.101604251347;5817.214676018683;5843.766249349978;5973.014452615444;9805.656802011896;9819.65631202933;9851.802963940825;9880.555375007998;9981.301308908307;9036.548172591212;9300.813983720423;9479.431234125974;9507.429554226768;10075.848862266925;7005.54463959841;7190.748323808851;7200.675969581277;7357.043584334002;7437.553746775211;7976.9202307976175;8255.339572834038;8275.172482751677;8284.378671599774;8288.792780180302;7443.330100291;7587.50681205742;7597.354224890946;7678.884816727866;7700.268474494914;7392.186859445565;7455.888161677471;7471.514351567131;7577.659005344883;7578.848423031619;6747.797566073025;6791.694373753094;6798.32016798336;6915.170179578282;6966.5471744336455;4921.384826896638;4959.851204463872;4998.750062496933;5074.695518268915;5080.695158290514;5085.949140508696;5099.1331473648825;5112.028714544224;5156.303898973741;5236.842894713165 13:02:10 INFO - PROCESS | 20478 | |4;prototype.html;342.78404605098797;348.2356228079366;350.71066370244546;359.75177127781814;359.9172190396207;6252.187215661969;6259.7496100155995;6268.905966410502;6300.30696623371;6314.810555683325;6011.188489553909;6067.271927368711;6220.906686399708;6280.968595157029;6295.874082518347;4770.21291486906;4788.186008378567;4798.448178459469;4810.831620893269;4811.735354555498;4795.880102997418;4799.304100905367;4801.591864691505;4808.350872632185;4820;4567.337736028274;4580.221362368406;4725.645576581753;4743.644226682995;4778.761061946906;4736.478987311393;4742.075295317414;4746.21687421575;4750.263709125074;4752.07334569759;4183;4183.811728472226;4191.1827193697245;4197.580241975808;4203.369494575808;6022.427869352405;6024.909626355608;6035.336113027607;6035.6076855004285;6036.728347224385;5511.58663100269;5538.169274608801;5539.806106786243;5543.390227075019;5550.888982220374;6361.968190159066;6496.545241833073;6497.967510162419;6511.055896894971;6567.441767449773;4547.613452856511;4608.907821843544;4618.630509559261;4620.953790462086;4633.837815676435;6891.896621550681;6892;6896.827579310558;6910.550814197011;6911.861762764716;4735.928961065587;4740.478547359788;4741.170295198326;4742.051589682077;4742.383490146328;4804.5195480451675;4810.7835147418455;4811.206150985118;4812.374391329105;4814.301926220748;5361.463853614608;5508.862278442991;5514.09017512114;5517.475839795213;5521.116621340566;6599.967000165065;6634.966825165843;6635.203775546869;6639.302873198245;6642.4686025118845;1575.2123938030984;1638.680457310813;1668.7079761041769;1684.9915750421414;1686.1569215392303;1114.899659030691;1133.8412622232895;1140.845985791924;1141.2068612314363;1148.1388958281289;6425.1968503937005;6428.967855160694;6438.935610643927;6442.935570644234;6461.095446637474;6798.8300292492095;6799.694013769392;6813.454923606099;6813.671334089805;6838.111045564045;6375.203099612549;6407.551471396958;6422.74309027643;6424.646644434601;6435.678216089177;3611.5485564304463;3656.232191239816;3656.7074634029213;3665.340238756996;3666.944995825065;6974.721011159599;6976.441884649216;7224.133104027445;7247.275272472711;7272.745453909088;7041.155061392666;7051.365377116084;7068.681909314093;7082.893756593655;7098.751543695946;7246.094238220223;7250.419966402781;7254.782356529313;7270.854582908312;7271.67277472515;6984.685689144102;6985.336393042653;6985.615791131537;6990.161180658353;6993.580385176702;6693.011110338979;6749.291324411062;6802.489813263926;6806.829829254309;6814.216365117876;7183.892241616275;7213.783586492414;7231.096112985877;7236.529625574532;7244.89132663;4605.332226827024;4619.630429565694;4622.168009758276;4628.861134165981;4630.930536041895;6679.23188833271;6942.132233470817;6945.444364450731;6945.68744406513;6947.305269473012;6618.900716489353;6778.288279730557;6781.593104413751;6799.014142949146;6799.354061364163;6710.832229194114;6740.157480314961;6743.5953842769595;6748.089007984056;6748.93251067483;6636.0377745225705;6637.137172167587;6637.435817955527;6640.601563906181;6645.003249512419;6537.477001839747;6723.193216814014;6803.829904252235;6806.115205023315;6811.591304521745;6612.537122401386;6613;6630.602163870183;6651.102101216467;6662.167229096363 13:02:10 INFO - PROCESS | 20478 | |5;yui.html;772.2277722277722;787.826678130811;823.7446391618598;867.5575456517175;895.4045559702798;14472.131672099667;14613;15236.466723664675;15260.618484537892;15279;14234.217118058503;14264.643383915407;14285.428582856699;14317.997740158193;14359.712805743906;739.3530660671912;753.1150897695213;869.6217145541709;885.7918389178537;887.041994645781;878.6046279174398;880.3441436130092;881.3742243007472;881.5107615273521;882.0606054551914;771.56406630254;923.833709932212;925.047201382577;925.9120383563551;926.1294383279729;775.6083177995105;775.7091090840935;919.3977944446365;927.5640448989031;930.2743859789375;672.6737532296833;676.8544762876005;680.8876535371658;681.2200030964518;683.5522732610149;14576.562703118818;14629.341679624336;14633.487827925972;14647.340869660891;14650.633734156625;13772.586822395344;13906.652333691638;14043.08719933201;14054.437822487089;14170;11303.434828258636;11373.545058197662;11513.366764827932;11733.120015998835;11935.343556104412;3946.48695669564;3994.121293315466;4042.5755295694116;4099.7745124018165;4142.357934520154;58942;59194.70402648002;61111;61744.07383889245;61917.69041154855;11578;11779.823302650468;11932.22440541362;11991.700207494883;12003.519859205533;22315.77684223137;22460.438489037577;22499.437514061952;22546.098156073575;22556.548869022856;8314.376421768391;8344.20596583833;8599.699010534727;8613.569321533898;8685.91314086851;4563.475200351935;4630.536946305342;4646.070785842845;4698.013417182362;4719.952800471951;3294.1764558860286;3346.6486018968144;3353.966460335414;3372.359251742161;3375.1393394684196;643.0868167202584;674.9865002700017;686.6703982088626;687.0861753867345;692.5152393324693;648.503894520692;693.9757108501178;706.4419108904011;716.1513606376357;810.8743144812563;9934.900650993543;9950.35322704022;9961.651342202988;10072.546735396925;10102.747431314276;765.9693612255447;781.2695130053419;782.1396463889789;787.9054513458307;795.0340336491191;4247.237052656808;4341.435613370305;4474;4581.885452863638;4723.055388922229;65813.34186658169;67916;68047.31952680509;68133.65933170302;68450;57802;58057.419425806045;58615.120773188435;59247;59909;54352.728236359355;54585;54941;55067.72466137644;56177;8909.287257019552;8944.731658050008;8965.910340896507;9286.396384235004;9377.1091746284;40580.18839623132;41031.58968410278;41970.160596788504;42013;42573.78713106415;48206.517934821604;52299.21551176659;52384.738076309375;52690.47309526856;53393.199102012724;11528.769424611628;11529;11774.94112529432;11783.234089784137;12024.458899349374;13274.867251327749;13316;13320.800187996994;13328;13370.331483425984;12269.754604907674;12309;12355.135140540076;12413.93793031029;12486.68783280389;12307.32309722938;12325.75348493043;12327;12345.753084938431;12387.566435174725;12202.81695774582;12441.191322564004;12448.937755311528;12520.373981301082;12536.937315313366;9864.260180486635;10038.347507411994;10169.84745228837;10215.978402159724;10220.795584088426;10045.899541004497;10291.742706432398;10312.188888393432;10358.637447689294;10361.171106311327 13:02:10 INFO - PROCESS | 20478 | __end_tp_report 13:02:10 INFO - PROCESS | 20478 | __start_cc_report 13:02:10 INFO - PROCESS | 20478 | _x_x_mozilla_cycle_collect,923 13:02:10 INFO - PROCESS | 20478 | __end_cc_report 13:02:10 INFO - PROCESS | 20478 | __startTimestamp1464292930827__endTimestamp 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | ------- Summary: start ------- 13:02:10 INFO - PROCESS | 20478 | Number of tests: 6 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#0] dojo.html Cycles:165 Average:5627.43 Median:5830.65 stddev:631.26 (10.8%) stddev-sans-first:607.40 13:02:10 INFO - PROCESS | 20478 | Values: 3350.4 3425.9 3426.4 3440.7 3462.4 5709.1 5712.5 5714.2 5718.1 5721.5 5719.1 5744.5 5745.3 5755.2 5758.4 4946.1 5139.1 5266.0 5298.4 5327.1 5147.6 5188.5 5191.0 5196.4 5203.1 5135.9 5166.9 5217.8 5222.5 5234.1 5203.5 5230.9 5231.1 5233.9 5263.9 4999.3 5010.7 5087.3 5114.4 5135.9 5554.7 5564.3 5606.4 5609.0 5610.8 6079.9 6112.2 6116.3 6121.4 6122.3 5962.9 6012.6 6036.5 6057.2 6134.9 5640.5 5647.7 5669.1 5673.0 5684.7 6071.9 6191.9 6207.2 6212.2 6218.0 6044.6 6086.4 6095.7 6111.8 6124.0 6112.2 6115.8 6119.4 6121.6 6127.3 5942.0 5983.4 6080.6 6088.4 6089.5 5967.5 5994.6 6000.9 6004.0 6031.7 4556.5 4564.7 4569.8 4571.9 4586.8 4020.0 4086.2 4096.5 4116.9 4137.0 5675.3 5696.0 5698.5 5698.6 5739.5 5949.6 6000.1 6007.1 6007.5 6018.4 5699.9 5715.0 5765.0 5875.6 5881.3 4991.4 4993.9 5009.5 5009.9 5011.4 6219.0 6220.8 6221.5 6232.1 6244.8 6000.0 6110.3 6175.7 6185.4 6192.1 6136.3 6140.9 6151.4 6157.0 6160.2 5778.7 5809.2 5811.9 5816.7 5880.6 6073.6 6130.0 6138.9 6143.7 6147.9 5960.0 5991.9 5996.9 5999.1 6002.1 5758.3 5840.5 5913.7 5933.2 5972.0 5827.7 5850.5 5851.2 5855.6 5886.7 5940.9 5965.7 5968.7 5970.4 5971.1 5755.7 5824.0 5826.3 5830.7 5849.3 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#1] ext.html Cycles:180 Average:56362.53 Median:34697.07 stddev:105583.72 (304.3%) stddev-sans-first:105796.92 13:02:10 INFO - PROCESS | 20478 | Values: 606.4 639.7 663.9 664.9 669.2 33807.3 34523.7 34584.0 34598.1 34599.5 42675.8 43309.0 43366.8 43412.0 43447.0 8713.3 8889.3 8894.2 8932.5 8989.0 8447.5 8807.3 8912.2 8913.0 10723.9 10645.1 10735.8 10740.4 10742.4 10745.8 10375.1 10558.0 10559.2 10563.8 10568.7 8344.6 10082.8 10327.3 10485.4 10504.3 40515.4 40983.0 41268.2 41285.2 41349.6 3483.7 3626.6 3675.9 3814.0 4044.9 31658.7 31726.5 32204.4 32209.0 32314.8 4198.1 4309.3 4318.2 4337.9 4348.7 336920.0 341543.0 341897.0 343683.0 344501.0 69271.0 69921.0 69944.0 69962.0 69977.7 72726.3 74277.6 74402.3 74459.3 74521.3 18012.5 18091.2 18222.5 18223.3 18253.4 14171.4 14315.5 14353.2 14398.5 14481.0 18958.7 21287.8 21943.2 21965.0 22006.4 7881.8 7907.6 7956.2 8220.0 8281.8 1084.9 1087.0 1103.0 1136.6 1136.9 33473.8 34147.1 34161.7 34406.5 35215.1 1213.1 1218.1 1294.2 1312.7 1320.8 17785.5 18029.6 18201.5 18236.4 18271.5 537462.0 538975.0 543441.0 544059.0 544169.0 64395.7 64846.7 64889.0 65035.7 65068.7 1456.9 1495.4 1501.2 1516.2 1529.3 30065.0 30443.2 31301.8 31634.2 31887.0 49310.8 50936.2 50996.7 51059.2 51063.0 254080.0 255513.0 255675.0 256045.0 256057.0 31080.5 31836.2 32120.2 32210.5 32234.5 51692.2 52444.0 52941.7 53072.7 53968.5 42929.6 43198.6 43532.1 43875.3 44727.3 37485.0 38082.4 38457.6 38473.0 39018.0 39775.2 44818.8 45778.1 46069.3 46184.5 33189.2 33874.7 34794.7 34806.5 34928.5 27266.0 27413.5 27532.3 27565.4 27757.2 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#2] jquery.html Cycles:180 Average:33617.87 Median:11774.92 stddev:105964.96 (899.9%) stddev-sans-first:106232.92 13:02:10 INFO - PROCESS | 20478 | Values: 436.7 438.7 441.2 441.8 453.9 19076.3 19480.8 19614.9 20909.6 21397.5 19948.5 20485.9 20488.5 20525.6 20629.5 5033.6 5287.4 5290.3 5293.9 5297.0 4054.7 5228.9 5304.0 5627.2 5888.6 5884.6 5901.9 5902.1 5902.8 5909.9 5659.5 5798.1 5819.2 5843.3 5872.6 3939.0 4088.7 5504.4 5665.0 5694.0 14306.4 14351.7 19076.1 22799.7 23018.9 2579.8 2585.9 2624.1 2629.0 2630.2 10252.2 10484.2 10860.8 14196.6 15567.5 2016.5 2036.7 2090.8 2097.5 2152.4 82239.0 83560.6 84993.0 85194.0 86286.6 11663.3 11746.2 11800.4 11918.8 12515.9 16793.7 17115.5 17185.0 17192.2 17195.6 9056.6 9174.4 9291.7 9332.8 9377.8 9147.3 9203.2 9260.4 9337.1 9344.0 5028.0 5102.6 5145.8 5190.4 5206.5 1848.8 2009.2 2042.1 2091.8 2092.4 967.3 1045.3 1065.4 1073.5 1103.7 19254.1 19379.6 19380.6 19489.8 19596.8 1033.9 1040.7 1058.2 1097.1 1140.9 10618.6 11019.9 11076.5 11142.3 11229.1 567816.0 651674.0 660587.0 672762.0 672858.0 60787.7 71957.0 99229.0 100544.0 109738.0 1093.4 1124.4 1132.0 1134.0 1151.9 16667.7 16895.2 17222.2 17278.3 17447.6 42107.6 42387.6 43466.0 43945.3 44163.8 58962.4 63398.4 63533.0 63553.4 63695.0 8882.2 8935.5 8957.8 9078.3 9136.3 8184.2 10024.7 10611.3 12917.5 14045.8 11921.7 11944.0 11998.7 12103.3 12125.3 11634.6 11652.8 11695.0 11981.9 12259.3 12541.7 12633.0 12643.1 12669.9 12678.3 8087.0 8567.8 9042.4 9093.3 9377.0 8853.6 11715.9 12344.6 12399.4 12854.6 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#3] mootools.html Cycles:180 Average:5706.47 Median:4699.28 stddev:3237.11 (68.9%) stddev-sans-first:3229.95 13:02:10 INFO - PROCESS | 20478 | Values: 1391.6 1551.0 1551.8 1742.2 1866.7 8128.0 8434.5 8446.0 8450.6 8466.5 8266.1 8484.2 8496.3 8504.6 8511.8 2149.2 2208.7 2211.0 2428.3 2458.8 2391.1 2460.2 2463.9 2464.0 2465.9 2360.5 2365.2 2373.4 2375.7 2416.8 2110.0 2365.7 2374.4 2384.1 2384.3 2344.4 2378.6 2388.7 2392.0 2392.9 8352.0 8411.0 8422.3 8425.7 8429.8 5181.9 5279.7 5280.9 5294.6 5297.7 3311.6 3382.8 3466.7 3474.0 3486.4 1097.3 1105.7 1116.6 1127.9 1171.9 12340.0 12446.9 12451.7 12458.8 12481.3 4640.4 4644.6 4652.9 4687.4 4711.1 10383.8 10443.6 10448.4 10473.2 10526.9 5232.6 5293.5 5355.8 5362.3 5367.8 4342.8 4673.2 4848.4 4959.0 4968.4 4051.8 4143.4 4174.9 4251.1 4254.3 1357.5 1357.6 1362.7 1366.2 1381.7 874.5 1009.2 1009.4 1026.2 1028.8 5644.4 5715.6 5735.4 5841.2 5906.8 420.4 437.6 438.0 442.1 448.4 3639.9 3794.5 3831.6 3844.8 3868.5 10576.9 10694.7 11053.7 11100.5 11105.3 10690.1 10812.5 10814.3 10817.6 10845.1 8273.7 8297.8 8345.3 8353.4 8370.5 5772.3 5796.1 5817.2 5843.8 5973.0 9805.7 9819.7 9851.8 9880.6 9981.3 9036.5 9300.8 9479.4 9507.4 10075.8 7005.5 7190.7 7200.7 7357.0 7437.6 7976.9 8255.3 8275.2 8284.4 8288.8 7443.3 7587.5 7597.4 7678.9 7700.3 7392.2 7455.9 7471.5 7577.7 7578.8 6747.8 6791.7 6798.3 6915.2 6966.5 4921.4 4959.9 4998.8 5074.7 5080.7 5085.9 5099.1 5112.0 5156.3 5236.8 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#4] prototype.html Cycles:180 Average:5578.35 Median:6368.59 stddev:1699.48 (26.7%) stddev-sans-first:1658.20 13:02:10 INFO - PROCESS | 20478 | Values: 342.8 348.2 350.7 359.8 359.9 6252.2 6259.7 6268.9 6300.3 6314.8 6011.2 6067.3 6220.9 6281.0 6295.9 4770.2 4788.2 4798.4 4810.8 4811.7 4795.9 4799.3 4801.6 4808.4 4820.0 4567.3 4580.2 4725.6 4743.6 4778.8 4736.5 4742.1 4746.2 4750.3 4752.1 4183.0 4183.8 4191.2 4197.6 4203.4 6022.4 6024.9 6035.3 6035.6 6036.7 5511.6 5538.2 5539.8 5543.4 5550.9 6362.0 6496.5 6498.0 6511.1 6567.4 4547.6 4608.9 4618.6 4621.0 4633.8 6891.9 6892.0 6896.8 6910.6 6911.9 4735.9 4740.5 4741.2 4742.1 4742.4 4804.5 4810.8 4811.2 4812.4 4814.3 5361.5 5508.9 5514.1 5517.5 5521.1 6600.0 6635.0 6635.2 6639.3 6642.5 1575.2 1638.7 1668.7 1685.0 1686.2 1114.9 1133.8 1140.8 1141.2 1148.1 6425.2 6429.0 6438.9 6442.9 6461.1 6798.8 6799.7 6813.5 6813.7 6838.1 6375.2 6407.6 6422.7 6424.6 6435.7 3611.5 3656.2 3656.7 3665.3 3666.9 6974.7 6976.4 7224.1 7247.3 7272.7 7041.2 7051.4 7068.7 7082.9 7098.8 7246.1 7250.4 7254.8 7270.9 7271.7 6984.7 6985.3 6985.6 6990.2 6993.6 6693.0 6749.3 6802.5 6806.8 6814.2 7183.9 7213.8 7231.1 7236.5 7244.9 4605.3 4619.6 4622.2 4628.9 4630.9 6679.2 6942.1 6945.4 6945.7 6947.3 6618.9 6778.3 6781.6 6799.0 6799.4 6710.8 6740.2 6743.6 6748.1 6748.9 6636.0 6637.1 6637.4 6640.6 6645.0 6537.5 6723.2 6803.8 6806.1 6811.6 6612.5 6613.0 6630.6 6651.1 6662.2 13:02:10 INFO - PROCESS | 20478 | 13:02:10 INFO - PROCESS | 20478 | [#5] yui.html Cycles:180 Average:15918.42 Median:4606.21 stddev:19025.21 (413.0%) stddev-sans-first:19044.58 13:02:10 INFO - PROCESS | 20478 | Values: 772.2 787.8 823.7 867.6 895.4 14472.1 14613.0 15236.5 15260.6 15279.0 14234.2 14264.6 14285.4 14318.0 14359.7 739.4 753.1 869.6 885.8 887.0 878.6 880.3 881.4 881.5 882.1 771.6 923.8 925.0 925.9 926.1 775.6 775.7 919.4 927.6 930.3 672.7 676.9 680.9 681.2 683.6 14576.6 14629.3 14633.5 14647.3 14650.6 13772.6 13906.7 14043.1 14054.4 14170.0 11303.4 11373.5 11513.4 11733.1 11935.3 3946.5 3994.1 4042.6 4099.8 4142.4 58942.0 59194.7 61111.0 61744.1 61917.7 11578.0 11779.8 11932.2 11991.7 12003.5 22315.8 22460.4 22499.4 22546.1 22556.5 8314.4 8344.2 8599.7 8613.6 8685.9 4563.5 4630.5 4646.1 4698.0 4720.0 3294.2 3346.6 3354.0 3372.4 3375.1 643.1 675.0 686.7 687.1 692.5 648.5 694.0 706.4 716.2 810.9 9934.9 9950.4 9961.7 10072.5 10102.7 766.0 781.3 782.1 787.9 795.0 4247.2 4341.4 4474.0 4581.9 4723.1 65813.3 67916.0 68047.3 68133.7 68450.0 57802.0 58057.4 58615.1 59247.0 59909.0 54352.7 54585.0 54941.0 55067.7 56177.0 8909.3 8944.7 8965.9 9286.4 9377.1 40580.2 41031.6 41970.2 42013.0 42573.8 48206.5 52299.2 52384.7 52690.5 53393.2 11528.8 11529.0 11774.9 11783.2 12024.5 13274.9 13316.0 13320.8 13328.0 13370.3 12269.8 12309.0 12355.1 12413.9 12486.7 12307.3 12325.8 12327.0 12345.8 12387.6 12202.8 12441.2 12448.9 12520.4 12536.9 9864.3 10038.3 10169.8 10216.0 10220.8 10045.9 10291.7 10312.2 10358.6 10361.2 13:02:10 INFO - PROCESS | 20478 | -------- Summary: end -------- 13:02:10 INFO - PROCESS | 20478 | 13:02:11 INFO - TEST-INFO | 20478: exit 0 13:02:11 INFO - TEST-OK | dromaeo_css | took 1110431ms 13:02:11 INFO - TEST-START | kraken 13:02:11 INFO - operating with platform_type : linux_ 13:02:11 INFO - Initialising browser for kraken test... 13:02:11 INFO - TEST-INFO | started process 20666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpACDfLy/profile http://localhost:48481/getInfo.html) 13:02:14 INFO - PROCESS | 20666 | __metrics Screen width/height:1600/1200 13:02:14 INFO - PROCESS | 20666 | colorDepth:24 13:02:14 INFO - PROCESS | 20666 | Browser inner width/height: 1024/697 13:02:14 INFO - PROCESS | 20666 | __metrics 13:02:15 ERROR - PROCESS | 20666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:02:16 INFO - TEST-INFO | 20666: exit 0 13:02:16 INFO - Browser initialized. 13:02:16 INFO - Running cycle 1/1 for kraken test... 13:02:16 INFO - TEST-INFO | started process 20760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpACDfLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:28 INFO - PROCESS | 20760 | RSS: Main: 142237696 13:02:28 INFO - PROCESS | 20760 | 13:02:30 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48481/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:31 INFO - PROCESS | 20760 | RSS: Main: 196702208 13:02:31 INFO - PROCESS | 20760 | 13:02:34 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48481/tests/kraken/driver.html?testName=audio-dft) 13:02:34 INFO - PROCESS | 20760 | RSS: Main: 181186560 13:02:34 INFO - PROCESS | 20760 | 13:02:37 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48481/tests/kraken/driver.html?testName=audio-fft) 13:02:38 INFO - PROCESS | 20760 | RSS: Main: 271634432 13:02:38 INFO - PROCESS | 20760 | 13:02:40 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48481/tests/kraken/driver.html?testName=audio-oscillator) 13:02:40 INFO - PROCESS | 20760 | RSS: Main: 178266112 13:02:40 INFO - PROCESS | 20760 | 13:02:42 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:02:43 INFO - PROCESS | 20760 | RSS: Main: 176369664 13:02:43 INFO - PROCESS | 20760 | 13:02:46 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48481/tests/kraken/driver.html?testName=imaging-darkroom) 13:02:46 INFO - PROCESS | 20760 | RSS: Main: 210821120 13:02:46 INFO - PROCESS | 20760 | 13:02:50 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48481/tests/kraken/driver.html?testName=imaging-desaturate) 13:02:50 INFO - PROCESS | 20760 | RSS: Main: 211419136 13:02:50 INFO - PROCESS | 20760 | 13:02:53 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48481/tests/kraken/driver.html?testName=json-parse-financial) 13:02:54 INFO - PROCESS | 20760 | RSS: Main: 211312640 13:02:54 INFO - PROCESS | 20760 | 13:02:55 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:56 INFO - PROCESS | 20760 | RSS: Main: 191553536 13:02:56 INFO - PROCESS | 20760 | 13:02:58 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:58 INFO - PROCESS | 20760 | RSS: Main: 192724992 13:02:58 INFO - PROCESS | 20760 | 13:03:00 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:01 INFO - PROCESS | 20760 | RSS: Main: 206663680 13:03:01 INFO - PROCESS | 20760 | 13:03:03 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:04 INFO - PROCESS | 20760 | RSS: Main: 213377024 13:03:04 INFO - PROCESS | 20760 | 13:03:06 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:07 INFO - PROCESS | 20760 | RSS: Main: 210874368 13:03:07 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | Cycle 1(1): loaded http://localhost:48481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48481/tests/kraken/driver.html?testName=ai-astar) 13:03:09 INFO - PROCESS | 20760 | RSS: Main: 274550784 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | __start_tp_report 13:03:09 INFO - PROCESS | 20760 | _x_x_mozilla_page_load 13:03:09 INFO - PROCESS | 20760 | _x_x_mozilla_page_load_details 13:03:09 INFO - PROCESS | 20760 | |i|pagename|runs| 13:03:09 INFO - PROCESS | 20760 | |0;ai-astar;111;110;110;109;109;111;108;109;109;109 13:03:09 INFO - PROCESS | 20760 | |1;audio-beat-detection;152;126;159;189;129;151;170;127;181;125 13:03:09 INFO - PROCESS | 20760 | |2;audio-dft;163;160;159;159;160;160;161;160;162;158 13:03:09 INFO - PROCESS | 20760 | |3;audio-fft;76;75;74;172;76;75;75;76;160;75 13:03:09 INFO - PROCESS | 20760 | |4;audio-oscillator;92;92;158;92;92;92;149;92;93;154 13:03:09 INFO - PROCESS | 20760 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;117;118;116 13:03:09 INFO - PROCESS | 20760 | |6;imaging-darkroom;145;145;145;145;145;151;145;145;146;145 13:03:09 INFO - PROCESS | 20760 | |7;imaging-desaturate;94;95;94;94;95;95;94;94;94;94 13:03:09 INFO - PROCESS | 20760 | |8;json-parse-financial;54;55;57;57;54;54;56;78;54;53 13:03:09 INFO - PROCESS | 20760 | |9;json-stringify-tinderbox;59;58;58;59;59;59;59;58;58;59 13:03:09 INFO - PROCESS | 20760 | |10;stanford-crypto-aes;73;72;72;72;73;73;73;73;73;73 13:03:09 INFO - PROCESS | 20760 | |11;stanford-crypto-ccm;119;117;118;120;119;112;112;112;129;115 13:03:09 INFO - PROCESS | 20760 | |12;stanford-crypto-pbkdf2;157;154;154;159;158;159;153;159;152;156 13:03:09 INFO - PROCESS | 20760 | |13;stanford-crypto-sha256-iterative;65;65;67;67;71;64;64;64;65;64 13:03:09 INFO - PROCESS | 20760 | __end_tp_report 13:03:09 INFO - PROCESS | 20760 | __start_cc_report 13:03:09 INFO - PROCESS | 20760 | _x_x_mozilla_cycle_collect,1600 13:03:09 INFO - PROCESS | 20760 | __end_cc_report 13:03:09 INFO - PROCESS | 20760 | __startTimestamp1464292989490__endTimestamp 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | ------- Summary: start ------- 13:03:09 INFO - PROCESS | 20760 | Number of tests: 14 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#0] ai-astar Cycles:10 Average:109.50 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:0.87 13:03:09 INFO - PROCESS | 20760 | Values: 111.0 110.0 110.0 109.0 109.0 111.0 108.0 109.0 109.0 109.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.50 stddev:23.88 (15.4%) stddev-sans-first:25.32 13:03:09 INFO - PROCESS | 20760 | Values: 152.0 126.0 159.0 189.0 129.0 151.0 170.0 127.0 181.0 125.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.48 (0.9%) stddev-sans-first:1.17 13:03:09 INFO - PROCESS | 20760 | Values: 163.0 160.0 159.0 159.0 160.0 160.0 161.0 160.0 162.0 158.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.37 (51.2%) stddev-sans-first:40.18 13:03:09 INFO - PROCESS | 20760 | Values: 76.0 75.0 74.0 172.0 76.0 75.0 75.0 76.0 160.0 75.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:29.80 (32.4%) stddev-sans-first:30.83 13:03:09 INFO - PROCESS | 20760 | Values: 92.0 92.0 158.0 92.0 92.0 92.0 149.0 92.0 93.0 154.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:03:09 INFO - PROCESS | 20760 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 118.0 116.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.00 stddev:1.89 (1.3%) stddev-sans-first:1.99 13:03:09 INFO - PROCESS | 20760 | Values: 145.0 145.0 145.0 145.0 145.0 151.0 145.0 145.0 146.0 145.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:03:09 INFO - PROCESS | 20760 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:7.44 (13.4%) stddev-sans-first:7.80 13:03:09 INFO - PROCESS | 20760 | Values: 54.0 55.0 57.0 57.0 54.0 54.0 56.0 78.0 54.0 53.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 13:03:09 INFO - PROCESS | 20760 | Values: 59.0 58.0 58.0 59.0 59.0 59.0 59.0 58.0 58.0 59.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:03:09 INFO - PROCESS | 20760 | Values: 73.0 72.0 72.0 72.0 73.0 73.0 73.0 73.0 73.0 73.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.50 stddev:5.17 (4.4%) stddev-sans-first:5.44 13:03:09 INFO - PROCESS | 20760 | Values: 119.0 117.0 118.0 120.0 119.0 112.0 112.0 112.0 129.0 115.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:157.50 stddev:2.69 (1.7%) stddev-sans-first:2.83 13:03:09 INFO - PROCESS | 20760 | Values: 157.0 154.0 154.0 159.0 158.0 159.0 153.0 159.0 152.0 156.0 13:03:09 INFO - PROCESS | 20760 | 13:03:09 INFO - PROCESS | 20760 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:2.22 (3.4%) stddev-sans-first:2.35 13:03:09 INFO - PROCESS | 20760 | Values: 65.0 65.0 67.0 67.0 71.0 64.0 64.0 64.0 65.0 64.0 13:03:09 INFO - PROCESS | 20760 | -------- Summary: end -------- 13:03:09 INFO - PROCESS | 20760 | 13:03:10 INFO - TEST-INFO | 20760: exit 0 13:03:10 INFO - TEST-OK | kraken | took 58869ms 13:03:10 INFO - SUITE-END | took 1169s 13:03:10 INFO - Completed test suite (00:19:29) 13:03:10 INFO - javascript benchmark 13:03:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.3801796667617, 3425.862965481381, 3426.4175090234658, 3440.707539859112, 3462.394081035818, 5709.1436284557285, 5712.485876271135, 5714.200011998323, 5718.056520674089, 5721.456461636149, 5719.1421286807, 5744.454276843703, 5745.339285982113, 5755.165501002352, 5758.42415758424, 4946.060248552763, 5139.126348520751, 5265.973670131644, 5298.390685071208, 5327.094393953037, 5147.613928955325, 5188.481151884819, 5191.039657663345, 5196.428392876781, 5203.089459344618, 5135.871603209931, 5166.948330516684, 5217.817376391827, 5222.451642577532, 5234.084035293828, 5203.531682148606, 5230.895382092356, 5231.110711179109, 5233.921491177635, 5263.947360526384, 4999.32509111269, 5010.7494625268955, 5087.313212716273, 5114.3862736471865, 5135.948640513584, 5554.694491802989, 5564.304461942257, 5606.383297837235, 5609.046462101453, 5610.803621873215, 6079.908801367983, 6112.174856394375, 6116.296625887991, 6121.418465245794, 6122.326544080148, 5962.910556341659, 6012.6392416455155, 6036.486898613623, 6057.242844644419, 6134.877302453926, 5640.464155905182, 5647.661140331593, 5669.149627555858, 5672.971635141798, 5684.744186511575, 6071.939719442051, 6191.876162476725, 6207.224096987877, 6212.192414986023, 6218.036204388327, 6044.607100538451, 6086.421789929949, 6095.712861415753, 6111.755529778848, 6124.0, 6112.205413296243, 6115.755369785159, 6119.388061193934, 6121.632702037892, 6127.325994140641, 5942.049272116441, 5983.371745966698, 6080.604760690541, 6088.360722124202, 6089.543284253698, 5967.46292833647, 5994.550408719363, 6000.939990600038, 6004.039353703386, 6031.728572214261, 4556.476005259371, 4564.7032942858605, 4569.817207311737, 4571.9314210286875, 4586.770661466913, 4019.979900100481, 4086.1827634473225, 4096.508418989681, 4116.91766164675, 4137.027798467418, 5675.31896172462, 5696.0, 5698.458646428583, 5698.572607054488, 5739.540836733051, 5949.553783466257, 6000.069989151689, 6007.098935159674, 6007.549433792483, 6018.4282493163955, 5699.943000570024, 5714.971425142848, 5764.971175144097, 5875.618084824473, 5881.264841894763, 4991.3511243538105, 4993.90012199754, 5009.499050094962, 5009.874753131128, 5011.448740638527, 6219.036049412348, 6220.813375598739, 6221.47117495018, 6232.127502149703, 6244.781432649836, 5999.970000149971, 6110.315755985069, 6175.69121543912, 6185.381461853958, 6192.133101365723, 6136.325004249618, 6140.8771824564155, 6151.384861513813, 6157.0456579230295, 6160.229971253593, 5778.739956702043, 5809.215755872903, 5811.94188058114, 5816.651000939957, 5880.588358815013, 6073.5748497604745, 6130.049842274455, 6138.904709091533, 6143.72682107623, 6147.938520614915, 5960.0, 5991.88016239664, 5996.940030599812, 5999.130126131599, 6002.129691194839, 5758.280214973129, 5840.474357307863, 5913.674747888907, 5933.228680271537, 5971.970140149271, 5827.708614569339, 5850.473457388855, 5851.239338886088, 5855.590108692521, 5886.676232807236, 5940.910886336795, 5965.731542080704, 5968.671723055274, 5970.373110823301, 5971.104334349709, 5755.65466072037, 5824.0, 5826.300843898759, 5830.650160990354, 5849.268841394825], "value": 5585.956949865308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3512042114936, 639.7409049335018, 663.8605892762516, 664.9102371179889, 669.1602039440502, 33807.32385352292, 34523.65476345236, 34584.0, 34598.135046623844, 34599.48100778484, 42675.78662106693, 43309.0, 43366.783166084206, 43412.0, 43447.0, 8713.302935765123, 8889.333300002494, 8894.199522043014, 8932.46405215689, 8989.0, 8447.535385553792, 8807.295416366675, 8912.153345432205, 8913.0, 10723.946380268128, 10645.14838812897, 10735.83896241557, 10740.409277489734, 10742.355458672504, 10745.83881241782, 10375.066244038035, 10558.0, 10559.155267578652, 10563.841542376871, 10568.682939511827, 8344.582770861492, 10082.848757268646, 10327.27709060366, 10485.423301718403, 10504.317219380791, 40515.39226911599, 40983.0, 41268.1746365074, 41285.174296514204, 41349.58650413487, 3483.6864682178725, 3626.582942961567, 3675.9081022974374, 3813.9618603813883, 4044.9393259100843, 31658.683413165803, 31726.524102138486, 32204.355912881612, 32209.0, 32314.838425807957, 4198.118395137025, 4309.267424537805, 4318.2227199104145, 4337.9132417351475, 4348.717333373353, 336920.0, 341543.0, 341897.0, 343683.0, 344501.0, 69271.0, 69921.0, 69944.0, 69962.0, 69977.65011174911, 72726.27273727302, 74277.62861185659, 74402.25597744061, 74459.25540744631, 74521.25478745143, 18012.459626211235, 18091.185896634684, 18222.544436388933, 18223.271069157352, 18253.361132360304, 14171.433142674177, 14315.498957536436, 14353.210573418562, 14398.496052638317, 14481.0, 18958.74976405635, 21287.78712212889, 21943.231986880382, 21965.0, 22006.44983875384, 7881.763547093597, 7907.5650839203245, 7956.164602716632, 8219.95890020546, 8281.792955176048, 1084.8969347911936, 1086.9673909782719, 1103.0458653264868, 1136.5999029731804, 1136.8976792088586, 33473.83263083669, 34147.14632134217, 34161.65838341635, 34406.48390274148, 35215.11962200965, 1213.0538180219444, 1218.1003176362365, 1294.2428679222571, 1312.7440149171011, 1320.8216890719823, 17785.46643600694, 18029.639407211784, 18201.544961376072, 18236.36172733948, 18271.451856444062, 537462.0, 538975.0, 543441.0, 544059.0, 544169.0, 64395.67802161053, 64846.675766620865, 64889.0, 65035.67482162559, 65068.67465662641, 1456.919869407193, 1495.439210296139, 1501.226868162897, 1516.226724370557, 1529.319452843474, 30065.0, 30443.225326590742, 31301.84349078331, 31634.209144771565, 31887.0, 49310.75344623254, 50936.23595645994, 50996.74501627468, 51059.23411148761, 51063.0, 254080.0, 255513.0, 255675.0, 256045.0, 256057.0, 31080.533791992686, 31836.204094896886, 32120.196995074377, 32210.516842246918, 32234.516482253253, 51692.22461663153, 52444.0, 52941.7352913233, 53072.73463632657, 53968.46031539791, 42929.57070429256, 43198.568014319455, 43532.12935741331, 43875.341869871336, 44727.32909006302, 37485.0, 38082.42876356912, 38457.615423845404, 38473.0, 39018.0, 39775.2044959105, 44818.77590612026, 45778.084438311715, 46069.30896036629, 46184.53815461802, 33189.17027074342, 33874.661253388134, 34794.65205348015, 34806.47790283097, 34928.47607285842, 27266.0, 27413.45173096567, 27532.311692207055, 27565.448691026468, 27757.167284981482], "value": 20878.966629680694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.74450446488805, 438.69729886378417, 441.17500274486713, 441.82989549023625, 453.8976098367657, 19076.33232836849, 19480.805191948057, 19614.90192549037, 20909.581808363822, 21397.465063373384, 19948.501287467785, 20485.897570512163, 20488.487787805312, 20525.589488210226, 20629.484262893435, 5033.572146367554, 5287.41838397776, 5290.259363689087, 5293.947060529384, 5297.046531624306, 4054.6958978076764, 5228.901930594579, 5303.965726683298, 5627.240322556443, 5888.558358123137, 5884.646921184722, 5901.852453688649, 5902.055671092626, 5902.793402230923, 5909.911351329733, 5659.462351076682, 5798.10129429939, 5819.185314056035, 5843.328017278025, 5872.5889187756875, 3938.9803050984847, 4088.7342322748927, 5504.422035686235, 5664.971675141598, 5694.0, 14306.356213970397, 14351.712965740731, 19076.14157362908, 22799.658005129935, 23018.88490557553, 2579.8452092874486, 2585.9353516162246, 2624.0815714499963, 2629.0, 2630.1977896741487, 10252.179825614008, 10484.213683973732, 10860.837087443695, 14196.645083872883, 15567.45513907019, 2016.5462770876582, 2036.6944958256381, 2090.811826935583, 2097.517570958673, 2152.3650523095725, 82238.9999999994, 83560.58219708923, 84993.0, 85194.0, 86286.56856715739, 11663.300201987908, 11746.236494627821, 11800.350980696145, 11918.821217681741, 12515.87484125147, 16793.748093778602, 17115.486535403958, 17185.0, 17192.22634981429, 17195.57011074708, 9056.637734490547, 9174.449533028039, 9291.72124836256, 9332.813343733087, 9377.765555861159, 9147.313951453667, 9203.217726493323, 9260.351775375793, 9337.13257348533, 9344.0, 5028.0, 5102.642815002914, 5145.845624631267, 5190.351206099238, 5206.505381988705, 1848.8428483579046, 2009.2164056018164, 2042.101475350841, 2091.801278878504, 2092.382747089612, 967.2842096848423, 1045.268312181476, 1065.3607835298915, 1073.4686330266568, 1103.6688993301977, 19254.074592540634, 19379.612407751767, 19380.612387752448, 19489.80510194908, 19596.844347121805, 1033.9379637221791, 1040.70339953113, 1058.1799105692996, 1097.1332647208776, 1140.9372484513265, 10618.575256989789, 11019.889801102046, 11076.544459494875, 11142.26417353474, 11229.10167186623, 567816.0, 651674.0, 660587.0, 672762.0, 672858.0, 60787.69606151941, 71957.0, 99229.0, 100544.0, 109738.0, 1093.4478088565384, 1124.4321617583068, 1132.0094916947671, 1133.960311389114, 1151.8963293303643, 16667.74998375001, 16895.155242237593, 17222.224999875285, 17278.30886764515, 17447.56381090483, 42107.57892421159, 42387.57612423836, 43466.0, 43945.34081988837, 44163.77918110389, 58962.41037589569, 63398.36601633925, 63533.0, 63553.364466356594, 63695.0, 8882.15619516145, 8935.508547029976, 8957.820843582962, 9078.273738100805, 9136.26909847224, 8184.2224988625985, 10024.699259022242, 10611.31026483276, 12917.547885823951, 14045.789313160516, 11921.701957451132, 11944.0, 11998.700032499257, 12103.334316612318, 12125.333106679218, 11634.592789252336, 11652.825207622061, 11695.0, 11981.880181198076, 12259.264444133381, 12541.686457838627, 12633.0, 12643.051771117387, 12669.93665031669, 12678.302693351954, 8086.959565202136, 8567.785805354915, 9042.3670343078, 9093.272538196796, 9377.0, 8853.557322133996, 11715.941420292844, 12344.567940122053, 12399.442025109072, 12854.55009074678], "value": 9583.016133702598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.6381740747402, 1551.0383562191441, 1551.798266225391, 1742.1637613945306, 1866.7106598477233, 8128.0, 8434.451760635555, 8445.95777021114, 8450.619722112504, 8466.534340611272, 8266.132056134109, 8484.19400156984, 8496.32029437645, 8504.61729222185, 8511.829763404729, 2149.151085321305, 2208.7018252535863, 2210.9778902211015, 2428.332208642624, 2458.7787099161073, 2391.1033362489065, 2460.200434858678, 2463.876806159694, 2464.0267094497663, 2465.8767061646936, 2360.5396947595227, 2365.207655435431, 2373.4303767095944, 2375.7386687464364, 2416.7824895759377, 2109.98945005274, 2365.7161140663056, 2374.4301367671806, 2384.0702126170895, 2384.344305316043, 2344.367020904346, 2378.595638741418, 2388.677528533643, 2392.043182726906, 2392.8923198455936, 8351.95824020876, 8410.957945210295, 8422.28410585101, 8425.662973481054, 8429.83140337196, 5181.870453238699, 5279.683219006872, 5280.867978300535, 5294.57643388528, 5297.682139071668, 3311.602607687069, 3382.8477718502727, 3466.7053300469493, 3474.0099071764425, 3486.3898817707054, 1097.319661809683, 1105.7180418993187, 1116.5920617748368, 1127.937963412012, 1171.9003884669814, 12340.0, 12446.937765311206, 12451.688707782287, 12458.81311780324, 12481.31352775597, 4640.350350950802, 4644.615767222084, 4652.906941861212, 4687.437507499122, 4711.128441238382, 10383.792324153626, 10443.634472793416, 10448.42533660656, 10473.162147028219, 10526.947365263124, 5232.630753321019, 5293.523582877559, 5355.812546560852, 5362.302900622894, 5367.812126575551, 4342.848000319974, 4673.228917228687, 4848.418189817245, 4958.975205123951, 4968.428630707443, 4051.756894586334, 4143.399207114951, 4174.91650166995, 4251.06476575153, 4254.31930891056, 1357.511295933463, 1357.633438971472, 1362.7410791949499, 1366.2075995922341, 1381.716748066644, 874.4665753890122, 1009.2430676992255, 1009.3842755918884, 1026.1688032693542, 1028.8456731490337, 5644.407337229614, 5715.571332150105, 5735.397783232784, 5841.240638716939, 5906.793262235801, 420.4492115328929, 437.6105266312984, 438.01228230340377, 442.11576846307383, 448.44169009582623, 3639.8544058237376, 3794.5446546414605, 3831.5976822433245, 3844.8077596120083, 3868.5357757069332, 10576.947115264375, 10694.679159625224, 11053.668389948314, 11100.500477478532, 11105.333679979227, 10690.144788416908, 10812.513436895359, 10814.29707069038, 10817.621383251706, 10845.078168355778, 8273.669053237803, 8297.8340433191, 8345.332373410112, 8353.415260931677, 8370.497770133812, 5772.278465191851, 5796.101604251347, 5817.214676018683, 5843.766249349978, 5973.014452615444, 9805.656802011896, 9819.65631202933, 9851.802963940825, 9880.555375007998, 9981.301308908307, 9036.548172591212, 9300.813983720423, 9479.431234125974, 9507.429554226768, 10075.848862266925, 7005.54463959841, 7190.748323808851, 7200.675969581277, 7357.043584334002, 7437.553746775211, 7976.9202307976175, 8255.339572834038, 8275.172482751677, 8284.378671599774, 8288.792780180302, 7443.330100291, 7587.50681205742, 7597.354224890946, 7678.884816727866, 7700.268474494914, 7392.186859445565, 7455.888161677471, 7471.514351567131, 7577.659005344883, 7578.848423031619, 6747.797566073025, 6791.694373753094, 6798.32016798336, 6915.170179578282, 6966.5471744336455, 4921.384826896638, 4959.851204463872, 4998.750062496933, 5074.695518268915, 5080.695158290514, 5085.949140508696, 5099.1331473648825, 5112.028714544224, 5156.303898973741, 5236.842894713165], "value": 4520.0380523415215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.78404605098797, 348.2356228079366, 350.71066370244546, 359.75177127781814, 359.9172190396207, 6252.187215661969, 6259.7496100155995, 6268.905966410502, 6300.30696623371, 6314.810555683325, 6011.188489553909, 6067.271927368711, 6220.906686399708, 6280.968595157029, 6295.874082518347, 4770.21291486906, 4788.186008378567, 4798.448178459469, 4810.831620893269, 4811.735354555498, 4795.880102997418, 4799.304100905367, 4801.591864691505, 4808.350872632185, 4820.0, 4567.337736028274, 4580.221362368406, 4725.645576581753, 4743.644226682995, 4778.761061946906, 4736.478987311393, 4742.075295317414, 4746.21687421575, 4750.263709125074, 4752.07334569759, 4183.0, 4183.811728472226, 4191.1827193697245, 4197.580241975808, 4203.369494575808, 6022.427869352405, 6024.909626355608, 6035.336113027607, 6035.6076855004285, 6036.728347224385, 5511.58663100269, 5538.169274608801, 5539.806106786243, 5543.390227075019, 5550.888982220374, 6361.968190159066, 6496.545241833073, 6497.967510162419, 6511.055896894971, 6567.441767449773, 4547.613452856511, 4608.907821843544, 4618.630509559261, 4620.953790462086, 4633.837815676435, 6891.896621550681, 6892.0, 6896.827579310558, 6910.550814197011, 6911.861762764716, 4735.928961065587, 4740.478547359788, 4741.170295198326, 4742.051589682077, 4742.383490146328, 4804.5195480451675, 4810.7835147418455, 4811.206150985118, 4812.374391329105, 4814.301926220748, 5361.463853614608, 5508.862278442991, 5514.09017512114, 5517.475839795213, 5521.116621340566, 6599.967000165065, 6634.966825165843, 6635.203775546869, 6639.302873198245, 6642.4686025118845, 1575.2123938030984, 1638.680457310813, 1668.7079761041769, 1684.9915750421414, 1686.1569215392303, 1114.899659030691, 1133.8412622232895, 1140.845985791924, 1141.2068612314363, 1148.1388958281289, 6425.1968503937005, 6428.967855160694, 6438.935610643927, 6442.935570644234, 6461.095446637474, 6798.8300292492095, 6799.694013769392, 6813.454923606099, 6813.671334089805, 6838.111045564045, 6375.203099612549, 6407.551471396958, 6422.74309027643, 6424.646644434601, 6435.678216089177, 3611.5485564304463, 3656.232191239816, 3656.7074634029213, 3665.340238756996, 3666.944995825065, 6974.721011159599, 6976.441884649216, 7224.133104027445, 7247.275272472711, 7272.745453909088, 7041.155061392666, 7051.365377116084, 7068.681909314093, 7082.893756593655, 7098.751543695946, 7246.094238220223, 7250.419966402781, 7254.782356529313, 7270.854582908312, 7271.67277472515, 6984.685689144102, 6985.336393042653, 6985.615791131537, 6990.161180658353, 6993.580385176702, 6693.011110338979, 6749.291324411062, 6802.489813263926, 6806.829829254309, 6814.216365117876, 7183.892241616275, 7213.783586492414, 7231.096112985877, 7236.529625574532, 7244.89132663, 4605.332226827024, 4619.630429565694, 4622.168009758276, 4628.861134165981, 4630.930536041895, 6679.23188833271, 6942.132233470817, 6945.444364450731, 6945.68744406513, 6947.305269473012, 6618.900716489353, 6778.288279730557, 6781.593104413751, 6799.014142949146, 6799.354061364163, 6710.832229194114, 6740.157480314961, 6743.5953842769595, 6748.089007984056, 6748.93251067483, 6636.0377745225705, 6637.137172167587, 6637.435817955527, 6640.601563906181, 6645.003249512419, 6537.477001839747, 6723.193216814014, 6803.829904252235, 6806.115205023315, 6811.591304521745, 6612.537122401386, 6613.0, 6630.602163870183, 6651.102101216467, 6662.167229096363], "value": 5024.915526056542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.2277722277722, 787.826678130811, 823.7446391618598, 867.5575456517175, 895.4045559702798, 14472.131672099667, 14613.0, 15236.466723664675, 15260.618484537892, 15279.0, 14234.217118058503, 14264.643383915407, 14285.428582856699, 14317.997740158193, 14359.712805743906, 739.3530660671912, 753.1150897695213, 869.6217145541709, 885.7918389178537, 887.041994645781, 878.6046279174398, 880.3441436130092, 881.3742243007472, 881.5107615273521, 882.0606054551914, 771.56406630254, 923.833709932212, 925.047201382577, 925.9120383563551, 926.1294383279729, 775.6083177995105, 775.7091090840935, 919.3977944446365, 927.5640448989031, 930.2743859789375, 672.6737532296833, 676.8544762876005, 680.8876535371658, 681.2200030964518, 683.5522732610149, 14576.562703118818, 14629.341679624336, 14633.487827925972, 14647.340869660891, 14650.633734156625, 13772.586822395344, 13906.652333691638, 14043.08719933201, 14054.437822487089, 14170.0, 11303.434828258636, 11373.545058197662, 11513.366764827932, 11733.120015998835, 11935.343556104412, 3946.48695669564, 3994.121293315466, 4042.5755295694116, 4099.7745124018165, 4142.357934520154, 58942.0, 59194.70402648002, 61111.0, 61744.07383889245, 61917.69041154855, 11578.0, 11779.823302650468, 11932.22440541362, 11991.700207494883, 12003.519859205533, 22315.77684223137, 22460.438489037577, 22499.437514061952, 22546.098156073575, 22556.548869022856, 8314.376421768391, 8344.20596583833, 8599.699010534727, 8613.569321533898, 8685.91314086851, 4563.475200351935, 4630.536946305342, 4646.070785842845, 4698.013417182362, 4719.952800471951, 3294.1764558860286, 3346.6486018968144, 3353.966460335414, 3372.359251742161, 3375.1393394684196, 643.0868167202584, 674.9865002700017, 686.6703982088626, 687.0861753867345, 692.5152393324693, 648.503894520692, 693.9757108501178, 706.4419108904011, 716.1513606376357, 810.8743144812563, 9934.900650993543, 9950.35322704022, 9961.651342202988, 10072.546735396925, 10102.747431314276, 765.9693612255447, 781.2695130053419, 782.1396463889789, 787.9054513458307, 795.0340336491191, 4247.237052656808, 4341.435613370305, 4474.0, 4581.885452863638, 4723.055388922229, 65813.34186658169, 67916.0, 68047.31952680509, 68133.65933170302, 68450.0, 57802.0, 58057.419425806045, 58615.120773188435, 59247.0, 59909.0, 54352.728236359355, 54585.0, 54941.0, 55067.72466137644, 56177.0, 8909.287257019552, 8944.731658050008, 8965.910340896507, 9286.396384235004, 9377.1091746284, 40580.18839623132, 41031.58968410278, 41970.160596788504, 42013.0, 42573.78713106415, 48206.517934821604, 52299.21551176659, 52384.738076309375, 52690.47309526856, 53393.199102012724, 11528.769424611628, 11529.0, 11774.94112529432, 11783.234089784137, 12024.458899349374, 13274.867251327749, 13316.0, 13320.800187996994, 13328.0, 13370.331483425984, 12269.754604907674, 12309.0, 12355.135140540076, 12413.93793031029, 12486.68783280389, 12307.32309722938, 12325.75348493043, 12327.0, 12345.753084938431, 12387.566435174725, 12202.81695774582, 12441.191322564004, 12448.937755311528, 12520.373981301082, 12536.937315313366, 9864.260180486635, 10038.347507411994, 10169.84745228837, 10215.978402159724, 10220.795584088426, 10045.899541004497, 10291.742706432398, 10312.188888393432, 10358.637447689294, 10361.171106311327], "value": 7033.215523959804, "unit": "score"}], "name": "dromaeo_css", "value": 7504.050402087996, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 109.0, 109.0, 111.0, 108.0, 109.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 159.0, 189.0, 129.0, 151.0, 170.0, 127.0, 181.0, 125.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 159.0, 159.0, 160.0, 160.0, 161.0, 160.0, 162.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 172.0, 76.0, 75.0, 75.0, 76.0, 160.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 158.0, 92.0, 92.0, 92.0, 149.0, 92.0, 93.0, 154.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 151.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 57.0, 54.0, 54.0, 56.0, 78.0, 54.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 120.0, 119.0, 112.0, 112.0, 112.0, 129.0, 115.0], "value": 117.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 154.0, 159.0, 158.0, 159.0, 153.0, 159.0, 152.0, 156.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 67.0, 71.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1508.6999999999998, "alertThreshold": 2.0}]} 13:03:10 INFO - Return code: 0 13:03:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:03:10 ERROR - # TBPL SUCCESS # 13:03:10 INFO - Running post-action listener: _resource_record_post_action 13:03:10 INFO - Running post-run listener: _resource_record_post_run 13:03:11 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 490516480; Read time: 28; Write time: 338012 13:03:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248995840; Read time: 0; Write time: 197368 13:03:11 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 241520640; Read time: 28; Write time: 140644 13:03:11 INFO - Running post-run listener: _upload_blobber_files 13:03:11 INFO - Blob upload gear active. 13:03:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:03:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:03:11 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'] 13:03:11 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 13:03:12 INFO - (blobuploader) - INFO - Open directory for files ... 13:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:13 INFO - (blobuploader) - INFO - Done attempting. 13:03:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:03:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:03:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:14 INFO - (blobuploader) - INFO - Done attempting. 13:03:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:14 INFO - Return code: 0 13:03:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00137dc7fb203143726d65fdfa09b8caa260d8e16408e4f9dd041d1e76aa35da54e103dfae3663bf34211a4023e2e24b6567085ae49f4fca27e5abab24fb8cee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d73c74d0b26fd50a25d4cf37213b3441ab2731e3e7c89506e52b1071c82b3af09f92314cd4a7d7468de1e5b1f2b093f1775ea22ed59bfe0999e6d1e5de8995cd"} 13:03:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:14 INFO - Contents: 13:03:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00137dc7fb203143726d65fdfa09b8caa260d8e16408e4f9dd041d1e76aa35da54e103dfae3663bf34211a4023e2e24b6567085ae49f4fca27e5abab24fb8cee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d73c74d0b26fd50a25d4cf37213b3441ab2731e3e7c89506e52b1071c82b3af09f92314cd4a7d7468de1e5b1f2b093f1775ea22ed59bfe0999e6d1e5de8995cd"} 13:03:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:14 INFO - Copying logs to upload dir... 13:03:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.619842 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-26 13:03:14.098964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:03:14.102270) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 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/00137dc7fb203143726d65fdfa09b8caa260d8e16408e4f9dd041d1e76aa35da54e103dfae3663bf34211a4023e2e24b6567085ae49f4fca27e5abab24fb8cee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d73c74d0b26fd50a25d4cf37213b3441ab2731e3e7c89506e52b1071c82b3af09f92314cd4a7d7468de1e5b1f2b093f1775ea22ed59bfe0999e6d1e5de8995cd"} build_url:https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Af23bjatSAie1gnjm_hYDQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00137dc7fb203143726d65fdfa09b8caa260d8e16408e4f9dd041d1e76aa35da54e103dfae3663bf34211a4023e2e24b6567085ae49f4fca27e5abab24fb8cee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d73c74d0b26fd50a25d4cf37213b3441ab2731e3e7c89506e52b1071c82b3af09f92314cd4a7d7468de1e5b1f2b093f1775ea22ed59bfe0999e6d1e5de8995cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 13:03:14.128260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:03:14.128638) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464290789.528826-2055065781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 13:03:14.212674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:03:14.213076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 13:03:14.213439) ========= ========= Total master_lag: 0.19 =========