builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1461151039.07 results: success (0) buildid: 20160420025138 builduid: 3bb49e3aa94a4d0a96badb2f0439b956 revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.070517) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.071267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.071776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.088787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.089115) ========= 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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 04:17:19-- 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% 21.9M=0.001s 2016-04-20 04:17:19 (21.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.178864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.179209) ========= 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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017613 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.228998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.229369) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f05a1242fb29023bd7ebc492897ed3d6907733c7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f05a1242fb29023bd7ebc492897ed3d6907733c7 --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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 04:17:19,369 truncating revision to first 12 chars 2016-04-20 04:17:19,369 Setting DEBUG logging. 2016-04-20 04:17:19,370 attempt 1/10 2016-04-20 04:17:19,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f05a1242fb29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:17:19,680 unpacking tar archive at: mozilla-central-f05a1242fb29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.825627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.826016) ========= script_repo_revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.826442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.826714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:17:19.835002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 04:17:19.835394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:17:20 INFO - MultiFileLogger online at 20160420 04:17:20 in /builds/slave/test 04:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:20 INFO - {'append_to_log': False, 04:17:20 INFO - 'base_work_dir': '/builds/slave/test', 04:17:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:20 INFO - 'branch': 'Firefox-Non-PGO', 04:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:20 INFO - 'config_files': ('talos/linux_config.py',), 04:17:20 INFO - 'default_actions': ('clobber', 04:17:20 INFO - 'read-buildbot-config', 04:17:20 INFO - 'download-and-extract', 04:17:20 INFO - 'populate-webroot', 04:17:20 INFO - 'create-virtualenv', 04:17:20 INFO - 'install', 04:17:20 INFO - 'run-tests'), 04:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:20 INFO - 'download_minidump_stackwalk': True, 04:17:20 INFO - 'download_symbols': 'ondemand', 04:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:20 INFO - 'installer_path': 'installer.exe', 04:17:20 INFO - 'log_level': 'info', 04:17:20 INFO - 'log_name': 'talos', 04:17:20 INFO - 'log_to_console': True, 04:17:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:17:20 INFO - 'opt_config_files': (), 04:17:20 INFO - 'pip_index': False, 04:17:20 INFO - 'sps_profile': False, 04:17:20 INFO - 'sps_profile_interval': 0, 04:17:20 INFO - 'suite': 'dromaeojs', 04:17:20 INFO - 'system_bits': '32', 04:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:20 INFO - 'title': 'talos-linux64-ix-038', 04:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:20 INFO - 'use_talos_json': True, 04:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:20 INFO - 'work_dir': 'build'} 04:17:20 INFO - ##### 04:17:20 INFO - ##### Running clobber step. 04:17:20 INFO - ##### 04:17:20 INFO - Running pre-action listener: _resource_record_pre_action 04:17:20 INFO - Running main action method: clobber 04:17:20 INFO - rmtree: /builds/slave/test/build 04:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:21 INFO - Running post-action listener: _resource_record_post_action 04:17:21 INFO - ##### 04:17:21 INFO - ##### Running read-buildbot-config step. 04:17:21 INFO - ##### 04:17:21 INFO - Running pre-action listener: _resource_record_pre_action 04:17:21 INFO - Running main action method: read_buildbot_config 04:17:21 INFO - Using buildbot properties: 04:17:21 INFO - { 04:17:21 INFO - "project": "", 04:17:21 INFO - "product": "firefox", 04:17:21 INFO - "script_repo_revision": "production", 04:17:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:17:21 INFO - "repository": "", 04:17:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:17:21 INFO - "buildid": "20160420025138", 04:17:21 INFO - "pgo_build": "False", 04:17:21 INFO - "basedir": "/builds/slave/test", 04:17:21 INFO - "buildnumber": 72, 04:17:21 INFO - "slavename": "talos-linux64-ix-038", 04:17:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:17:21 INFO - "platform": "ubuntu64_hw", 04:17:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:17:21 INFO - "branch": "mozilla-central", 04:17:21 INFO - "repo_path": "mozilla-central", 04:17:21 INFO - "revision": "f05a1242fb29023bd7ebc492897ed3d6907733c7", 04:17:21 INFO - "stage_platform": "linux64", 04:17:21 INFO - "builduid": "3bb49e3aa94a4d0a96badb2f0439b956", 04:17:21 INFO - "slavebuilddir": "test" 04:17:21 INFO - } 04:17:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:17:21 INFO - Running post-action listener: _resource_record_post_action 04:17:21 INFO - ##### 04:17:21 INFO - ##### Running download-and-extract step. 04:17:21 INFO - ##### 04:17:21 INFO - Running pre-action listener: _resource_record_pre_action 04:17:21 INFO - Running main action method: download_and_extract 04:17:21 INFO - mkdir: /builds/slave/test/build/tests 04:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:21 INFO - https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:17:21 INFO - Downloaded 1361 bytes. 04:17:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:17:21 INFO - Using the following test package requirements: 04:17:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:17:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:17:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'jsshell-linux-x86_64.zip'], 04:17:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:17:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:17:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:17:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:17:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:17:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:21 INFO - https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:17:24 INFO - Downloaded 22267541 bytes. 04:17:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:17:25 INFO - Return code: 0 04:17:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:25 INFO - https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:17:27 INFO - Downloaded 22267541 bytes. 04:17:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:17:28 INFO - Return code: 0 04:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:28 INFO - https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:17:29 INFO - Downloaded 10845952 bytes. 04:17:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:17:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:17:30 INFO - Return code: 0 04:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:30 INFO - https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:17:32 INFO - Downloaded 54602932 bytes. 04:17:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:32 INFO - mkdir: /builds/slave/test/properties 04:17:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:17:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:17:32 INFO - Contents: 04:17:32 INFO - build_url:https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:17:33 INFO - Running post-action listener: _resource_record_post_action 04:17:33 INFO - Running post-action listener: set_extra_try_arguments 04:17:33 INFO - ##### 04:17:33 INFO - ##### Running populate-webroot step. 04:17:33 INFO - ##### 04:17:33 INFO - Running pre-action listener: _resource_record_pre_action 04:17:33 INFO - Running main action method: populate_webroot 04:17:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:17:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:17:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:17:33 INFO - '--tppagecycles', 04:17:33 INFO - '7'], 04:17:33 INFO - 'tests': ['tsvgm']}}, 04:17:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:17:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:17:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:17:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:17:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['damp', 'tps']}, 04:17:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'tests': ['damp', 'tps']}, 04:17:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['dromaeo_dom']}, 04:17:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:17:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['a11yr', 04:17:33 INFO - 'ts_paint', 04:17:33 INFO - 'tpaint', 04:17:33 INFO - 'sessionrestore', 04:17:33 INFO - 'sessionrestore_no_auto_restore', 04:17:33 INFO - 'tabpaint']}, 04:17:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['tsvgx', 04:17:33 INFO - 'tsvgr_opacity', 04:17:33 INFO - 'tart', 04:17:33 INFO - 'tscrollx', 04:17:33 INFO - 'cart']}, 04:17:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:17:33 INFO - 'tsvgr_opacity', 04:17:33 INFO - 'tart', 04:17:33 INFO - 'tscrollx', 04:17:33 INFO - 'cart']}, 04:17:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'talos_options': ['--disable-e10s'], 04:17:33 INFO - 'tests': ['tp5o']}, 04:17:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'tests': ['tp5o']}, 04:17:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'talos_options': ['--disable-e10s', 04:17:33 INFO - '--xperf_path', 04:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:33 INFO - 'tests': ['tp5n']}, 04:17:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:33 INFO - 'talos_options': ['--xperf_path', 04:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:33 INFO - 'tests': ['tp5n']}}, 04:17:33 INFO - 'talos.zip': {'path': '', 04:17:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:17:33 INFO - Running post-action listener: _resource_record_post_action 04:17:33 INFO - ##### 04:17:33 INFO - ##### Running create-virtualenv step. 04:17:33 INFO - ##### 04:17:33 INFO - Running pre-action listener: _resource_record_pre_action 04:17:33 INFO - Running main action method: create_virtualenv 04:17:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:17:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:17:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:17:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:17:33 INFO - Using real prefix '/usr' 04:17:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:36 INFO - Installing pip.................done. 04:17:36 INFO - Return code: 0 04:17:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:17:36 INFO - Using env: {'DISPLAY': ':0', 04:17:36 INFO - 'HOME': '/home/cltbld', 04:17:36 INFO - 'LANG': 'en_US.UTF-8', 04:17:36 INFO - 'LANGUAGE': 'en_US:en', 04:17:36 INFO - 'LOGNAME': 'cltbld', 04:17:36 INFO - 'MAIL': '/var/mail/cltbld', 04:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:36 INFO - 'MOZ_NO_REMOTE': '1', 04:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:36 INFO - 'NO_EM_RESTART': '1', 04:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:36 INFO - 'PWD': '/builds/slave/test', 04:17:36 INFO - 'SHELL': '/bin/bash', 04:17:36 INFO - 'SHLVL': '1', 04:17:36 INFO - 'TERM': 'linux', 04:17:36 INFO - 'TMOUT': '86400', 04:17:36 INFO - 'USER': 'cltbld', 04:17:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:36 INFO - '_': '/tools/buildbot/bin/python'} 04:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:17:36 INFO - Cleaning up... 04:17:36 INFO - Return code: 0 04:17:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:36 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:17:36 INFO - Using env: {'DISPLAY': ':0', 04:17:36 INFO - 'HOME': '/home/cltbld', 04:17:36 INFO - 'LANG': 'en_US.UTF-8', 04:17:36 INFO - 'LANGUAGE': 'en_US:en', 04:17:36 INFO - 'LOGNAME': 'cltbld', 04:17:36 INFO - 'MAIL': '/var/mail/cltbld', 04:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:36 INFO - 'MOZ_NO_REMOTE': '1', 04:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:36 INFO - 'NO_EM_RESTART': '1', 04:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:36 INFO - 'PWD': '/builds/slave/test', 04:17:36 INFO - 'SHELL': '/bin/bash', 04:17:36 INFO - 'SHLVL': '1', 04:17:36 INFO - 'TERM': 'linux', 04:17:36 INFO - 'TMOUT': '86400', 04:17:36 INFO - 'USER': 'cltbld', 04:17:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:36 INFO - '_': '/tools/buildbot/bin/python'} 04:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:36 INFO - Downloading/unpacking psutil>=0.7.1 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:38 INFO - Installing collected packages: psutil 04:17:38 INFO - Running setup.py install for psutil 04:17:38 INFO - building 'psutil._psutil_linux' extension 04:17:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:17:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:17:38 INFO - building 'psutil._psutil_posix' extension 04:17:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:17:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:38 INFO - Successfully installed psutil 04:17:38 INFO - Cleaning up... 04:17:39 INFO - Return code: 0 04:17:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:39 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:17:39 INFO - Using env: {'DISPLAY': ':0', 04:17:39 INFO - 'HOME': '/home/cltbld', 04:17:39 INFO - 'LANG': 'en_US.UTF-8', 04:17:39 INFO - 'LANGUAGE': 'en_US:en', 04:17:39 INFO - 'LOGNAME': 'cltbld', 04:17:39 INFO - 'MAIL': '/var/mail/cltbld', 04:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:39 INFO - 'MOZ_NO_REMOTE': '1', 04:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:39 INFO - 'NO_EM_RESTART': '1', 04:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:39 INFO - 'PWD': '/builds/slave/test', 04:17:39 INFO - 'SHELL': '/bin/bash', 04:17:39 INFO - 'SHLVL': '1', 04:17:39 INFO - 'TERM': 'linux', 04:17:39 INFO - 'TMOUT': '86400', 04:17:39 INFO - 'USER': 'cltbld', 04:17:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:39 INFO - '_': '/tools/buildbot/bin/python'} 04:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:17:41 INFO - Installing collected packages: mozsystemmonitor 04:17:41 INFO - Running setup.py install for mozsystemmonitor 04:17:41 INFO - Successfully installed mozsystemmonitor 04:17:41 INFO - Cleaning up... 04:17:41 INFO - Return code: 0 04:17:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:41 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:17:41 INFO - Using env: {'DISPLAY': ':0', 04:17:41 INFO - 'HOME': '/home/cltbld', 04:17:41 INFO - 'LANG': 'en_US.UTF-8', 04:17:41 INFO - 'LANGUAGE': 'en_US:en', 04:17:41 INFO - 'LOGNAME': 'cltbld', 04:17:41 INFO - 'MAIL': '/var/mail/cltbld', 04:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:41 INFO - 'MOZ_NO_REMOTE': '1', 04:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:41 INFO - 'NO_EM_RESTART': '1', 04:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:41 INFO - 'PWD': '/builds/slave/test', 04:17:41 INFO - 'SHELL': '/bin/bash', 04:17:41 INFO - 'SHLVL': '1', 04:17:41 INFO - 'TERM': 'linux', 04:17:41 INFO - 'TMOUT': '86400', 04:17:41 INFO - 'USER': 'cltbld', 04:17:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:41 INFO - '_': '/tools/buildbot/bin/python'} 04:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:44 INFO - Downloading docopt-0.6.1.tar.gz 04:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:44 INFO - Running setup.py install for blobuploader 04:17:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:44 INFO - Running setup.py install for requests 04:17:44 INFO - Running setup.py install for docopt 04:17:44 INFO - Successfully installed blobuploader requests docopt 04:17:44 INFO - Cleaning up... 04:17:44 INFO - Return code: 0 04:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:44 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:44 INFO - Using env: {'DISPLAY': ':0', 04:17:44 INFO - 'HOME': '/home/cltbld', 04:17:44 INFO - 'LANG': 'en_US.UTF-8', 04:17:44 INFO - 'LANGUAGE': 'en_US:en', 04:17:44 INFO - 'LOGNAME': 'cltbld', 04:17:44 INFO - 'MAIL': '/var/mail/cltbld', 04:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:44 INFO - 'MOZ_NO_REMOTE': '1', 04:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:44 INFO - 'NO_EM_RESTART': '1', 04:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:44 INFO - 'PWD': '/builds/slave/test', 04:17:44 INFO - 'SHELL': '/bin/bash', 04:17:44 INFO - 'SHLVL': '1', 04:17:44 INFO - 'TERM': 'linux', 04:17:44 INFO - 'TMOUT': '86400', 04:17:44 INFO - 'USER': 'cltbld', 04:17:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:44 INFO - '_': '/tools/buildbot/bin/python'} 04:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:44 INFO - Running setup.py (path:/tmp/pip-Nap6lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:45 INFO - Running setup.py (path:/tmp/pip-T9QMEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:45 INFO - Running setup.py (path:/tmp/pip-BwpngG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:45 INFO - Running setup.py (path:/tmp/pip-gMTxkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:45 INFO - Running setup.py (path:/tmp/pip-da0vPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:45 INFO - Running setup.py (path:/tmp/pip-z124ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:45 INFO - Running setup.py (path:/tmp/pip-kRiqBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:45 INFO - Running setup.py (path:/tmp/pip-xnzXUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:45 INFO - Running setup.py (path:/tmp/pip-O85j7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:45 INFO - Running setup.py (path:/tmp/pip-HFCxa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:45 INFO - Running setup.py (path:/tmp/pip-zJsNkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:45 INFO - Running setup.py (path:/tmp/pip-p_rTkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:45 INFO - Running setup.py (path:/tmp/pip-3zLVpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:45 INFO - Running setup.py (path:/tmp/pip-mVhXOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:45 INFO - Running setup.py (path:/tmp/pip-bljnaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:46 INFO - Running setup.py (path:/tmp/pip-FGPWSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:46 INFO - Running setup.py (path:/tmp/pip-H_84H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:46 INFO - Running setup.py install for manifestparser 04:17:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Running setup.py install for mozcrash 04:17:46 INFO - Running setup.py install for mozdebug 04:17:46 INFO - Running setup.py install for mozdevice 04:17:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Running setup.py install for mozfile 04:17:46 INFO - Running setup.py install for mozhttpd 04:17:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Running setup.py install for mozinfo 04:17:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Running setup.py install for mozInstall 04:17:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:46 INFO - Running setup.py install for mozleak 04:17:47 INFO - Running setup.py install for mozlog 04:17:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Running setup.py install for moznetwork 04:17:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Running setup.py install for mozprocess 04:17:47 INFO - Running setup.py install for mozprofile 04:17:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Running setup.py install for mozrunner 04:17:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Running setup.py install for mozscreenshot 04:17:47 INFO - Running setup.py install for moztest 04:17:47 INFO - Running setup.py install for mozversion 04:17:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:47 INFO - Cleaning up... 04:17:47 INFO - Return code: 0 04:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:47 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:47 INFO - Using env: {'DISPLAY': ':0', 04:17:47 INFO - 'HOME': '/home/cltbld', 04:17:47 INFO - 'LANG': 'en_US.UTF-8', 04:17:47 INFO - 'LANGUAGE': 'en_US:en', 04:17:47 INFO - 'LOGNAME': 'cltbld', 04:17:47 INFO - 'MAIL': '/var/mail/cltbld', 04:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:47 INFO - 'MOZ_NO_REMOTE': '1', 04:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:47 INFO - 'NO_EM_RESTART': '1', 04:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:47 INFO - 'PWD': '/builds/slave/test', 04:17:47 INFO - 'SHELL': '/bin/bash', 04:17:47 INFO - 'SHLVL': '1', 04:17:47 INFO - 'TERM': 'linux', 04:17:47 INFO - 'TMOUT': '86400', 04:17:47 INFO - 'USER': 'cltbld', 04:17:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:47 INFO - '_': '/tools/buildbot/bin/python'} 04:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:48 INFO - Running setup.py (path:/tmp/pip-GZzqwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:48 INFO - Running setup.py (path:/tmp/pip-tfzw_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:48 INFO - Running setup.py (path:/tmp/pip-NjeebB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:48 INFO - Running setup.py (path:/tmp/pip-ESrYUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:48 INFO - Running setup.py (path:/tmp/pip-HdD9dI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:48 INFO - Running setup.py (path:/tmp/pip-fiY92C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:48 INFO - Running setup.py (path:/tmp/pip-8AUDSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:48 INFO - Running setup.py (path:/tmp/pip-5OV8Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:48 INFO - Running setup.py (path:/tmp/pip-Nh2hgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:48 INFO - Running setup.py (path:/tmp/pip-bgbDJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:48 INFO - Running setup.py (path:/tmp/pip-eRgWLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:48 INFO - Running setup.py (path:/tmp/pip-XroJpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:49 INFO - Running setup.py (path:/tmp/pip-bpPg48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:49 INFO - Running setup.py (path:/tmp/pip-3X58gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:49 INFO - Running setup.py (path:/tmp/pip-Hv6QcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:49 INFO - Running setup.py (path:/tmp/pip-40YShq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:49 INFO - Running setup.py (path:/tmp/pip-JOWQe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:17:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:51 INFO - Downloading blessings-1.6.tar.gz 04:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:51 INFO - Installing collected packages: blessings 04:17:51 INFO - Running setup.py install for blessings 04:17:51 INFO - Successfully installed blessings 04:17:51 INFO - Cleaning up... 04:17:51 INFO - Return code: 0 04:17:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:51 INFO - Reading from file tmpfile_stdout 04:17:51 INFO - Current package versions: 04:17:51 INFO - argparse == 1.2.1 04:17:51 INFO - blessings == 1.6 04:17:51 INFO - blobuploader == 1.2.4 04:17:51 INFO - docopt == 0.6.1 04:17:51 INFO - manifestparser == 1.1 04:17:51 INFO - mozInstall == 1.12 04:17:51 INFO - mozcrash == 0.17 04:17:51 INFO - mozdebug == 0.1 04:17:51 INFO - mozdevice == 0.48 04:17:51 INFO - mozfile == 1.2 04:17:51 INFO - mozhttpd == 0.7 04:17:51 INFO - mozinfo == 0.9 04:17:51 INFO - mozleak == 0.1 04:17:51 INFO - mozlog == 3.1 04:17:51 INFO - moznetwork == 0.27 04:17:51 INFO - mozprocess == 0.22 04:17:51 INFO - mozprofile == 0.28 04:17:51 INFO - mozrunner == 6.11 04:17:51 INFO - mozscreenshot == 0.1 04:17:51 INFO - mozsystemmonitor == 0.0 04:17:51 INFO - moztest == 0.7 04:17:51 INFO - mozversion == 1.4 04:17:51 INFO - psutil == 3.1.1 04:17:51 INFO - requests == 1.2.3 04:17:51 INFO - wsgiref == 0.1.2 04:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:51 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 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:17:51 INFO - Using env: {'DISPLAY': ':0', 04:17:51 INFO - 'HOME': '/home/cltbld', 04:17:51 INFO - 'LANG': 'en_US.UTF-8', 04:17:51 INFO - 'LANGUAGE': 'en_US:en', 04:17:51 INFO - 'LOGNAME': 'cltbld', 04:17:51 INFO - 'MAIL': '/var/mail/cltbld', 04:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:51 INFO - 'MOZ_NO_REMOTE': '1', 04:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:51 INFO - 'NO_EM_RESTART': '1', 04:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:51 INFO - 'PWD': '/builds/slave/test', 04:17:51 INFO - 'SHELL': '/bin/bash', 04:17:51 INFO - 'SHLVL': '1', 04:17:51 INFO - 'TERM': 'linux', 04:17:51 INFO - 'TMOUT': '86400', 04:17:51 INFO - 'USER': 'cltbld', 04:17:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:51 INFO - '_': '/tools/buildbot/bin/python'} 04:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:17:52 INFO - Cleaning up... 04:17:52 INFO - Return code: 0 04:17:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:17:52 INFO - Using env: {'DISPLAY': ':0', 04:17:52 INFO - 'HOME': '/home/cltbld', 04:17:52 INFO - 'LANG': 'en_US.UTF-8', 04:17:52 INFO - 'LANGUAGE': 'en_US:en', 04:17:52 INFO - 'LOGNAME': 'cltbld', 04:17:52 INFO - 'MAIL': '/var/mail/cltbld', 04:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:52 INFO - 'MOZ_NO_REMOTE': '1', 04:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:52 INFO - 'NO_EM_RESTART': '1', 04:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:52 INFO - 'PWD': '/builds/slave/test', 04:17:52 INFO - 'SHELL': '/bin/bash', 04:17:52 INFO - 'SHLVL': '1', 04:17:52 INFO - 'TERM': 'linux', 04:17:52 INFO - 'TMOUT': '86400', 04:17:52 INFO - 'USER': 'cltbld', 04:17:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:52 INFO - '_': '/tools/buildbot/bin/python'} 04:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:52 INFO - Downloading/unpacking jsonschema 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:54 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:54 INFO - warning: no files found matching '*.txt' 04:17:54 INFO - no previously-included directories found matching 'build' 04:17:54 INFO - no previously-included directories found matching 'dist' 04:17:54 INFO - no previously-included directories found matching '.git*' 04:17:54 INFO - Installing collected packages: jsonschema, functools32 04:17:54 INFO - Running setup.py install for functools32 04:17:54 INFO - warning: no files found matching '*.txt' 04:17:54 INFO - no previously-included directories found matching 'build' 04:17:54 INFO - no previously-included directories found matching 'dist' 04:17:54 INFO - no previously-included directories found matching '.git*' 04:17:54 INFO - Successfully installed jsonschema functools32 04:17:54 INFO - Cleaning up... 04:17:54 INFO - Return code: 0 04:17:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1a176ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18445a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, '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': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:17:54 INFO - Using env: {'DISPLAY': ':0', 04:17:54 INFO - 'HOME': '/home/cltbld', 04:17:54 INFO - 'LANG': 'en_US.UTF-8', 04:17:54 INFO - 'LANGUAGE': 'en_US:en', 04:17:54 INFO - 'LOGNAME': 'cltbld', 04:17:54 INFO - 'MAIL': '/var/mail/cltbld', 04:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:54 INFO - 'MOZ_NO_REMOTE': '1', 04:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:54 INFO - 'NO_EM_RESTART': '1', 04:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:54 INFO - 'PWD': '/builds/slave/test', 04:17:54 INFO - 'SHELL': '/bin/bash', 04:17:54 INFO - 'SHLVL': '1', 04:17:54 INFO - 'TERM': 'linux', 04:17:54 INFO - 'TMOUT': '86400', 04:17:54 INFO - 'USER': 'cltbld', 04:17:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:54 INFO - '_': '/tools/buildbot/bin/python'} 04:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:54 INFO - Downloading/unpacking flake8 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:57 INFO - no previously-included directories found matching 'docs/_build' 04:17:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:57 INFO - Running setup.py install for pep8 04:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:57 INFO - no previously-included directories found matching 'docs/_build' 04:17:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:57 INFO - Cleaning up... 04:17:57 INFO - Return code: 0 04:17:57 INFO - Running post-action listener: _resource_record_post_action 04:17:57 INFO - Running post-action listener: _start_resource_monitoring 04:17:57 INFO - Starting resource monitoring. 04:17:57 INFO - ##### 04:17:57 INFO - ##### Running install step. 04:17:57 INFO - ##### 04:17:57 INFO - Running pre-action listener: _resource_record_pre_action 04:17:57 INFO - Running main action method: install 04:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:57 INFO - Reading from file tmpfile_stdout 04:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:58 INFO - Reading from file tmpfile_stdout 04:17:58 INFO - Output received: 04:17:58 INFO - Usage: mozinstall [options] installer 04:17:58 INFO - Options: 04:17:58 INFO - -h, --help show this help message and exit 04:17:58 INFO - -d DEST, --destination=DEST 04:17:58 INFO - Directory to install application into. [default: 04:17:58 INFO - "/builds/slave/test"] 04:17:58 INFO - --app=APP Application being installed. [default: firefox] 04:17:58 INFO - mkdir: /builds/slave/test/build/application 04:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:18:13 INFO - Reading from file tmpfile_stdout 04:18:13 INFO - Output received: 04:18:13 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:13 INFO - Running post-action listener: _resource_record_post_action 04:18:13 INFO - ##### 04:18:13 INFO - ##### Running run-tests step. 04:18:13 INFO - ##### 04:18:13 INFO - Running pre-action listener: _resource_record_pre_action 04:18:13 INFO - Running main action method: run_tests 04:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:13 INFO - Python 2.7.3 04:18:13 INFO - Return code: 0 04:18:13 INFO - grabbing minidump binary from tooltool 04:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:13 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 0x18d3410>, '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 0x18d4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:18:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:18:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:13 INFO - Return code: 0 04:18:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:18:14 INFO - Return code: 0 04:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:18:14 INFO - Using env: {'DISPLAY': ':0', 04:18:14 INFO - 'HOME': '/home/cltbld', 04:18:14 INFO - 'LANG': 'en_US.UTF-8', 04:18:14 INFO - 'LANGUAGE': 'en_US:en', 04:18:14 INFO - 'LOGNAME': 'cltbld', 04:18:14 INFO - 'MAIL': '/var/mail/cltbld', 04:18:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:14 INFO - 'MOZ_NO_REMOTE': '1', 04:18:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:14 INFO - 'NO_EM_RESTART': '1', 04:18:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:14 INFO - 'PWD': '/builds/slave/test', 04:18:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:14 INFO - 'SHELL': '/bin/bash', 04:18:14 INFO - 'SHLVL': '1', 04:18:14 INFO - 'TERM': 'linux', 04:18:14 INFO - 'TMOUT': '86400', 04:18:14 INFO - 'USER': 'cltbld', 04:18:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376', 04:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:14 INFO - '_': '/tools/buildbot/bin/python'} 04:18:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:18:14 INFO - mozversion application_buildid: 20160420025138 04:18:14 INFO - mozversion application_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 04:18:14 INFO - mozversion application_display_name: Nightly 04:18:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:14 INFO - mozversion application_name: Firefox 04:18:14 INFO - mozversion application_remotingname: firefox 04:18:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:18:14 INFO - mozversion application_vendor: Mozilla 04:18:14 INFO - mozversion application_version: 48.0a1 04:18:14 INFO - mozversion platform_buildid: 20160420025138 04:18:14 INFO - mozversion platform_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 04:18:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:18:14 INFO - mozversion platform_version: 48.0a1 04:18:14 INFO - using testdate: 1461151094 04:18:14 INFO - actual date: 1461151094 04:18:14 INFO - starting webserver on 'localhost:53341' 04:18:14 INFO - SUITE-START | Running 2 tests 04:18:14 INFO - TEST-START | dromaeo_css 04:18:14 INFO - operating with platform_type : linux_ 04:18:14 INFO - Initialising browser for dromaeo_css test... 04:18:15 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR1_YM/profile http://localhost:53341/getInfo.html) 04:18:19 INFO - PROCESS | 3391 | __metrics Screen width/height:1600/1200 04:18:19 INFO - PROCESS | 3391 | colorDepth:24 04:18:19 INFO - PROCESS | 3391 | Browser inner width/height: 1024/697 04:18:19 INFO - PROCESS | 3391 | __metrics 04:18:20 ERROR - PROCESS | 3391 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:18:21 INFO - TEST-INFO | 3391: exit 0 04:18:21 INFO - Browser initialized. 04:18:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:18:21 INFO - TEST-INFO | started process 3470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoR1_YM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:33 INFO - PROCESS | 3470 | RSS: Main: 155385856 04:18:33 INFO - PROCESS | 3470 | 04:19:24 INFO - PROCESS | 3470 | 1461151164708 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:21:35 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53341/tests/dromaeo/cssquery-ext.html) 04:21:37 INFO - PROCESS | 3470 | RSS: Main: 228032512 04:21:37 INFO - PROCESS | 3470 | 04:24:39 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-ext.html (next: http://localhost:53341/tests/dromaeo/cssquery-jquery.html) 04:24:40 INFO - PROCESS | 3470 | RSS: Main: 237289472 04:24:40 INFO - PROCESS | 3470 | 04:27:42 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53341/tests/dromaeo/cssquery-mootools.html) 04:27:43 INFO - PROCESS | 3470 | RSS: Main: 239710208 04:27:43 INFO - PROCESS | 3470 | 04:30:45 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53341/tests/dromaeo/cssquery-prototype.html) 04:30:46 INFO - PROCESS | 3470 | RSS: Main: 236388352 04:30:46 INFO - PROCESS | 3470 | 04:33:49 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53341/tests/dromaeo/cssquery-yui.html) 04:33:49 INFO - PROCESS | 3470 | RSS: Main: 214614016 04:33:49 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | Cycle 1(1): loaded http://localhost:53341/tests/dromaeo/cssquery-yui.html (next: http://localhost:53341/tests/dromaeo/cssquery-dojo.html) 04:36:52 INFO - PROCESS | 3470 | RSS: Main: 245456896 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | __start_tp_report 04:36:52 INFO - PROCESS | 3470 | _x_x_mozilla_page_load 04:36:52 INFO - PROCESS | 3470 | _x_x_mozilla_page_load_details 04:36:52 INFO - PROCESS | 3470 | |i|pagename|runs| 04:36:52 INFO - PROCESS | 3470 | |0;dojo.html;2585.806064545159;2630.053180854893;2633.8156329056974;2639.1950455111196;2654.4292977009945;4524.163029839474;4622.214223581991;4624.306354046895;4626.861194164177;4634.235351167062;4693.225617773063;4709.929351059737;4710.670253082277;4780.30685550595;4800.135975524404;4186.748795072298;4187.853425130121;4213.47331583552;4218.346156345771;4393.07745373472;4325.372820940962;4343.066240758237;4351.347297905324;4363.476382834065;4391.626711729491;4203.831846726142;4216.810243539048;4288.69979101463;4288.957110428887;4299.054208074219;4221.577842215785;4250.617444429985;4251.893702657428;4258.787060646955;4313.266744653416;4261.595148460922;4283.721558098714;4287.164003019412;4319.935200971988;4324.113556720865;4443;4499.595036446703;4558.635309175291;4579.793909274091;4635.6986795858165;4981.053599816023;4996.400431948153;4996.475370086161;4999.225120106353;5028.120078986163;4995.925061124086;5010.398752149766;5022.096022715909;5026.52248036436;5044.445111037783;4577.542245775429;4688.859334219979;4697.553732395417;4787.760611969387;4791.257355109894;5155.97422012895;5171.32772739549;5178.145605975047;5182.067227899014;5184.714840683799;4958.702477851269;4959.652824302337;4961.8511444656715;4963.826266080742;5008.549230569266;4896.926546101811;4989.301497790239;5021.221710634857;5075.111855425286;5076.568491678175;4967.776450059756;5017.648764586444;5019.799208031638;5027.296178534935;5078.720670363092;4843.660943733905;4964.801407943714;4982.701037937735;4991.675541089818;5035.395752509722;4181.623653871166;4219.198352313051;4256.638185754184;4278.935815962763;4300.09697963425;3658.140337020798;3661.835217415223;3663.4504824276573;3700.0749812546865;3700.8519659213866;4268.9786551067045;4340.262155433584;4340.544242854518;4350.521442641307;4383.101464199832;4990.775415106329;5025.221090730943;5027.3464449621315;5066.265391518209;5073.213651883964;4351.521332653406;4382.8904277392685;4387.144506821203;4388.934165987513;4412.646988240933;4413.293872980308;4501.7524036177665;4522.841700540465;4523.84166554169;4539.682222244412;4719.858404247878;4720.055988802184;4724.196886529367;4764.0471905619015;4776.09254241693;4975.0547395994645;4976.278439626161;4979.029089327546;4981.950180498148;5026.74866256693;4563.49801521839;4689.2497200449125;4703.247480403119;4747.905041899074;4763.857084287477;4916.92624610624;4925.655204135819;4931.087748766489;4964.156093464192;4977.253411988231;4939.209726443895;4984.925226121683;4987.226979818134;5008.899822003466;5026.070177017264;4751.83368582098;4857.975710121426;4887.43794463627;4913.459519452786;4974.32846565709;4913.091078150411;4926.630502712383;4933.260010998379;4936.580390666833;4939.259111133215;4859.684120532295;4859.95140048595;4869.147899117711;4881.194602890483;4916.70499770015;4766.594839438548;4810.42274926997;4859.951400486091;4893.632977526771;4980.27785971025;4793.472718000948;4796;4805.351277577623;4815.133276010211;4857.931255123867 04:36:52 INFO - PROCESS | 3470 | |1;ext.html;582.4321286745421;605.6456972670987;620.3889169168367;621.8694074244409;629.4303655192052;26431.3392165196;33019.17452063697;33757.32485350291;33770.83114584423;33804;36178.81910590443;36637.81681091591;36724.26551468969;36866.81566592163;36883.4467482988;7162.0689310389835;7496.175420703718;7682.884756728654;9336.486493242868;9561.713148605553;9441;9498.382605130644;9561.760955976086;9581.233501319912;9586.808263834719;9589.041095890425;9674.90325096747;9676.371035882681;9678.128968392879;9679.90320096797;9556.331056826026;9631.951840240825;9634.373765705206;9635.56639951204;9643.807123857554;9525.904740952572;9643.517824108767;9647.179989700884;9942.652007179713;9970.255205339037;36507.81746091279;36900.630993689985;37039.81480092609;37089.814550927345;37124.25751484982;3238.8056716596843;3267.2975310308398;3281.392942305681;3668.211334563082;3900.180961997984;29171.708282917112;29219.41561168786;29447.085939414083;29694.703052969628;29938.700612994027;3479.530263414432;3489.755717099804;3499.125218695326;3513.877014304487;3520.4719292106133;211923;212309;213435;213961.99999999846;214076;49718.50281497211;50197.24704129441;50490.747546262035;50507.24239136416;50519.49480505148;53794.7310263454;54051.18923216155;54239.186412203846;54309.45690543123;54348.72825635847;13985.65035874091;14380.280985950661;14400.783988240184;14423.206723630092;14431.20628365429;11003.119750419946;11041.613543525938;11056;11061.446927653746;11099.223054386277;17718.379856704953;17864.732029019575;17872.463826085237;17989.640207195782;18008.729869051975;6777.2545020047755;7133.286671332929;7166.211716711157;7168.211496735355;7174.569525828467;832.908380078203;872.991270087291;992.4243938515643;993.1855878179823;1001.8547310639916;26725.866370668024;27452.313692157455;27862.860685696443;27878.303042423697;28212.43575128527;974.1281553010158;991.9057689519484;1019.556492925565;1066.2642776484201;1071.3357718214756;14260.215688137045;14803.259837008107;14897.404103835725;15172.620684482756;15238.161901095546;349295;352187;354243;354360;358386;48911.755441222565;49733.50266497289;49785.50214497808;49791.75104124456;49791.75104124528;1132.8640563132476;1203.6629743671785;1217.7625363054296;1281.730836524303;1287.4270949427414;24226.757732423157;25652.8717356412;26002.609960850223;26348.8682556586;26573;36237.63762362448;36648.63351366559;36788.816055919546;36840.44739328966;36898.63101368952;222446;223582;224534;224792;225084;21790.346289611338;24260.75739242585;25286.5863108478;25400.618990715524;25463;36048.81975590105;36067.27865442729;36286.63713362833;36804.631953680124;36965.260694785415;31574;33699.494507582895;34037.48943765796;34530;34971.551991360364;32866;33487;33646.495302569994;33836.81571145097;34119.31761364808;33413.16467088342;33471.49792753062;33724.25229256995;34019;34333.82833085819;29742.851285743433;30762.538561922036;30791.692083078884;31116;31129.221769455944;23701;24367.634485483086;24380.87809560941;24519.632205516577;24525.50948980975 04:36:52 INFO - PROCESS | 3470 | |2;jquery.html;380.9238152369526;385.7261344445442;386.5187841137784;399.2573812708362;405.1208876737479;15223.619409514768;16504.438444601645;16626;16650.333986640537;16652.417165399227;16105.677886442265;16350.918245408786;16798;16820;16915.915420422913;3706.314331848603;5178.818741344045;5362.892742145154;5365.275687782138;5365.865853353678;3928;5766.855828604276;6116.052011938156;6123.8162855114415;6128.601640893327;5980.162777211194;6056.394360563952;6058.818235452944;6061.787837425691;6075.301340345873;3572.3212589607892;5875.529957603403;5986.431289027535;6024.698765061729;6026.397360263961;4928.310036594879;5269.104252277122;5270.631055826094;5272.470983414805;5279.155335146358;18478.445646630622;18981.905090474596;18985.33551325711;18995.240190392367;19002.52493687669;2138.657814749648;2230.107956817286;2238.0264584905617;2407.9759202407927;2547.6305935639416;12136.332501712403;12397.318147501885;12484.937575312157;13175.604731857964;13640.294963129609;1771.4597047900386;1845.8246466585654;1847.7875044369935;1896.4026331705468;1900.0689662065627;61330.69334653343;64366.3563364365;71438.64280678616;74925.62537187334;84766.57616711939;8015.719449819228;8576.614052367659;8690.78273043179;9313.767155821024;9432.339736218537;12071.034317254775;12404.62786116418;12463.813042804366;12511.812322814983;12512.687182820502;6692.431143352869;6704.865902681919;6986.93013069873;7011.088558487364;7044.295570442915;6553.508486863504;6611.669416529155;6634.701438435282;6719.160104986877;6762.188537375547;3663.670269675742;3771.3777226757825;3776.8489260429824;3817.675497582681;3949.6445319921345;1750.7111326631218;1765.8145894681131;1770.5662112782193;1773.5211492896847;1802.3241284518306;826.7685048186518;874.4709450782185;888.7111688701069;939.6006697153682;939.7415710679618;15412.075275483507;16552.42066527666;16567.585810354838;17102.230399632048;17251.309947601956;875.671623141322;882.3162049411629;894.2577660541734;953.1802649721234;972.0910948263396;9307.488088155082;9460.337776355727;9515.666951656798;9536.713898583053;9664.806703865883;382282;383562;396723;398077;399327;80552.59723701462;81250.59374703089;81255;82336.58831705803;83880.58059709662;900.869373940788;923.0769230769231;932.9253659707207;938.9248860091176;953.3755390219418;14884.925575372054;14980.85019149838;15006.624834379229;15041.924790375979;15231.695366092394;26669.19992400231;29571.85214073916;32449.35101298008;33168.66831331656;34705;47476.762616188076;48688;48732;48732.269015965496;48819.26771098508;7763.650635721293;7836.412269079728;7916.920830791619;7980;7985.401094917788;8430.524658184915;10657.680269591925;11808.704782380166;11944.940275298568;11966.880331196577;10263.819660739111;10296.588136474757;10348.120409765253;10401.115905148146;10404.635837745642;9958.402495850272;10021.849672255068;10333.534990925576;10469.581216751245;10540.631077912236;10271.229657775548;10475;10514.78970420572;10578.15374770032;10597.311174773924;7613.314801667876;7752.961235193788;7790.61046947639;7818.491798033109;7936.6031698416;7960.402969777174;9198.26413886874;10319.400492923609;10370.533326000197;10383.844242336521 04:36:52 INFO - PROCESS | 3470 | |3;mootools.html;1282.5318758653082;1443.1846007006038;1464.0191071981774;1606.46183528518;1781.750554922311;6806.251312355643;7548.471606987513;7740.612969351524;7746.147923728399;7769.300762931328;7492.138404083532;7676.309132178103;7688.884666730003;7691.846163076749;7700.4224683148705;1874.184729642603;1932.7390802241657;1939.8448124150034;2196.253273886878;2232.073689418889;2134.7011418401435;2204.272590045281;2208.745994210662;2210.6794514795347;2211.148707747521;2132.8400369972237;2144.817690496302;2154.9030293636747;2155.8167555757777;2173.4566358410398;1860.7953125156223;2143.667731501612;2152.0638522242875;2152.365052309565;2159.0608085482863;2220.31170337196;2246.84272100953;2248.426651203949;2248.87631180285;2251.2233279518705;7490.3258706716115;7506.924930750677;7571.545707257582;7574.810629734246;7577.355924746404;4325;4442.2004039272915;4456;4487.663425243087;4488.506264310923;2870.7703383729254;2925.312551550384;3016.3816417634334;3017.7284044436105;3023.3953209358215;946.8106378724283;978.1196922769565;989.9059589339001;993.458565082032;1004.6333088422746;10004.899951000469;10079.143272821819;10086.646967356108;10093.142082922961;10096.848547271724;4103.302438585448;4143.834246630101;4266.274733295348;4270.551592082787;4316.482022157361;8711.782205444915;8713.782155446164;8715.564221789013;8726.69456569017;8728.345374096969;4567.223571992769;4589.2657174851865;4589.7705114744795;4594.5864872161665;4610.585047345755;3703.2408356286896;4100.200460910094;4108.239975604522;4113.341865301538;4206.85276015338;3661.359262129117;3678.834452449646;3781.9432708509394;3812.0850995760816;3812.5615554211067;1243.819646151303;1264.905132115095;1268.5560053981033;1288.935553222354;1296.7536168128026;871.8517851965181;880.7533890510667;880.8282384934876;881.5151666583354;888.2849306308484;5400.648957817729;5443.673379597237;5509.925564514881;5582.162675598693;5602.187682785973;409.26741133370933;423.5256512705789;436.9279068953587;438.0887753472769;440.2164147816891;3650.5619325681087;3735.8879233623034;3760.3231418344963;3778.981105094512;3828.444875493038;9201.355905086579;9539.713808585753;9567.952160239154;9676.758081047888;9689.563969621384;9424.858627120599;9571.569279382444;9578.47318397481;9584.66453674118;9610.759731006781;7270.600116993616;7374.852502949911;7389.261073892568;7396.112466504054;7453.329200371993;4965.230389289666;4981.37732783402;5116.897662046813;5130.461301563431;5149.6910185389;8687.348448866487;8759.605817738344;8778.078301778221;8798.648054077765;8910.821783564423;9048.728538143867;9166;9166.266698663958;9173.54132293396;9180.954095229481;6001.4298641628975;6622.205335359788;6896.241413444617;6897.689603967733;6982.406495447741;7126.109236345457;7150.928490715234;7169.4981351304905;7201.063861697946;7212.2427145149;6611.239707433707;6715.127033485615;6771.289014653587;6855.657217139223;6902.344277293649;6411.647359395091;6445.774397896051;6594.604323740591;6604.900926486011;6853.965730171517;6383.521235907233;6439;6452.645104519296;6460.870782584416;6463.224413070461;4796.3285140079715;4805.207140821725;4923.335349727741;4949.381327334083;4953;4814.711117332971;4843.782029808737;4862.149123903232;4864.343313652612;4956.529129732669 04:36:52 INFO - PROCESS | 3470 | |4;prototype.html;317.2829405543472;318.1997276848724;318.4331889237157;321.40379595849697;325.63366213010363;5071;5110.105731496987;5136.306598609187;5139.820106296281;5159.432462429129;5054.570361519275;5059.139946209144;5076.593872490201;5085.771140298686;5090.694558326503;3755.3428150073696;3835.2329534093155;3897.4153876918404;3956.6636835868985;3972.443857859902;3909.2181563687236;3957.4261732048835;3958.4759867451094;3979.9801000994953;3998.840046398155;3731.1231860512894;3952.901177470572;3969.7221194516396;3970.1464185200175;3974.5230572331216;3843.673287770543;3937.2125574884994;3952.5849785772366;3972.980135099335;3984.2230765000836;3520.1023738946406;3530.75284730069;3542.167590616203;3542.3446662367546;3552.662497062775;4903.338049363361;4910.926336104962;4919.458859525449;4922.876928076791;4941.827036053721;4241.766702831343;4446.5331140230455;4454.821807127711;4469.329600559942;4615.023309965054;5289.471052894718;5292.179712144623;5295.629305948585;5305.230741542493;5312.2828418163435;3747.2692824899154;3750.962490375116;3769.981150094232;3770.6606405423368;3781.735278530504;5299.867503312409;5556.777728890839;5615.101583746622;5627.212190293362;5631.2960879890015;3802.6957843372466;3806.1245913440066;3818.4845045918446;3829.2341531693774;3832.2143960488033;3869.5743468218475;3871.7483363581277;3877.7091718121255;3879.612038796154;3880.84476620932;4198.4961804583645;4451.265541185733;4451.844185453559;4471.35165401015;4474.373587697725;5338.786448542015;5345.4654534546235;5361.892762144736;5383.973080134574;5389.299391079213;1333.6799168199561;1360.7074478987065;1362.3733082782032;1369.9383527741275;1372.7185926885165;854.9145085491401;904.0688091266006;921.1341339141186;959.1751094059103;993.9055789699967;4650.581447669726;4707.905841883212;4709.835155769531;4715.198416269242;4718.740469274223;5482.643628164156;5490.423505531941;5498.560115190855;5501.092319767274;5501.422350653123;4530.592246697813;4670.509596492388;4682.484926658065;4708.976455117702;4760.595349395271;2935.66239882412;2954.301276765825;2962.7037296270632;2963.2443726849947;2965.4069186162424;5182.870428239249;5194.298769666047;5209.453007434241;5228.372595288513;5231.215317702375;5405.7837686492885;5582.24639673647;5585.245991791137;5632.633878797865;5670.319561652628;5211.869703257449;5220.738963051832;5222.738863056832;5230.320058392384;5262.289590905179;5531.834044978657;5546.389897111395;5547.833564992895;5548.472895074961;5569.749361278671;5196.220566914993;5481.369642491005;5483.424240454854;5490.478404551562;5500.312460942382;5213.165893457029;5231.633785634969;5232.979568984164;5235.319408476874;5239.266502689703;3841.9039524012123;3892.377219644843;3909.6285852843935;3916.5300163980505;3922.3332033553793;5276.630635855453;5524.33707955048;5571.498565129158;5599.860003499945;5601.6358936668985;5381.650192737459;5390.541803946709;5397.598068859477;5406.432324606017;5406.83779486616;5213.13983192769;5380.11228147367;5386.676799392049;5398.865028374165;5408.675479471244;5013.2981382607195;5299.33758280215;5311.44229855875;5320.255164276927;5335.226392173191;5142.6914385137015;5270.552003079782;5277.261183434245;5278;5300.920486192787;5188.431726295357;5228.137357335997;5230.7384630769075;5242.536008076198;5267.631265811357 04:36:52 INFO - PROCESS | 3470 | |5;yui.html;701.8070030741547;789.6891160673283;793.9801504962379;796.7012370361116;802.4342838298996;11060.391678457681;11108.555657773679;11129.054030407406;11134.276272042312;12016.399180040995;11283.153763467752;11349.262297950627;11371.829422558669;11412.54349826006;11438.771224575525;634.8984162533995;779.3142035009184;799.8600244957138;812.6668066092903;813.2436833744645;807.8142027333716;809.2029351089172;809.6761295481796;814.9511029338229;815.3151352863594;850.9659613615479;858.2876212743408;859.0979471554874;859.222403724627;859.922606965373;658.7826017414266;817.2767101115496;849.2484151525913;850.8213275212213;851.1828644501286;621.828997025817;625.5433533520555;625.9843503912393;626.3892704613012;626.4925410417576;11805.468753906009;11905.345206013666;11939.34333611651;11941.343226122559;11947.462364193632;12514.12401131912;13110.737785244337;13284.335783210801;13379.197248165141;13434.462621495128;9847.60609575616;10006.499675016294;10044.09603135714;10127.29108962373;10230.283880128394;4209.810558524874;4211.284081706117;4224.831006759726;4289.420928174719;4395.560443955611;46357.53642463566;48201.276980845316;48374;48377.27434088491;48520.51479485195;9801.411915285105;9825.606975720892;9975.102240798364;9995.350302230332;10112.544935477921;17222;17249.655006899793;17278;17288.827111728973;17312.48062558125;6740.831479213059;6750.3924646782025;6796.184457865088;6834.897476537856;6935.791926242221;3720.162963333228;3836.76979381238;3918.8824335269987;3935.9803200984384;4027.134166154291;2653.7744291735034;2748.4365705030423;2755.738204870534;2772.0297895736735;2772.6534183227095;436.6005105328589;512.1498312800733;513.6609837507227;520.6745783885071;523.1446584833748;559.4237934927031;565.005590161319;638.7285403703407;652.4833913318544;654.1332734127301;7917.643706033243;8001.639926203335;8013.158618345106;8043.638036288381;8247;598.8143675460622;604.9667268300286;607.8389226854887;628.9433950944436;637.5314144104079;3719.888403347904;3742.1018955450495;3811.961880381161;3837.808109594509;3870.322693528621;57953.4204657948;58700.4129958695;59243.40756592465;59960;60256.69871650614;51772.48227517752;51780.74109629503;52473;52532.737336313076;53807.73096134494;46766.76616616963;47328.763356183;47416.270573124115;47522.52477475181;48289.27566086512;7274.781756547312;7339.559626422431;7354.742584009534;7395.297446742551;7578.924210757822;29965.101046968626;30731.692683072884;31157;31637.20906977344;32119.357612848078;40608;42771.7861410691;42831.785841070596;43112;43564.56435435605;9662.855057174289;9725.610975560898;9785.119339259501;9891.060349266809;9935.105840474393;10210.438425886647;10437.530311136168;10565.683029509128;10865.837012444978;10965.50655220501;8453.746387608382;10099.343542669703;10519.94740026295;11108.611198608332;11262.774744505228;11021.393823339473;11088.833667495155;11150.442477876237;11375.374354410587;11677.299362038304;10993.560257589606;11054.778904421706;11153.888461115284;11469.483873225892;11673.182877198515;9236.676716314896;9353.158215760614;9741.366811157252;9903.108720215216;9930.751731206778;9510;9640.228781697588;9692.951535242279;9698.85451718239;9779.378568912649 04:36:52 INFO - PROCESS | 3470 | __end_tp_report 04:36:52 INFO - PROCESS | 3470 | __start_cc_report 04:36:52 INFO - PROCESS | 3470 | _x_x_mozilla_cycle_collect,1070 04:36:52 INFO - PROCESS | 3470 | __end_cc_report 04:36:52 INFO - PROCESS | 3470 | __startTimestamp1461152212751__endTimestamp 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | ------- Summary: start ------- 04:36:52 INFO - PROCESS | 3470 | Number of tests: 6 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#0] dojo.html Cycles:165 Average:4627.10 Median:4776.09 stddev:489.95 (10.3%) stddev-sans-first:464.55 04:36:52 INFO - PROCESS | 3470 | Values: 2585.8 2630.1 2633.8 2639.2 2654.4 4524.2 4622.2 4624.3 4626.9 4634.2 4693.2 4709.9 4710.7 4780.3 4800.1 4186.7 4187.9 4213.5 4218.3 4393.1 4325.4 4343.1 4351.3 4363.5 4391.6 4203.8 4216.8 4288.7 4289.0 4299.1 4221.6 4250.6 4251.9 4258.8 4313.3 4261.6 4283.7 4287.2 4319.9 4324.1 4443.0 4499.6 4558.6 4579.8 4635.7 4981.1 4996.4 4996.5 4999.2 5028.1 4995.9 5010.4 5022.1 5026.5 5044.4 4577.5 4688.9 4697.6 4787.8 4791.3 5156.0 5171.3 5178.1 5182.1 5184.7 4958.7 4959.7 4961.9 4963.8 5008.5 4896.9 4989.3 5021.2 5075.1 5076.6 4967.8 5017.6 5019.8 5027.3 5078.7 4843.7 4964.8 4982.7 4991.7 5035.4 4181.6 4219.2 4256.6 4278.9 4300.1 3658.1 3661.8 3663.5 3700.1 3700.9 4269.0 4340.3 4340.5 4350.5 4383.1 4990.8 5025.2 5027.3 5066.3 5073.2 4351.5 4382.9 4387.1 4388.9 4412.6 4413.3 4501.8 4522.8 4523.8 4539.7 4719.9 4720.1 4724.2 4764.0 4776.1 4975.1 4976.3 4979.0 4982.0 5026.7 4563.5 4689.2 4703.2 4747.9 4763.9 4916.9 4925.7 4931.1 4964.2 4977.3 4939.2 4984.9 4987.2 5008.9 5026.1 4751.8 4858.0 4887.4 4913.5 4974.3 4913.1 4926.6 4933.3 4936.6 4939.3 4859.7 4860.0 4869.1 4881.2 4916.7 4766.6 4810.4 4860.0 4893.6 4980.3 4793.5 4796.0 4805.4 4815.1 4857.9 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#1] ext.html Cycles:180 Average:41947.38 Median:19004.77 stddev:71101.74 (374.1%) stddev-sans-first:71233.36 04:36:52 INFO - PROCESS | 3470 | Values: 582.4 605.6 620.4 621.9 629.4 26431.3 33019.2 33757.3 33770.8 33804.0 36178.8 36637.8 36724.3 36866.8 36883.4 7162.1 7496.2 7682.9 9336.5 9561.7 9441.0 9498.4 9561.8 9581.2 9586.8 9589.0 9674.9 9676.4 9678.1 9679.9 9556.3 9632.0 9634.4 9635.6 9643.8 9525.9 9643.5 9647.2 9942.7 9970.3 36507.8 36900.6 37039.8 37089.8 37124.3 3238.8 3267.3 3281.4 3668.2 3900.2 29171.7 29219.4 29447.1 29694.7 29938.7 3479.5 3489.8 3499.1 3513.9 3520.5 211923.0 212309.0 213435.0 213962.0 214076.0 49718.5 50197.2 50490.7 50507.2 50519.5 53794.7 54051.2 54239.2 54309.5 54348.7 13985.7 14380.3 14400.8 14423.2 14431.2 11003.1 11041.6 11056.0 11061.4 11099.2 17718.4 17864.7 17872.5 17989.6 18008.7 6777.3 7133.3 7166.2 7168.2 7174.6 832.9 873.0 992.4 993.2 1001.9 26725.9 27452.3 27862.9 27878.3 28212.4 974.1 991.9 1019.6 1066.3 1071.3 14260.2 14803.3 14897.4 15172.6 15238.2 349295.0 352187.0 354243.0 354360.0 358386.0 48911.8 49733.5 49785.5 49791.8 49791.8 1132.9 1203.7 1217.8 1281.7 1287.4 24226.8 25652.9 26002.6 26348.9 26573.0 36237.6 36648.6 36788.8 36840.4 36898.6 222446.0 223582.0 224534.0 224792.0 225084.0 21790.3 24260.8 25286.6 25400.6 25463.0 36048.8 36067.3 36286.6 36804.6 36965.3 31574.0 33699.5 34037.5 34530.0 34971.6 32866.0 33487.0 33646.5 33836.8 34119.3 33413.2 33471.5 33724.3 34019.0 34333.8 29742.9 30762.5 30791.7 31116.0 31129.2 23701.0 24367.6 24380.9 24519.6 24525.5 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#2] jquery.html Cycles:180 Average:24251.40 Median:199238.13 stddev:64851.72 (32.5%) stddev-sans-first:65008.87 04:36:52 INFO - PROCESS | 3470 | Values: 380.9 385.7 386.5 399.3 405.1 15223.6 16504.4 16626.0 16650.3 16652.4 16105.7 16350.9 16798.0 16820.0 16915.9 3706.3 5178.8 5362.9 5365.3 5365.9 3928.0 5766.9 6116.1 6123.8 6128.6 5980.2 6056.4 6058.8 6061.8 6075.3 3572.3 5875.5 5986.4 6024.7 6026.4 4928.3 5269.1 5270.6 5272.5 5279.2 18478.4 18981.9 18985.3 18995.2 19002.5 2138.7 2230.1 2238.0 2408.0 2547.6 12136.3 12397.3 12484.9 13175.6 13640.3 1771.5 1845.8 1847.8 1896.4 1900.1 61330.7 64366.4 71438.6 74925.6 84766.6 8015.7 8576.6 8690.8 9313.8 9432.3 12071.0 12404.6 12463.8 12511.8 12512.7 6692.4 6704.9 6986.9 7011.1 7044.3 6553.5 6611.7 6634.7 6719.2 6762.2 3663.7 3771.4 3776.8 3817.7 3949.6 1750.7 1765.8 1770.6 1773.5 1802.3 826.8 874.5 888.7 939.6 939.7 15412.1 16552.4 16567.6 17102.2 17251.3 875.7 882.3 894.3 953.2 972.1 9307.5 9460.3 9515.7 9536.7 9664.8 382282.0 383562.0 396723.0 398077.0 399327.0 80552.6 81250.6 81255.0 82336.6 83880.6 900.9 923.1 932.9 938.9 953.4 14884.9 14980.9 15006.6 15041.9 15231.7 26669.2 29571.9 32449.4 33168.7 34705.0 47476.8 48688.0 48732.0 48732.3 48819.3 7763.7 7836.4 7916.9 7980.0 7985.4 8430.5 10657.7 11808.7 11944.9 11966.9 10263.8 10296.6 10348.1 10401.1 10404.6 9958.4 10021.8 10333.5 10469.6 10540.6 10271.2 10475.0 10514.8 10578.2 10597.3 7613.3 7753.0 7790.6 7818.5 7936.6 7960.4 9198.3 10319.4 10370.5 10383.8 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#3] mootools.html Cycles:180 Average:5095.82 Median:4960.88 stddev:2815.15 (56.7%) stddev-sans-first:2808.46 04:36:52 INFO - PROCESS | 3470 | Values: 1282.5 1443.2 1464.0 1606.5 1781.8 6806.3 7548.5 7740.6 7746.1 7769.3 7492.1 7676.3 7688.9 7691.8 7700.4 1874.2 1932.7 1939.8 2196.3 2232.1 2134.7 2204.3 2208.7 2210.7 2211.1 2132.8 2144.8 2154.9 2155.8 2173.5 1860.8 2143.7 2152.1 2152.4 2159.1 2220.3 2246.8 2248.4 2248.9 2251.2 7490.3 7506.9 7571.5 7574.8 7577.4 4325.0 4442.2 4456.0 4487.7 4488.5 2870.8 2925.3 3016.4 3017.7 3023.4 946.8 978.1 989.9 993.5 1004.6 10004.9 10079.1 10086.6 10093.1 10096.8 4103.3 4143.8 4266.3 4270.6 4316.5 8711.8 8713.8 8715.6 8726.7 8728.3 4567.2 4589.3 4589.8 4594.6 4610.6 3703.2 4100.2 4108.2 4113.3 4206.9 3661.4 3678.8 3781.9 3812.1 3812.6 1243.8 1264.9 1268.6 1288.9 1296.8 871.9 880.8 880.8 881.5 888.3 5400.6 5443.7 5509.9 5582.2 5602.2 409.3 423.5 436.9 438.1 440.2 3650.6 3735.9 3760.3 3779.0 3828.4 9201.4 9539.7 9568.0 9676.8 9689.6 9424.9 9571.6 9578.5 9584.7 9610.8 7270.6 7374.9 7389.3 7396.1 7453.3 4965.2 4981.4 5116.9 5130.5 5149.7 8687.3 8759.6 8778.1 8798.6 8910.8 9048.7 9166.0 9166.3 9173.5 9181.0 6001.4 6622.2 6896.2 6897.7 6982.4 7126.1 7150.9 7169.5 7201.1 7212.2 6611.2 6715.1 6771.3 6855.7 6902.3 6411.6 6445.8 6594.6 6604.9 6854.0 6383.5 6439.0 6452.6 6460.9 6463.2 4796.3 4805.2 4923.3 4949.4 4953.0 4814.7 4843.8 4862.1 4864.3 4956.5 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#4] prototype.html Cycles:180 Average:4428.81 Median:5088.23 stddev:1292.67 (25.4%) stddev-sans-first:1258.93 04:36:52 INFO - PROCESS | 3470 | Values: 317.3 318.2 318.4 321.4 325.6 5071.0 5110.1 5136.3 5139.8 5159.4 5054.6 5059.1 5076.6 5085.8 5090.7 3755.3 3835.2 3897.4 3956.7 3972.4 3909.2 3957.4 3958.5 3980.0 3998.8 3731.1 3952.9 3969.7 3970.1 3974.5 3843.7 3937.2 3952.6 3973.0 3984.2 3520.1 3530.8 3542.2 3542.3 3552.7 4903.3 4910.9 4919.5 4922.9 4941.8 4241.8 4446.5 4454.8 4469.3 4615.0 5289.5 5292.2 5295.6 5305.2 5312.3 3747.3 3751.0 3770.0 3770.7 3781.7 5299.9 5556.8 5615.1 5627.2 5631.3 3802.7 3806.1 3818.5 3829.2 3832.2 3869.6 3871.7 3877.7 3879.6 3880.8 4198.5 4451.3 4451.8 4471.4 4474.4 5338.8 5345.5 5361.9 5384.0 5389.3 1333.7 1360.7 1362.4 1369.9 1372.7 854.9 904.1 921.1 959.2 993.9 4650.6 4707.9 4709.8 4715.2 4718.7 5482.6 5490.4 5498.6 5501.1 5501.4 4530.6 4670.5 4682.5 4709.0 4760.6 2935.7 2954.3 2962.7 2963.2 2965.4 5182.9 5194.3 5209.5 5228.4 5231.2 5405.8 5582.2 5585.2 5632.6 5670.3 5211.9 5220.7 5222.7 5230.3 5262.3 5531.8 5546.4 5547.8 5548.5 5569.7 5196.2 5481.4 5483.4 5490.5 5500.3 5213.2 5231.6 5233.0 5235.3 5239.3 3841.9 3892.4 3909.6 3916.5 3922.3 5276.6 5524.3 5571.5 5599.9 5601.6 5381.7 5390.5 5397.6 5406.4 5406.8 5213.1 5380.1 5386.7 5398.9 5408.7 5013.3 5299.3 5311.4 5320.3 5335.2 5142.7 5270.6 5277.3 5278.0 5300.9 5188.4 5228.1 5230.7 5242.5 5267.6 04:36:52 INFO - PROCESS | 3470 | 04:36:52 INFO - PROCESS | 3470 | [#5] yui.html Cycles:180 Average:13378.92 Median:512.91 stddev:16036.77 (3126.7%) stddev-sans-first:16053.50 04:36:52 INFO - PROCESS | 3470 | Values: 701.8 789.7 794.0 796.7 802.4 11060.4 11108.6 11129.1 11134.3 12016.4 11283.2 11349.3 11371.8 11412.5 11438.8 634.9 779.3 799.9 812.7 813.2 807.8 809.2 809.7 815.0 815.3 851.0 858.3 859.1 859.2 859.9 658.8 817.3 849.2 850.8 851.2 621.8 625.5 626.0 626.4 626.5 11805.5 11905.3 11939.3 11941.3 11947.5 12514.1 13110.7 13284.3 13379.2 13434.5 9847.6 10006.5 10044.1 10127.3 10230.3 4209.8 4211.3 4224.8 4289.4 4395.6 46357.5 48201.3 48374.0 48377.3 48520.5 9801.4 9825.6 9975.1 9995.4 10112.5 17222.0 17249.7 17278.0 17288.8 17312.5 6740.8 6750.4 6796.2 6834.9 6935.8 3720.2 3836.8 3918.9 3936.0 4027.1 2653.8 2748.4 2755.7 2772.0 2772.7 436.6 512.1 513.7 520.7 523.1 559.4 565.0 638.7 652.5 654.1 7917.6 8001.6 8013.2 8043.6 8247.0 598.8 605.0 607.8 628.9 637.5 3719.9 3742.1 3812.0 3837.8 3870.3 57953.4 58700.4 59243.4 59960.0 60256.7 51772.5 51780.7 52473.0 52532.7 53807.7 46766.8 47328.8 47416.3 47522.5 48289.3 7274.8 7339.6 7354.7 7395.3 7578.9 29965.1 30731.7 31157.0 31637.2 32119.4 40608.0 42771.8 42831.8 43112.0 43564.6 9662.9 9725.6 9785.1 9891.1 9935.1 10210.4 10437.5 10565.7 10865.8 10965.5 8453.7 10099.3 10519.9 11108.6 11262.8 11021.4 11088.8 11150.4 11375.4 11677.3 10993.6 11054.8 11153.9 11469.5 11673.2 9236.7 9353.2 9741.4 9903.1 9930.8 9510.0 9640.2 9693.0 9698.9 9779.4 04:36:52 INFO - PROCESS | 3470 | -------- Summary: end -------- 04:36:52 INFO - PROCESS | 3470 | 04:36:53 INFO - TEST-INFO | 3470: exit 0 04:36:53 INFO - TEST-OK | dromaeo_css | took 1118549ms 04:36:53 INFO - TEST-START | kraken 04:36:53 INFO - operating with platform_type : linux_ 04:36:53 INFO - Initialising browser for kraken test... 04:36:53 INFO - TEST-INFO | started process 3644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iLdco/profile http://localhost:53341/getInfo.html) 04:36:57 INFO - PROCESS | 3644 | __metrics Screen width/height:1600/1200 04:36:57 INFO - PROCESS | 3644 | colorDepth:24 04:36:57 INFO - PROCESS | 3644 | Browser inner width/height: 1024/697 04:36:57 INFO - PROCESS | 3644 | __metrics 04:36:59 ERROR - PROCESS | 3644 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:36:59 INFO - TEST-INFO | 3644: exit 0 04:36:59 INFO - Browser initialized. 04:36:59 INFO - Running cycle 1/1 for kraken test... 04:36:59 INFO - TEST-INFO | started process 3726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1iLdco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:11 INFO - PROCESS | 3726 | RSS: Main: 154910720 04:37:11 INFO - PROCESS | 3726 | 04:37:14 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:15 INFO - PROCESS | 3726 | RSS: Main: 209526784 04:37:15 INFO - PROCESS | 3726 | 04:37:18 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-dft) 04:37:18 INFO - PROCESS | 3726 | RSS: Main: 194936832 04:37:18 INFO - PROCESS | 3726 | 04:37:22 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-fft) 04:37:22 INFO - PROCESS | 3726 | RSS: Main: 265977856 04:37:22 INFO - PROCESS | 3726 | 04:37:24 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53341/tests/kraken/driver.html?testName=audio-oscillator) 04:37:25 INFO - PROCESS | 3726 | RSS: Main: 174166016 04:37:25 INFO - PROCESS | 3726 | 04:37:27 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:28 INFO - PROCESS | 3726 | RSS: Main: 178352128 04:37:28 INFO - PROCESS | 3726 | 04:37:31 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:32 INFO - PROCESS | 3726 | RSS: Main: 214659072 04:37:32 INFO - PROCESS | 3726 | 04:37:35 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53341/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:36 INFO - PROCESS | 3726 | RSS: Main: 215515136 04:37:36 INFO - PROCESS | 3726 | 04:37:38 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53341/tests/kraken/driver.html?testName=json-parse-financial) 04:37:39 INFO - PROCESS | 3726 | RSS: Main: 215224320 04:37:39 INFO - PROCESS | 3726 | 04:37:41 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:41 INFO - PROCESS | 3726 | RSS: Main: 202727424 04:37:41 INFO - PROCESS | 3726 | 04:37:43 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:44 INFO - PROCESS | 3726 | RSS: Main: 205557760 04:37:44 INFO - PROCESS | 3726 | 04:37:46 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:47 INFO - PROCESS | 3726 | RSS: Main: 219250688 04:37:47 INFO - PROCESS | 3726 | 04:37:49 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:50 INFO - PROCESS | 3726 | RSS: Main: 225095680 04:37:50 INFO - PROCESS | 3726 | 04:37:53 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:54 INFO - PROCESS | 3726 | RSS: Main: 219594752 04:37:54 INFO - PROCESS | 3726 | 04:37:55 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:53341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53341/tests/kraken/driver.html?testName=ai-astar) 04:37:56 INFO - PROCESS | 3726 | RSS: Main: 282849280 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | __start_tp_report 04:37:56 INFO - PROCESS | 3726 | _x_x_mozilla_page_load 04:37:56 INFO - PROCESS | 3726 | _x_x_mozilla_page_load_details 04:37:56 INFO - PROCESS | 3726 | |i|pagename|runs| 04:37:56 INFO - PROCESS | 3726 | |0;ai-astar;113;114;107;111;114;116;102;112;115;113 04:37:56 INFO - PROCESS | 3726 | |1;audio-beat-detection;169;131;154;181;142;157;164;133;185;140 04:37:56 INFO - PROCESS | 3726 | |2;audio-dft;162;160;162;161;163;162;162;161;161;162 04:37:56 INFO - PROCESS | 3726 | |3;audio-fft;74;74;105;104;75;74;73;129;101;74 04:37:56 INFO - PROCESS | 3726 | |4;audio-oscillator;94;94;148;94;96;94;149;94;94;154 04:37:56 INFO - PROCESS | 3726 | |5;imaging-gaussian-blur;117;117;116;117;118;117;116;116;117;117 04:37:56 INFO - PROCESS | 3726 | |6;imaging-darkroom;146;145;146;146;147;145;145;145;145;145 04:37:56 INFO - PROCESS | 3726 | |7;imaging-desaturate;94;94;94;94;95;95;94;94;95;94 04:37:56 INFO - PROCESS | 3726 | |8;json-parse-financial;63;70;64;64;64;64;64;87;69;61 04:37:56 INFO - PROCESS | 3726 | |9;json-stringify-tinderbox;65;66;65;66;65;65;65;65;66;66 04:37:56 INFO - PROCESS | 3726 | |10;stanford-crypto-aes;78;79;78;78;80;79;79;86;80;79 04:37:56 INFO - PROCESS | 3726 | |11;stanford-crypto-ccm;136;140;143;134;143;130;130;134;173;136 04:37:56 INFO - PROCESS | 3726 | |12;stanford-crypto-pbkdf2;179;170;169;175;175;181;169;174;172;173 04:37:56 INFO - PROCESS | 3726 | |13;stanford-crypto-sha256-iterative;70;71;71;78;70;71;71;70;72;73 04:37:56 INFO - PROCESS | 3726 | __end_tp_report 04:37:56 INFO - PROCESS | 3726 | __start_cc_report 04:37:56 INFO - PROCESS | 3726 | _x_x_mozilla_cycle_collect,1881 04:37:56 INFO - PROCESS | 3726 | __end_cc_report 04:37:56 INFO - PROCESS | 3726 | __startTimestamp1461152276182__endTimestamp 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | ------- Summary: start ------- 04:37:56 INFO - PROCESS | 3726 | Number of tests: 14 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:4.22 (3.7%) stddev-sans-first:4.45 04:37:56 INFO - PROCESS | 3726 | Values: 113.0 114.0 107.0 111.0 114.0 116.0 102.0 112.0 115.0 113.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:160.50 stddev:19.17 (11.9%) stddev-sans-first:19.71 04:37:56 INFO - PROCESS | 3726 | Values: 169.0 131.0 154.0 181.0 142.0 157.0 164.0 133.0 185.0 140.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 04:37:56 INFO - PROCESS | 3726 | Values: 162.0 160.0 162.0 161.0 163.0 162.0 162.0 161.0 161.0 162.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#3] audio-fft Cycles:10 Average:88.30 Median:74.00 stddev:19.92 (26.9%) stddev-sans-first:20.45 04:37:56 INFO - PROCESS | 3726 | Values: 74.0 74.0 105.0 104.0 75.0 74.0 73.0 129.0 101.0 74.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:94.00 stddev:27.12 (28.9%) stddev-sans-first:28.05 04:37:56 INFO - PROCESS | 3726 | Values: 94.0 94.0 148.0 94.0 96.0 94.0 149.0 94.0 94.0 154.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:37:56 INFO - PROCESS | 3726 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 116.0 116.0 117.0 117.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:37:56 INFO - PROCESS | 3726 | Values: 146.0 145.0 146.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:37:56 INFO - PROCESS | 3726 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:64.00 stddev:7.53 (11.8%) stddev-sans-first:7.84 04:37:56 INFO - PROCESS | 3726 | Values: 63.0 70.0 64.0 64.0 64.0 64.0 64.0 87.0 69.0 61.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:37:56 INFO - PROCESS | 3726 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.37 (3.0%) stddev-sans-first:2.44 04:37:56 INFO - PROCESS | 3726 | Values: 78.0 79.0 78.0 78.0 80.0 79.0 79.0 86.0 80.0 79.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:138.00 stddev:12.52 (9.1%) stddev-sans-first:13.20 04:37:56 INFO - PROCESS | 3726 | Values: 136.0 140.0 143.0 134.0 143.0 130.0 130.0 134.0 173.0 136.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.50 stddev:4.03 (2.3%) stddev-sans-first:3.79 04:37:56 INFO - PROCESS | 3726 | Values: 179.0 170.0 169.0 175.0 175.0 181.0 169.0 174.0 172.0 173.0 04:37:56 INFO - PROCESS | 3726 | 04:37:56 INFO - PROCESS | 3726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:71.00 stddev:2.41 (3.4%) stddev-sans-first:2.47 04:37:56 INFO - PROCESS | 3726 | Values: 70.0 71.0 71.0 78.0 70.0 71.0 71.0 70.0 72.0 73.0 04:37:56 INFO - PROCESS | 3726 | -------- Summary: end -------- 04:37:56 INFO - PROCESS | 3726 | 04:37:57 INFO - TEST-INFO | 3726: exit 0 04:37:57 INFO - TEST-OK | kraken | took 63669ms 04:37:57 INFO - SUITE-END | took 1182s 04:37:57 INFO - Completed test suite (00:19:42) 04:37:57 INFO - javascript benchmark 04:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.806064545159, 2630.053180854893, 2633.8156329056974, 2639.1950455111196, 2654.4292977009945, 4524.163029839474, 4622.214223581991, 4624.306354046895, 4626.861194164177, 4634.235351167062, 4693.225617773063, 4709.929351059737, 4710.670253082277, 4780.30685550595, 4800.135975524404, 4186.748795072298, 4187.853425130121, 4213.47331583552, 4218.346156345771, 4393.07745373472, 4325.372820940962, 4343.066240758237, 4351.347297905324, 4363.476382834065, 4391.626711729491, 4203.831846726142, 4216.810243539048, 4288.69979101463, 4288.957110428887, 4299.054208074219, 4221.577842215785, 4250.617444429985, 4251.893702657428, 4258.787060646955, 4313.266744653416, 4261.595148460922, 4283.721558098714, 4287.164003019412, 4319.935200971988, 4324.113556720865, 4443.0, 4499.595036446703, 4558.635309175291, 4579.793909274091, 4635.6986795858165, 4981.053599816023, 4996.400431948153, 4996.475370086161, 4999.225120106353, 5028.120078986163, 4995.925061124086, 5010.398752149766, 5022.096022715909, 5026.52248036436, 5044.445111037783, 4577.542245775429, 4688.859334219979, 4697.553732395417, 4787.760611969387, 4791.257355109894, 5155.97422012895, 5171.32772739549, 5178.145605975047, 5182.067227899014, 5184.714840683799, 4958.702477851269, 4959.652824302337, 4961.8511444656715, 4963.826266080742, 5008.549230569266, 4896.926546101811, 4989.301497790239, 5021.221710634857, 5075.111855425286, 5076.568491678175, 4967.776450059756, 5017.648764586444, 5019.799208031638, 5027.296178534935, 5078.720670363092, 4843.660943733905, 4964.801407943714, 4982.701037937735, 4991.675541089818, 5035.395752509722, 4181.623653871166, 4219.198352313051, 4256.638185754184, 4278.935815962763, 4300.09697963425, 3658.140337020798, 3661.835217415223, 3663.4504824276573, 3700.0749812546865, 3700.8519659213866, 4268.9786551067045, 4340.262155433584, 4340.544242854518, 4350.521442641307, 4383.101464199832, 4990.775415106329, 5025.221090730943, 5027.3464449621315, 5066.265391518209, 5073.213651883964, 4351.521332653406, 4382.8904277392685, 4387.144506821203, 4388.934165987513, 4412.646988240933, 4413.293872980308, 4501.7524036177665, 4522.841700540465, 4523.84166554169, 4539.682222244412, 4719.858404247878, 4720.055988802184, 4724.196886529367, 4764.0471905619015, 4776.09254241693, 4975.0547395994645, 4976.278439626161, 4979.029089327546, 4981.950180498148, 5026.74866256693, 4563.49801521839, 4689.2497200449125, 4703.247480403119, 4747.905041899074, 4763.857084287477, 4916.92624610624, 4925.655204135819, 4931.087748766489, 4964.156093464192, 4977.253411988231, 4939.209726443895, 4984.925226121683, 4987.226979818134, 5008.899822003466, 5026.070177017264, 4751.83368582098, 4857.975710121426, 4887.43794463627, 4913.459519452786, 4974.32846565709, 4913.091078150411, 4926.630502712383, 4933.260010998379, 4936.580390666833, 4939.259111133215, 4859.684120532295, 4859.95140048595, 4869.147899117711, 4881.194602890483, 4916.70499770015, 4766.594839438548, 4810.42274926997, 4859.951400486091, 4893.632977526771, 4980.27785971025, 4793.472718000948, 4796.0, 4805.351277577623, 4815.133276010211, 4857.931255123867], "value": 4595.6791684027785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.4321286745421, 605.6456972670987, 620.3889169168367, 621.8694074244409, 629.4303655192052, 26431.3392165196, 33019.17452063697, 33757.32485350291, 33770.83114584423, 33804.0, 36178.81910590443, 36637.81681091591, 36724.26551468969, 36866.81566592163, 36883.4467482988, 7162.0689310389835, 7496.175420703718, 7682.884756728654, 9336.486493242868, 9561.713148605553, 9441.0, 9498.382605130644, 9561.760955976086, 9581.233501319912, 9586.808263834719, 9589.041095890425, 9674.90325096747, 9676.371035882681, 9678.128968392879, 9679.90320096797, 9556.331056826026, 9631.951840240825, 9634.373765705206, 9635.56639951204, 9643.807123857554, 9525.904740952572, 9643.517824108767, 9647.179989700884, 9942.652007179713, 9970.255205339037, 36507.81746091279, 36900.630993689985, 37039.81480092609, 37089.814550927345, 37124.25751484982, 3238.8056716596843, 3267.2975310308398, 3281.392942305681, 3668.211334563082, 3900.180961997984, 29171.708282917112, 29219.41561168786, 29447.085939414083, 29694.703052969628, 29938.700612994027, 3479.530263414432, 3489.755717099804, 3499.125218695326, 3513.877014304487, 3520.4719292106133, 211923.0, 212309.0, 213435.0, 213961.99999999846, 214076.0, 49718.50281497211, 50197.24704129441, 50490.747546262035, 50507.24239136416, 50519.49480505148, 53794.7310263454, 54051.18923216155, 54239.186412203846, 54309.45690543123, 54348.72825635847, 13985.65035874091, 14380.280985950661, 14400.783988240184, 14423.206723630092, 14431.20628365429, 11003.119750419946, 11041.613543525938, 11056.0, 11061.446927653746, 11099.223054386277, 17718.379856704953, 17864.732029019575, 17872.463826085237, 17989.640207195782, 18008.729869051975, 6777.2545020047755, 7133.286671332929, 7166.211716711157, 7168.211496735355, 7174.569525828467, 832.908380078203, 872.991270087291, 992.4243938515643, 993.1855878179823, 1001.8547310639916, 26725.866370668024, 27452.313692157455, 27862.860685696443, 27878.303042423697, 28212.43575128527, 974.1281553010158, 991.9057689519484, 1019.556492925565, 1066.2642776484201, 1071.3357718214756, 14260.215688137045, 14803.259837008107, 14897.404103835725, 15172.620684482756, 15238.161901095546, 349295.0, 352187.0, 354243.0, 354360.0, 358386.0, 48911.755441222565, 49733.50266497289, 49785.50214497808, 49791.75104124456, 49791.75104124528, 1132.8640563132476, 1203.6629743671785, 1217.7625363054296, 1281.730836524303, 1287.4270949427414, 24226.757732423157, 25652.8717356412, 26002.609960850223, 26348.8682556586, 26573.0, 36237.63762362448, 36648.63351366559, 36788.816055919546, 36840.44739328966, 36898.63101368952, 222446.0, 223582.0, 224534.0, 224792.0, 225084.0, 21790.346289611338, 24260.75739242585, 25286.5863108478, 25400.618990715524, 25463.0, 36048.81975590105, 36067.27865442729, 36286.63713362833, 36804.631953680124, 36965.260694785415, 31574.0, 33699.494507582895, 34037.48943765796, 34530.0, 34971.551991360364, 32866.0, 33487.0, 33646.495302569994, 33836.81571145097, 34119.31761364808, 33413.16467088342, 33471.49792753062, 33724.25229256995, 34019.0, 34333.82833085819, 29742.851285743433, 30762.538561922036, 30791.692083078884, 31116.0, 31129.221769455944, 23701.0, 24367.634485483086, 24380.87809560941, 24519.632205516577, 24525.50948980975], "value": 17290.82601523013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.9238152369526, 385.7261344445442, 386.5187841137784, 399.2573812708362, 405.1208876737479, 15223.619409514768, 16504.438444601645, 16626.0, 16650.333986640537, 16652.417165399227, 16105.677886442265, 16350.918245408786, 16798.0, 16820.0, 16915.915420422913, 3706.314331848603, 5178.818741344045, 5362.892742145154, 5365.275687782138, 5365.865853353678, 3928.0, 5766.855828604276, 6116.052011938156, 6123.8162855114415, 6128.601640893327, 5980.162777211194, 6056.394360563952, 6058.818235452944, 6061.787837425691, 6075.301340345873, 3572.3212589607892, 5875.529957603403, 5986.431289027535, 6024.698765061729, 6026.397360263961, 4928.310036594879, 5269.104252277122, 5270.631055826094, 5272.470983414805, 5279.155335146358, 18478.445646630622, 18981.905090474596, 18985.33551325711, 18995.240190392367, 19002.52493687669, 2138.657814749648, 2230.107956817286, 2238.0264584905617, 2407.9759202407927, 2547.6305935639416, 12136.332501712403, 12397.318147501885, 12484.937575312157, 13175.604731857964, 13640.294963129609, 1771.4597047900386, 1845.8246466585654, 1847.7875044369935, 1896.4026331705468, 1900.0689662065627, 61330.69334653343, 64366.3563364365, 71438.64280678616, 74925.62537187334, 84766.57616711939, 8015.719449819228, 8576.614052367659, 8690.78273043179, 9313.767155821024, 9432.339736218537, 12071.034317254775, 12404.62786116418, 12463.813042804366, 12511.812322814983, 12512.687182820502, 6692.431143352869, 6704.865902681919, 6986.93013069873, 7011.088558487364, 7044.295570442915, 6553.508486863504, 6611.669416529155, 6634.701438435282, 6719.160104986877, 6762.188537375547, 3663.670269675742, 3771.3777226757825, 3776.8489260429824, 3817.675497582681, 3949.6445319921345, 1750.7111326631218, 1765.8145894681131, 1770.5662112782193, 1773.5211492896847, 1802.3241284518306, 826.7685048186518, 874.4709450782185, 888.7111688701069, 939.6006697153682, 939.7415710679618, 15412.075275483507, 16552.42066527666, 16567.585810354838, 17102.230399632048, 17251.309947601956, 875.671623141322, 882.3162049411629, 894.2577660541734, 953.1802649721234, 972.0910948263396, 9307.488088155082, 9460.337776355727, 9515.666951656798, 9536.713898583053, 9664.806703865883, 382282.0, 383562.0, 396723.0, 398077.0, 399327.0, 80552.59723701462, 81250.59374703089, 81255.0, 82336.58831705803, 83880.58059709662, 900.869373940788, 923.0769230769231, 932.9253659707207, 938.9248860091176, 953.3755390219418, 14884.925575372054, 14980.85019149838, 15006.624834379229, 15041.924790375979, 15231.695366092394, 26669.19992400231, 29571.85214073916, 32449.35101298008, 33168.66831331656, 34705.0, 47476.762616188076, 48688.0, 48732.0, 48732.269015965496, 48819.26771098508, 7763.650635721293, 7836.412269079728, 7916.920830791619, 7980.0, 7985.401094917788, 8430.524658184915, 10657.680269591925, 11808.704782380166, 11944.940275298568, 11966.880331196577, 10263.819660739111, 10296.588136474757, 10348.120409765253, 10401.115905148146, 10404.635837745642, 9958.402495850272, 10021.849672255068, 10333.534990925576, 10469.581216751245, 10540.631077912236, 10271.229657775548, 10475.0, 10514.78970420572, 10578.15374770032, 10597.311174773924, 7613.314801667876, 7752.961235193788, 7790.61046947639, 7818.491798033109, 7936.6031698416, 7960.402969777174, 9198.26413886874, 10319.400492923609, 10370.533326000197, 10383.844242336521], "value": 8207.404670899356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.5318758653082, 1443.1846007006038, 1464.0191071981774, 1606.46183528518, 1781.750554922311, 6806.251312355643, 7548.471606987513, 7740.612969351524, 7746.147923728399, 7769.300762931328, 7492.138404083532, 7676.309132178103, 7688.884666730003, 7691.846163076749, 7700.4224683148705, 1874.184729642603, 1932.7390802241657, 1939.8448124150034, 2196.253273886878, 2232.073689418889, 2134.7011418401435, 2204.272590045281, 2208.745994210662, 2210.6794514795347, 2211.148707747521, 2132.8400369972237, 2144.817690496302, 2154.9030293636747, 2155.8167555757777, 2173.4566358410398, 1860.7953125156223, 2143.667731501612, 2152.0638522242875, 2152.365052309565, 2159.0608085482863, 2220.31170337196, 2246.84272100953, 2248.426651203949, 2248.87631180285, 2251.2233279518705, 7490.3258706716115, 7506.924930750677, 7571.545707257582, 7574.810629734246, 7577.355924746404, 4325.0, 4442.2004039272915, 4456.0, 4487.663425243087, 4488.506264310923, 2870.7703383729254, 2925.312551550384, 3016.3816417634334, 3017.7284044436105, 3023.3953209358215, 946.8106378724283, 978.1196922769565, 989.9059589339001, 993.458565082032, 1004.6333088422746, 10004.899951000469, 10079.143272821819, 10086.646967356108, 10093.142082922961, 10096.848547271724, 4103.302438585448, 4143.834246630101, 4266.274733295348, 4270.551592082787, 4316.482022157361, 8711.782205444915, 8713.782155446164, 8715.564221789013, 8726.69456569017, 8728.345374096969, 4567.223571992769, 4589.2657174851865, 4589.7705114744795, 4594.5864872161665, 4610.585047345755, 3703.2408356286896, 4100.200460910094, 4108.239975604522, 4113.341865301538, 4206.85276015338, 3661.359262129117, 3678.834452449646, 3781.9432708509394, 3812.0850995760816, 3812.5615554211067, 1243.819646151303, 1264.905132115095, 1268.5560053981033, 1288.935553222354, 1296.7536168128026, 871.8517851965181, 880.7533890510667, 880.8282384934876, 881.5151666583354, 888.2849306308484, 5400.648957817729, 5443.673379597237, 5509.925564514881, 5582.162675598693, 5602.187682785973, 409.26741133370933, 423.5256512705789, 436.9279068953587, 438.0887753472769, 440.2164147816891, 3650.5619325681087, 3735.8879233623034, 3760.3231418344963, 3778.981105094512, 3828.444875493038, 9201.355905086579, 9539.713808585753, 9567.952160239154, 9676.758081047888, 9689.563969621384, 9424.858627120599, 9571.569279382444, 9578.47318397481, 9584.66453674118, 9610.759731006781, 7270.600116993616, 7374.852502949911, 7389.261073892568, 7396.112466504054, 7453.329200371993, 4965.230389289666, 4981.37732783402, 5116.897662046813, 5130.461301563431, 5149.6910185389, 8687.348448866487, 8759.605817738344, 8778.078301778221, 8798.648054077765, 8910.821783564423, 9048.728538143867, 9166.0, 9166.266698663958, 9173.54132293396, 9180.954095229481, 6001.4298641628975, 6622.205335359788, 6896.241413444617, 6897.689603967733, 6982.406495447741, 7126.109236345457, 7150.928490715234, 7169.4981351304905, 7201.063861697946, 7212.2427145149, 6611.239707433707, 6715.127033485615, 6771.289014653587, 6855.657217139223, 6902.344277293649, 6411.647359395091, 6445.774397896051, 6594.604323740591, 6604.900926486011, 6853.965730171517, 6383.521235907233, 6439.0, 6452.645104519296, 6460.870782584416, 6463.224413070461, 4796.3285140079715, 4805.207140821725, 4923.335349727741, 4949.381327334083, 4953.0, 4814.711117332971, 4843.782029808737, 4862.149123903232, 4864.343313652612, 4956.529129732669], "value": 4070.781345334943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2829405543472, 318.1997276848724, 318.4331889237157, 321.40379595849697, 325.63366213010363, 5071.0, 5110.105731496987, 5136.306598609187, 5139.820106296281, 5159.432462429129, 5054.570361519275, 5059.139946209144, 5076.593872490201, 5085.771140298686, 5090.694558326503, 3755.3428150073696, 3835.2329534093155, 3897.4153876918404, 3956.6636835868985, 3972.443857859902, 3909.2181563687236, 3957.4261732048835, 3958.4759867451094, 3979.9801000994953, 3998.840046398155, 3731.1231860512894, 3952.901177470572, 3969.7221194516396, 3970.1464185200175, 3974.5230572331216, 3843.673287770543, 3937.2125574884994, 3952.5849785772366, 3972.980135099335, 3984.2230765000836, 3520.1023738946406, 3530.75284730069, 3542.167590616203, 3542.3446662367546, 3552.662497062775, 4903.338049363361, 4910.926336104962, 4919.458859525449, 4922.876928076791, 4941.827036053721, 4241.766702831343, 4446.5331140230455, 4454.821807127711, 4469.329600559942, 4615.023309965054, 5289.471052894718, 5292.179712144623, 5295.629305948585, 5305.230741542493, 5312.2828418163435, 3747.2692824899154, 3750.962490375116, 3769.981150094232, 3770.6606405423368, 3781.735278530504, 5299.867503312409, 5556.777728890839, 5615.101583746622, 5627.212190293362, 5631.2960879890015, 3802.6957843372466, 3806.1245913440066, 3818.4845045918446, 3829.2341531693774, 3832.2143960488033, 3869.5743468218475, 3871.7483363581277, 3877.7091718121255, 3879.612038796154, 3880.84476620932, 4198.4961804583645, 4451.265541185733, 4451.844185453559, 4471.35165401015, 4474.373587697725, 5338.786448542015, 5345.4654534546235, 5361.892762144736, 5383.973080134574, 5389.299391079213, 1333.6799168199561, 1360.7074478987065, 1362.3733082782032, 1369.9383527741275, 1372.7185926885165, 854.9145085491401, 904.0688091266006, 921.1341339141186, 959.1751094059103, 993.9055789699967, 4650.581447669726, 4707.905841883212, 4709.835155769531, 4715.198416269242, 4718.740469274223, 5482.643628164156, 5490.423505531941, 5498.560115190855, 5501.092319767274, 5501.422350653123, 4530.592246697813, 4670.509596492388, 4682.484926658065, 4708.976455117702, 4760.595349395271, 2935.66239882412, 2954.301276765825, 2962.7037296270632, 2963.2443726849947, 2965.4069186162424, 5182.870428239249, 5194.298769666047, 5209.453007434241, 5228.372595288513, 5231.215317702375, 5405.7837686492885, 5582.24639673647, 5585.245991791137, 5632.633878797865, 5670.319561652628, 5211.869703257449, 5220.738963051832, 5222.738863056832, 5230.320058392384, 5262.289590905179, 5531.834044978657, 5546.389897111395, 5547.833564992895, 5548.472895074961, 5569.749361278671, 5196.220566914993, 5481.369642491005, 5483.424240454854, 5490.478404551562, 5500.312460942382, 5213.165893457029, 5231.633785634969, 5232.979568984164, 5235.319408476874, 5239.266502689703, 3841.9039524012123, 3892.377219644843, 3909.6285852843935, 3916.5300163980505, 3922.3332033553793, 5276.630635855453, 5524.33707955048, 5571.498565129158, 5599.860003499945, 5601.6358936668985, 5381.650192737459, 5390.541803946709, 5397.598068859477, 5406.432324606017, 5406.83779486616, 5213.13983192769, 5380.11228147367, 5386.676799392049, 5398.865028374165, 5408.675479471244, 5013.2981382607195, 5299.33758280215, 5311.44229855875, 5320.255164276927, 5335.226392173191, 5142.6914385137015, 5270.552003079782, 5277.261183434245, 5278.0, 5300.920486192787, 5188.431726295357, 5228.137357335997, 5230.7384630769075, 5242.536008076198, 5267.631265811357], "value": 4021.5975586520967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8070030741547, 789.6891160673283, 793.9801504962379, 796.7012370361116, 802.4342838298996, 11060.391678457681, 11108.555657773679, 11129.054030407406, 11134.276272042312, 12016.399180040995, 11283.153763467752, 11349.262297950627, 11371.829422558669, 11412.54349826006, 11438.771224575525, 634.8984162533995, 779.3142035009184, 799.8600244957138, 812.6668066092903, 813.2436833744645, 807.8142027333716, 809.2029351089172, 809.6761295481796, 814.9511029338229, 815.3151352863594, 850.9659613615479, 858.2876212743408, 859.0979471554874, 859.222403724627, 859.922606965373, 658.7826017414266, 817.2767101115496, 849.2484151525913, 850.8213275212213, 851.1828644501286, 621.828997025817, 625.5433533520555, 625.9843503912393, 626.3892704613012, 626.4925410417576, 11805.468753906009, 11905.345206013666, 11939.34333611651, 11941.343226122559, 11947.462364193632, 12514.12401131912, 13110.737785244337, 13284.335783210801, 13379.197248165141, 13434.462621495128, 9847.60609575616, 10006.499675016294, 10044.09603135714, 10127.29108962373, 10230.283880128394, 4209.810558524874, 4211.284081706117, 4224.831006759726, 4289.420928174719, 4395.560443955611, 46357.53642463566, 48201.276980845316, 48374.0, 48377.27434088491, 48520.51479485195, 9801.411915285105, 9825.606975720892, 9975.102240798364, 9995.350302230332, 10112.544935477921, 17222.0, 17249.655006899793, 17278.0, 17288.827111728973, 17312.48062558125, 6740.831479213059, 6750.3924646782025, 6796.184457865088, 6834.897476537856, 6935.791926242221, 3720.162963333228, 3836.76979381238, 3918.8824335269987, 3935.9803200984384, 4027.134166154291, 2653.7744291735034, 2748.4365705030423, 2755.738204870534, 2772.0297895736735, 2772.6534183227095, 436.6005105328589, 512.1498312800733, 513.6609837507227, 520.6745783885071, 523.1446584833748, 559.4237934927031, 565.005590161319, 638.7285403703407, 652.4833913318544, 654.1332734127301, 7917.643706033243, 8001.639926203335, 8013.158618345106, 8043.638036288381, 8247.0, 598.8143675460622, 604.9667268300286, 607.8389226854887, 628.9433950944436, 637.5314144104079, 3719.888403347904, 3742.1018955450495, 3811.961880381161, 3837.808109594509, 3870.322693528621, 57953.4204657948, 58700.4129958695, 59243.40756592465, 59960.0, 60256.69871650614, 51772.48227517752, 51780.74109629503, 52473.0, 52532.737336313076, 53807.73096134494, 46766.76616616963, 47328.763356183, 47416.270573124115, 47522.52477475181, 48289.27566086512, 7274.781756547312, 7339.559626422431, 7354.742584009534, 7395.297446742551, 7578.924210757822, 29965.101046968626, 30731.692683072884, 31157.0, 31637.20906977344, 32119.357612848078, 40608.0, 42771.7861410691, 42831.785841070596, 43112.0, 43564.56435435605, 9662.855057174289, 9725.610975560898, 9785.119339259501, 9891.060349266809, 9935.105840474393, 10210.438425886647, 10437.530311136168, 10565.683029509128, 10865.837012444978, 10965.50655220501, 8453.746387608382, 10099.343542669703, 10519.94740026295, 11108.611198608332, 11262.774744505228, 11021.393823339473, 11088.833667495155, 11150.442477876237, 11375.374354410587, 11677.299362038304, 10993.560257589606, 11054.778904421706, 11153.888461115284, 11469.483873225892, 11673.182877198515, 9236.676716314896, 9353.158215760614, 9741.366811157252, 9903.108720215216, 9930.751731206778, 9510.0, 9640.228781697588, 9692.951535242279, 9698.85451718239, 9779.378568912649], "value": 6017.961535222721, "unit": "score"}], "name": "dromaeo_css", "value": 6328.840038534039, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 107.0, 111.0, 114.0, 116.0, 102.0, 112.0, 115.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 131.0, 154.0, 181.0, 142.0, 157.0, 164.0, 133.0, 185.0, 140.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 105.0, 104.0, 75.0, 74.0, 73.0, 129.0, 101.0, 74.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 148.0, 94.0, 96.0, 94.0, 149.0, 94.0, 94.0, 154.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 64.0, 64.0, 64.0, 64.0, 64.0, 87.0, 69.0, 61.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 80.0, 79.0, 79.0, 86.0, 80.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 143.0, 134.0, 143.0, 130.0, 130.0, 134.0, 173.0, 136.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 170.0, 169.0, 175.0, 175.0, 181.0, 169.0, 174.0, 172.0, 173.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 78.0, 70.0, 71.0, 71.0, 70.0, 72.0, 73.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1582.2, "alertThreshold": 2.0}]} 04:37:57 INFO - Return code: 0 04:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:57 ERROR - # TBPL SUCCESS # 04:37:57 INFO - Running post-action listener: _resource_record_post_action 04:37:57 INFO - Running post-run listener: _resource_record_post_run 04:37:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518377472; Read time: 12; Write time: 657204 04:37:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233738240; Read time: 0; Write time: 393452 04:37:58 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284041216; Read time: 12; Write time: 263752 04:37:58 INFO - Running post-run listener: _upload_blobber_files 04:37:58 INFO - Blob upload gear active. 04:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:37:58 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:58 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:59 INFO - (blobuploader) - INFO - Done attempting. 04:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:38:00 INFO - (blobuploader) - INFO - Done attempting. 04:38:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:38:00 INFO - Return code: 0 04:38:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:38:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:38:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f4e4b452e6776193a9d259794167a97c7df9ed43ba780f594b9e9be7600f1ffb521267cf70624e1735245c5f3fd0bd63f70cdb65ba0d909223bd497c5447fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/235cafa9c7aa4dd30effee53db182d2f283e872f5e0207f42a1c18262e59220d350f593ad05c7853e1393c832275f35e8e1ea8df736e44da0ae7808193e7f744"} 04:38:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:38:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:38:00 INFO - Contents: 04:38:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f4e4b452e6776193a9d259794167a97c7df9ed43ba780f594b9e9be7600f1ffb521267cf70624e1735245c5f3fd0bd63f70cdb65ba0d909223bd497c5447fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/235cafa9c7aa4dd30effee53db182d2f283e872f5e0207f42a1c18262e59220d350f593ad05c7853e1393c832275f35e8e1ea8df736e44da0ae7808193e7f744"} 04:38:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:38:00 INFO - Copying logs to upload dir... 04:38:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:38:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.680609 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 04:38:00.535702) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:38:00.539502) ========= 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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f4e4b452e6776193a9d259794167a97c7df9ed43ba780f594b9e9be7600f1ffb521267cf70624e1735245c5f3fd0bd63f70cdb65ba0d909223bd497c5447fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/235cafa9c7aa4dd30effee53db182d2f283e872f5e0207f42a1c18262e59220d350f593ad05c7853e1393c832275f35e8e1ea8df736e44da0ae7808193e7f744"} build_url:https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/dVsvw32xQsaoEE3cS3oraA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46f4e4b452e6776193a9d259794167a97c7df9ed43ba780f594b9e9be7600f1ffb521267cf70624e1735245c5f3fd0bd63f70cdb65ba0d909223bd497c5447fc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/235cafa9c7aa4dd30effee53db182d2f283e872f5e0207f42a1c18262e59220d350f593ad05c7853e1393c832275f35e8e1ea8df736e44da0ae7808193e7f744"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 04:38:00.563847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:38:00.564181) ========= 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=8783db0840cc980e80bb0bd400000236-1461151036.189610-160401376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:38:00.647860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:38:00.648190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 04:38:00.648481) ========= ========= Total master_lag: 0.17 =========