builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1461847960.96 results: success (0) buildid: 20160428030218 builduid: c7baa838da0b448badf6c92ee65235a8 revision: 86730d0a82093d705e44f33a34973d28b269f1ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:40.960583) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:40.961442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:40.961969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.002767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.003292) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 05:52:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-04-28 05:52:41 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081897 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.128700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.129262) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021500 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.174567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.175227) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86730d0a82093d705e44f33a34973d28b269f1ea --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 86730d0a82093d705e44f33a34973d28b269f1ea --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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 05:52:41,195 truncating revision to first 12 chars 2016-04-28 05:52:41,195 Setting DEBUG logging. 2016-04-28 05:52:41,195 attempt 1/10 2016-04-28 05:52:41,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86730d0a8209?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 05:52:41,438 unpacking tar archive at: mozilla-central-86730d0a8209/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529842 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.722767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.723299) ========= script_repo_revision: 86730d0a82093d705e44f33a34973d28b269f1ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.724007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.724934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 05:52:41.736943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 05:52:41.737619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:41 INFO - MultiFileLogger online at 20160428 05:52:41 in /builds/slave/test 05:52:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:41 INFO - {'append_to_log': False, 05:52:41 INFO - 'base_work_dir': '/builds/slave/test', 05:52:41 INFO - 'blob_upload_branch': 'Firefox', 05:52:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:41 INFO - 'branch': 'Firefox', 05:52:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:41 INFO - 'config_files': ('talos/linux_config.py',), 05:52:41 INFO - 'default_actions': ('clobber', 05:52:41 INFO - 'read-buildbot-config', 05:52:41 INFO - 'download-and-extract', 05:52:41 INFO - 'populate-webroot', 05:52:41 INFO - 'create-virtualenv', 05:52:41 INFO - 'install', 05:52:41 INFO - 'run-tests'), 05:52:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:41 INFO - 'download_minidump_stackwalk': True, 05:52:41 INFO - 'download_symbols': 'ondemand', 05:52:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:41 INFO - 'installer_path': 'installer.exe', 05:52:41 INFO - 'log_level': 'info', 05:52:41 INFO - 'log_name': 'talos', 05:52:41 INFO - 'log_to_console': True, 05:52:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:41 INFO - 'opt_config_files': (), 05:52:41 INFO - 'pip_index': False, 05:52:41 INFO - 'sps_profile': False, 05:52:41 INFO - 'sps_profile_interval': 0, 05:52:41 INFO - 'suite': 'dromaeojs', 05:52:41 INFO - 'system_bits': '32', 05:52:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:41 INFO - 'title': 'talos-linux64-ix-046', 05:52:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:41 INFO - 'use_talos_json': True, 05:52:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:41 INFO - 'work_dir': 'build'} 05:52:41 INFO - ##### 05:52:41 INFO - ##### Running clobber step. 05:52:41 INFO - ##### 05:52:41 INFO - Running pre-action listener: _resource_record_pre_action 05:52:41 INFO - Running main action method: clobber 05:52:41 INFO - rmtree: /builds/slave/test/build 05:52:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:42 INFO - Running post-action listener: _resource_record_post_action 05:52:42 INFO - ##### 05:52:42 INFO - ##### Running read-buildbot-config step. 05:52:42 INFO - ##### 05:52:42 INFO - Running pre-action listener: _resource_record_pre_action 05:52:42 INFO - Running main action method: read_buildbot_config 05:52:42 INFO - Using buildbot properties: 05:52:42 INFO - { 05:52:42 INFO - "project": "", 05:52:42 INFO - "product": "firefox", 05:52:42 INFO - "script_repo_revision": "production", 05:52:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:52:42 INFO - "repository": "", 05:52:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:52:42 INFO - "buildid": "20160428030218", 05:52:42 INFO - "stage_platform": "linux64-pgo", 05:52:42 INFO - "basedir": "/builds/slave/test", 05:52:42 INFO - "nightly_build": "True", 05:52:42 INFO - "buildnumber": 756, 05:52:42 INFO - "slavename": "talos-linux64-ix-046", 05:52:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:42 INFO - "platform": "ubuntu64_hw", 05:52:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:42 INFO - "branch": "mozilla-central", 05:52:42 INFO - "repo_path": "mozilla-central", 05:52:42 INFO - "revision": "86730d0a82093d705e44f33a34973d28b269f1ea", 05:52:42 INFO - "pgo_build": "True", 05:52:42 INFO - "builduid": "c7baa838da0b448badf6c92ee65235a8", 05:52:42 INFO - "slavebuilddir": "test" 05:52:42 INFO - } 05:52:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:52:42 INFO - Running post-action listener: _resource_record_post_action 05:52:42 INFO - ##### 05:52:42 INFO - ##### Running download-and-extract step. 05:52:42 INFO - ##### 05:52:42 INFO - Running pre-action listener: _resource_record_pre_action 05:52:42 INFO - Running main action method: download_and_extract 05:52:42 INFO - mkdir: /builds/slave/test/build/tests 05:52:42 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')]} 05:52:42 INFO - https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:43 INFO - Downloaded 1361 bytes. 05:52:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:52:43 INFO - Using the following test package requirements: 05:52:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'jsshell-linux-x86_64.zip'], 05:52:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:43 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')]} 05:52:43 INFO - https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:45 INFO - Downloaded 23865034 bytes. 05:52:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:46 INFO - Return code: 0 05:52:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:46 INFO - https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:48 INFO - Downloaded 23865034 bytes. 05:52:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:50 INFO - Return code: 0 05:52:50 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')]} 05:52:50 INFO - https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:51 INFO - Downloaded 10840145 bytes. 05:52:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:52:51 INFO - Return code: 0 05:52: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')]} 05:52:51 INFO - https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:52 INFO - Downloaded 58345926 bytes. 05:52:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:52:52 INFO - mkdir: /builds/slave/test/properties 05:52:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:52 INFO - Contents: 05:52:52 INFO - build_url:https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:52:53 INFO - Running post-action listener: _resource_record_post_action 05:52:53 INFO - Running post-action listener: set_extra_try_arguments 05:52:53 INFO - ##### 05:52:53 INFO - ##### Running populate-webroot step. 05:52:53 INFO - ##### 05:52:53 INFO - Running pre-action listener: _resource_record_pre_action 05:52:53 INFO - Running main action method: populate_webroot 05:52:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:53 INFO - '--tppagecycles', 05:52:53 INFO - '7'], 05:52:53 INFO - 'tests': ['tsvgm']}}, 05:52:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['damp', 'tps']}, 05:52:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'tests': ['damp', 'tps']}, 05:52:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['dromaeo_dom']}, 05:52:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['a11yr', 05:52:53 INFO - 'ts_paint', 05:52:53 INFO - 'tpaint', 05:52:53 INFO - 'sessionrestore', 05:52:53 INFO - 'sessionrestore_no_auto_restore', 05:52:53 INFO - 'tabpaint']}, 05:52:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['tsvgx', 05:52:53 INFO - 'tsvgr_opacity', 05:52:53 INFO - 'tart', 05:52:53 INFO - 'tscrollx', 05:52:53 INFO - 'cart']}, 05:52:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:53 INFO - 'tsvgr_opacity', 05:52:53 INFO - 'tart', 05:52:53 INFO - 'tscrollx', 05:52:53 INFO - 'cart']}, 05:52:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'talos_options': ['--disable-e10s'], 05:52:53 INFO - 'tests': ['tp5o']}, 05:52:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'tests': ['tp5o']}, 05:52:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'talos_options': ['--disable-e10s', 05:52:53 INFO - '--xperf_path', 05:52:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:53 INFO - 'tests': ['tp5n']}, 05:52:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:53 INFO - 'talos_options': ['--xperf_path', 05:52:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:53 INFO - 'tests': ['tp5n']}}, 05:52:53 INFO - 'talos.zip': {'path': '', 05:52:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:53 INFO - Running post-action listener: _resource_record_post_action 05:52:53 INFO - ##### 05:52:53 INFO - ##### Running create-virtualenv step. 05:52:53 INFO - ##### 05:52:53 INFO - Running pre-action listener: _resource_record_pre_action 05:52:53 INFO - Running main action method: create_virtualenv 05:52:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:53 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 05:52:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:53 INFO - Using real prefix '/usr' 05:52:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:57 INFO - Installing pip.................done. 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:52:57 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 05:52:57 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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 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 05:52:57 INFO - Cleaning up... 05:52:57 INFO - Return code: 0 05:52:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:57 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:52:57 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 05:52:57 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 05:52:57 INFO - Using env: {'DISPLAY': ':0', 05:52:57 INFO - 'HOME': '/home/cltbld', 05:52:57 INFO - 'LANG': 'en_US.UTF-8', 05:52:57 INFO - 'LANGUAGE': 'en_US:en', 05:52:57 INFO - 'LOGNAME': 'cltbld', 05:52:57 INFO - 'MAIL': '/var/mail/cltbld', 05:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:57 INFO - 'MOZ_NO_REMOTE': '1', 05:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:57 INFO - 'NO_EM_RESTART': '1', 05:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:57 INFO - 'PWD': '/builds/slave/test', 05:52:57 INFO - 'SHELL': '/bin/bash', 05:52:57 INFO - 'SHLVL': '1', 05:52:57 INFO - 'TERM': 'linux', 05:52:57 INFO - 'TMOUT': '86400', 05:52:57 INFO - 'USER': 'cltbld', 05:52:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:57 INFO - '_': '/tools/buildbot/bin/python'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 INFO - Downloading/unpacking psutil>=0.7.1 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:59 INFO - Installing collected packages: psutil 05:52:59 INFO - Running setup.py install for psutil 05:52:59 INFO - building 'psutil._psutil_linux' extension 05:52:59 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 05:52:59 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 05:52:59 INFO - building 'psutil._psutil_posix' extension 05:52:59 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 05:52:59 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 05:52:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:59 INFO - Successfully installed psutil 05:52:59 INFO - Cleaning up... 05:52:59 INFO - Return code: 0 05:52:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:52:59 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')]} 05:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:59 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')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:00 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 05:53:00 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 05:53:00 INFO - Using env: {'DISPLAY': ':0', 05:53:00 INFO - 'HOME': '/home/cltbld', 05:53:00 INFO - 'LANG': 'en_US.UTF-8', 05:53:00 INFO - 'LANGUAGE': 'en_US:en', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MAIL': '/var/mail/cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SHLVL': '1', 05:53:00 INFO - 'TERM': 'linux', 05:53:00 INFO - 'TMOUT': '86400', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - '_': '/tools/buildbot/bin/python'} 05:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:53:02 INFO - Installing collected packages: mozsystemmonitor 05:53:02 INFO - Running setup.py install for mozsystemmonitor 05:53:02 INFO - Successfully installed mozsystemmonitor 05:53:02 INFO - Cleaning up... 05:53:03 INFO - Return code: 0 05:53:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:03 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:03 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 05:53:03 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 05:53:03 INFO - Using env: {'DISPLAY': ':0', 05:53:03 INFO - 'HOME': '/home/cltbld', 05:53:03 INFO - 'LANG': 'en_US.UTF-8', 05:53:03 INFO - 'LANGUAGE': 'en_US:en', 05:53:03 INFO - 'LOGNAME': 'cltbld', 05:53:03 INFO - 'MAIL': '/var/mail/cltbld', 05:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:03 INFO - 'MOZ_NO_REMOTE': '1', 05:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:03 INFO - 'NO_EM_RESTART': '1', 05:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:03 INFO - 'PWD': '/builds/slave/test', 05:53:03 INFO - 'SHELL': '/bin/bash', 05:53:03 INFO - 'SHLVL': '1', 05:53:03 INFO - 'TERM': 'linux', 05:53:03 INFO - 'TMOUT': '86400', 05:53:03 INFO - 'USER': 'cltbld', 05:53:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:03 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:03 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 05:53:03 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 05:53:03 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 05:53:03 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 05:53:03 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 05:53:03 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 05:53:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - Downloading docopt-0.6.1.tar.gz 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:06 INFO - Running setup.py install for blobuploader 05:53:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:06 INFO - Running setup.py install for requests 05:53:06 INFO - Running setup.py install for docopt 05:53:06 INFO - Successfully installed blobuploader requests docopt 05:53:06 INFO - Cleaning up... 05:53:06 INFO - Return code: 0 05:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:06 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')]} 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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')]} 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:06 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 05:53:06 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 05:53:06 INFO - Using env: {'DISPLAY': ':0', 05:53:06 INFO - 'HOME': '/home/cltbld', 05:53:06 INFO - 'LANG': 'en_US.UTF-8', 05:53:06 INFO - 'LANGUAGE': 'en_US:en', 05:53:06 INFO - 'LOGNAME': 'cltbld', 05:53:06 INFO - 'MAIL': '/var/mail/cltbld', 05:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:06 INFO - 'MOZ_NO_REMOTE': '1', 05:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:06 INFO - 'NO_EM_RESTART': '1', 05:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:06 INFO - 'PWD': '/builds/slave/test', 05:53:06 INFO - 'SHELL': '/bin/bash', 05:53:06 INFO - 'SHLVL': '1', 05:53:06 INFO - 'TERM': 'linux', 05:53:06 INFO - 'TMOUT': '86400', 05:53:06 INFO - 'USER': 'cltbld', 05:53:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:06 INFO - '_': '/tools/buildbot/bin/python'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:06 INFO - Running setup.py (path:/tmp/pip-DkjV_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:06 INFO - Running setup.py (path:/tmp/pip-8E7pDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:07 INFO - Running setup.py (path:/tmp/pip-t8sTF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:07 INFO - Running setup.py (path:/tmp/pip-Jqv121-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:07 INFO - Running setup.py (path:/tmp/pip-1ll5d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:07 INFO - Running setup.py (path:/tmp/pip-rHpAvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:07 INFO - Running setup.py (path:/tmp/pip-djAa4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:07 INFO - Running setup.py (path:/tmp/pip-hGrJst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:07 INFO - Running setup.py (path:/tmp/pip-60I63r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:07 INFO - Running setup.py (path:/tmp/pip-aJIYgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:07 INFO - Running setup.py (path:/tmp/pip-rmidm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:07 INFO - Running setup.py (path:/tmp/pip-dJWDhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:07 INFO - Running setup.py (path:/tmp/pip-02OGBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:07 INFO - Running setup.py (path:/tmp/pip-RFKiHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:07 INFO - Running setup.py (path:/tmp/pip-IgPVV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:07 INFO - Running setup.py (path:/tmp/pip-YroBRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:08 INFO - Running setup.py (path:/tmp/pip-kdkU57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:08 INFO - Running setup.py install for manifestparser 05:53:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozcrash 05:53:08 INFO - Running setup.py install for mozdebug 05:53:08 INFO - Running setup.py install for mozdevice 05:53:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozfile 05:53:08 INFO - Running setup.py install for mozhttpd 05:53:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozinfo 05:53:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozInstall 05:53:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:08 INFO - Running setup.py install for mozleak 05:53:09 INFO - Running setup.py install for mozlog 05:53:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for moznetwork 05:53:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozprocess 05:53:09 INFO - Running setup.py install for mozprofile 05:53:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozrunner 05:53:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Running setup.py install for mozscreenshot 05:53:09 INFO - Running setup.py install for moztest 05:53:09 INFO - Running setup.py install for mozversion 05:53:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:09 INFO - Cleaning up... 05:53:09 INFO - Return code: 0 05:53:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:09 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')]} 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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')]} 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:09 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:09 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 05:53:09 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 05:53:09 INFO - Using env: {'DISPLAY': ':0', 05:53:09 INFO - 'HOME': '/home/cltbld', 05:53:09 INFO - 'LANG': 'en_US.UTF-8', 05:53:09 INFO - 'LANGUAGE': 'en_US:en', 05:53:09 INFO - 'LOGNAME': 'cltbld', 05:53:09 INFO - 'MAIL': '/var/mail/cltbld', 05:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:09 INFO - 'MOZ_NO_REMOTE': '1', 05:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:09 INFO - 'NO_EM_RESTART': '1', 05:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:09 INFO - 'PWD': '/builds/slave/test', 05:53:09 INFO - 'SHELL': '/bin/bash', 05:53:09 INFO - 'SHLVL': '1', 05:53:09 INFO - 'TERM': 'linux', 05:53:09 INFO - 'TMOUT': '86400', 05:53:09 INFO - 'USER': 'cltbld', 05:53:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:09 INFO - '_': '/tools/buildbot/bin/python'} 05:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 INFO - Running setup.py (path:/tmp/pip-4nsQVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 INFO - Running setup.py (path:/tmp/pip-gOVBFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 INFO - Running setup.py (path:/tmp/pip-lGCZmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 INFO - Running setup.py (path:/tmp/pip-UZbwuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:10 INFO - Running setup.py (path:/tmp/pip-uoh4hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 INFO - Running setup.py (path:/tmp/pip-r8oIlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 INFO - Running setup.py (path:/tmp/pip-h0pg4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 INFO - Running setup.py (path:/tmp/pip-5KnPYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:10 INFO - Running setup.py (path:/tmp/pip-uBWIYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:10 INFO - Running setup.py (path:/tmp/pip-ORXCfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:10 INFO - Running setup.py (path:/tmp/pip-WZWj6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:10 INFO - Running setup.py (path:/tmp/pip-TDjLtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:10 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)) 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 INFO - Running setup.py (path:/tmp/pip-DOfJHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 INFO - Running setup.py (path:/tmp/pip-0NU3n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 INFO - Running setup.py (path:/tmp/pip-1Uc768-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:11 INFO - Running setup.py (path:/tmp/pip-_YQo7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:11 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)) 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:11 INFO - Running setup.py (path:/tmp/pip-0hNzke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 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)) 05:53:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:13 INFO - Downloading blessings-1.6.tar.gz 05:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:13 INFO - Installing collected packages: blessings 05:53:13 INFO - Running setup.py install for blessings 05:53:13 INFO - Successfully installed blessings 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:13 INFO - Reading from file tmpfile_stdout 05:53:13 INFO - Current package versions: 05:53:13 INFO - argparse == 1.2.1 05:53:13 INFO - blessings == 1.6 05:53:13 INFO - blobuploader == 1.2.4 05:53:13 INFO - docopt == 0.6.1 05:53:13 INFO - manifestparser == 1.1 05:53:13 INFO - mozInstall == 1.12 05:53:13 INFO - mozcrash == 0.17 05:53:13 INFO - mozdebug == 0.1 05:53:13 INFO - mozdevice == 0.48 05:53:13 INFO - mozfile == 1.2 05:53:13 INFO - mozhttpd == 0.7 05:53:13 INFO - mozinfo == 0.9 05:53:13 INFO - mozleak == 0.1 05:53:13 INFO - mozlog == 3.1 05:53:13 INFO - moznetwork == 0.27 05:53:13 INFO - mozprocess == 0.22 05:53:13 INFO - mozprofile == 0.28 05:53:13 INFO - mozrunner == 6.11 05:53:13 INFO - mozscreenshot == 0.1 05:53:13 INFO - mozsystemmonitor == 0.0 05:53:13 INFO - moztest == 0.7 05:53:13 INFO - mozversion == 1.4 05:53:13 INFO - psutil == 3.1.1 05:53:13 INFO - requests == 1.2.3 05:53:13 INFO - wsgiref == 0.1.2 05:53:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:13 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 05:53:13 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 05:53:13 INFO - Using env: {'DISPLAY': ':0', 05:53:13 INFO - 'HOME': '/home/cltbld', 05:53:13 INFO - 'LANG': 'en_US.UTF-8', 05:53:13 INFO - 'LANGUAGE': 'en_US:en', 05:53:13 INFO - 'LOGNAME': 'cltbld', 05:53:13 INFO - 'MAIL': '/var/mail/cltbld', 05:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:13 INFO - 'MOZ_NO_REMOTE': '1', 05:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:13 INFO - 'NO_EM_RESTART': '1', 05:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:13 INFO - 'PWD': '/builds/slave/test', 05:53:13 INFO - 'SHELL': '/bin/bash', 05:53:13 INFO - 'SHLVL': '1', 05:53:13 INFO - 'TERM': 'linux', 05:53:13 INFO - 'TMOUT': '86400', 05:53:13 INFO - 'USER': 'cltbld', 05:53:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:13 INFO - '_': '/tools/buildbot/bin/python'} 05:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 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)) 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:13 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 05:53:13 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 05:53:13 INFO - Using env: {'DISPLAY': ':0', 05:53:13 INFO - 'HOME': '/home/cltbld', 05:53:13 INFO - 'LANG': 'en_US.UTF-8', 05:53:13 INFO - 'LANGUAGE': 'en_US:en', 05:53:13 INFO - 'LOGNAME': 'cltbld', 05:53:13 INFO - 'MAIL': '/var/mail/cltbld', 05:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:13 INFO - 'MOZ_NO_REMOTE': '1', 05:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:13 INFO - 'NO_EM_RESTART': '1', 05:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:13 INFO - 'PWD': '/builds/slave/test', 05:53:13 INFO - 'SHELL': '/bin/bash', 05:53:13 INFO - 'SHLVL': '1', 05:53:13 INFO - 'TERM': 'linux', 05:53:13 INFO - 'TMOUT': '86400', 05:53:13 INFO - 'USER': 'cltbld', 05:53:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:13 INFO - '_': '/tools/buildbot/bin/python'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Downloading/unpacking jsonschema 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:14 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 05:53:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:16 INFO - warning: no files found matching '*.txt' 05:53:16 INFO - no previously-included directories found matching 'build' 05:53:16 INFO - no previously-included directories found matching 'dist' 05:53:16 INFO - no previously-included directories found matching '.git*' 05:53:16 INFO - Installing collected packages: jsonschema, functools32 05:53:16 INFO - Running setup.py install for functools32 05:53:16 INFO - warning: no files found matching '*.txt' 05:53:16 INFO - no previously-included directories found matching 'build' 05:53:16 INFO - no previously-included directories found matching 'dist' 05:53:16 INFO - no previously-included directories found matching '.git*' 05:53:16 INFO - Successfully installed jsonschema functools32 05:53:16 INFO - Cleaning up... 05:53:16 INFO - Return code: 0 05:53:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:53:16 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')]} 05:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:16 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')]} 05:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:16 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 0x7fd6561b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe49a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', '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 05:53:16 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 05:53:16 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 05:53:16 INFO - Using env: {'DISPLAY': ':0', 05:53:16 INFO - 'HOME': '/home/cltbld', 05:53:16 INFO - 'LANG': 'en_US.UTF-8', 05:53:16 INFO - 'LANGUAGE': 'en_US:en', 05:53:16 INFO - 'LOGNAME': 'cltbld', 05:53:16 INFO - 'MAIL': '/var/mail/cltbld', 05:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:16 INFO - 'MOZ_NO_REMOTE': '1', 05:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:16 INFO - 'NO_EM_RESTART': '1', 05:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:16 INFO - 'PWD': '/builds/slave/test', 05:53:16 INFO - 'SHELL': '/bin/bash', 05:53:16 INFO - 'SHLVL': '1', 05:53:16 INFO - 'TERM': 'linux', 05:53:16 INFO - 'TMOUT': '86400', 05:53:16 INFO - 'USER': 'cltbld', 05:53:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:16 INFO - '_': '/tools/buildbot/bin/python'} 05:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:16 INFO - Downloading/unpacking flake8 05:53:16 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 05:53:16 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 05:53:16 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 05:53:16 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 05:53:16 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 05:53:16 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 05:53:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:53:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:53:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:19 INFO - no previously-included directories found matching 'docs/_build' 05:53:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:53:19 INFO - Running setup.py install for pep8 05:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:19 INFO - no previously-included directories found matching 'docs/_build' 05:53:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:53:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Running post-action listener: _resource_record_post_action 05:53:19 INFO - Running post-action listener: _start_resource_monitoring 05:53:19 INFO - Starting resource monitoring. 05:53:19 INFO - ##### 05:53:19 INFO - ##### Running install step. 05:53:19 INFO - ##### 05:53:19 INFO - Running pre-action listener: _resource_record_pre_action 05:53:19 INFO - Running main action method: install 05:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:19 INFO - Reading from file tmpfile_stdout 05:53:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:19 INFO - Reading from file tmpfile_stdout 05:53:19 INFO - Output received: 05:53:19 INFO - Usage: mozinstall [options] installer 05:53:19 INFO - Options: 05:53:19 INFO - -h, --help show this help message and exit 05:53:19 INFO - -d DEST, --destination=DEST 05:53:19 INFO - Directory to install application into. [default: 05:53:19 INFO - "/builds/slave/test"] 05:53:19 INFO - --app=APP Application being installed. [default: firefox] 05:53:19 INFO - mkdir: /builds/slave/test/build/application 05:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:53:36 INFO - Reading from file tmpfile_stdout 05:53:36 INFO - Output received: 05:53:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:36 INFO - Running post-action listener: _resource_record_post_action 05:53:36 INFO - ##### 05:53:36 INFO - ##### Running run-tests step. 05:53:36 INFO - ##### 05:53:36 INFO - Running pre-action listener: _resource_record_pre_action 05:53:36 INFO - Running main action method: run_tests 05:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:36 INFO - Python 2.7.3 05:53:36 INFO - Return code: 0 05:53:36 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53:36 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 0x1073810>, '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 0x1074710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:36 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 05:53:36 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 05:53:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:36 INFO - Return code: 0 05:53:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:53:37 INFO - Return code: 0 05:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:53:37 INFO - Using env: {'DISPLAY': ':0', 05:53:37 INFO - 'HOME': '/home/cltbld', 05:53:37 INFO - 'LANG': 'en_US.UTF-8', 05:53:37 INFO - 'LANGUAGE': 'en_US:en', 05:53:37 INFO - 'LOGNAME': 'cltbld', 05:53:37 INFO - 'MAIL': '/var/mail/cltbld', 05:53:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:37 INFO - 'MOZ_NO_REMOTE': '1', 05:53:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:37 INFO - 'NO_EM_RESTART': '1', 05:53:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:37 INFO - 'PWD': '/builds/slave/test', 05:53:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:37 INFO - 'SHELL': '/bin/bash', 05:53:37 INFO - 'SHLVL': '1', 05:53:37 INFO - 'TERM': 'linux', 05:53:37 INFO - 'TMOUT': '86400', 05:53:37 INFO - 'USER': 'cltbld', 05:53:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533', 05:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:37 INFO - '_': '/tools/buildbot/bin/python'} 05:53:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:53:37 INFO - mozversion application_buildid: 20160428030218 05:53:37 INFO - mozversion application_changeset: 86730d0a82093d705e44f33a34973d28b269f1ea 05:53:37 INFO - mozversion application_display_name: Nightly 05:53:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:37 INFO - mozversion application_name: Firefox 05:53:37 INFO - mozversion application_remotingname: firefox 05:53:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:37 INFO - mozversion application_vendor: Mozilla 05:53:37 INFO - mozversion application_version: 49.0a1 05:53:37 INFO - mozversion platform_buildid: 20160428030218 05:53:37 INFO - mozversion platform_changeset: 86730d0a82093d705e44f33a34973d28b269f1ea 05:53:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:37 INFO - mozversion platform_version: 49.0a1 05:53:37 INFO - using testdate: 1461848017 05:53:37 INFO - actual date: 1461848017 05:53:37 INFO - starting webserver on 'localhost:37110' 05:53:37 INFO - SUITE-START | Running 2 tests 05:53:37 INFO - TEST-START | dromaeo_css 05:53:37 INFO - operating with platform_type : linux_ 05:53:37 INFO - Initialising browser for dromaeo_css test... 05:53:37 INFO - TEST-INFO | started process 3933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplptQ_n/profile http://localhost:37110/getInfo.html) 05:53:41 INFO - PROCESS | 3933 | __metrics Screen width/height:1600/1200 05:53:41 INFO - PROCESS | 3933 | colorDepth:24 05:53:41 INFO - PROCESS | 3933 | Browser inner width/height: 1024/697 05:53:41 INFO - PROCESS | 3933 | __metrics 05:53:42 ERROR - PROCESS | 3933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:53:43 INFO - TEST-INFO | 3933: exit 0 05:53:43 INFO - Browser initialized. 05:53:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:43 INFO - TEST-INFO | started process 4013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplptQ_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:55 INFO - PROCESS | 4013 | RSS: Main: 155422720 05:53:55 INFO - PROCESS | 4013 | 05:54:46 INFO - PROCESS | 4013 | 1461848086514 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] 05:56:54 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37110/tests/dromaeo/cssquery-ext.html) 05:56:55 INFO - PROCESS | 4013 | RSS: Main: 271118336 05:56:55 INFO - PROCESS | 4013 | 05:59:57 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-ext.html (next: http://localhost:37110/tests/dromaeo/cssquery-jquery.html) 05:59:58 INFO - PROCESS | 4013 | RSS: Main: 238436352 05:59:58 INFO - PROCESS | 4013 | 06:02:59 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37110/tests/dromaeo/cssquery-mootools.html) 06:03:00 INFO - PROCESS | 4013 | RSS: Main: 239554560 06:03:00 INFO - PROCESS | 4013 | 06:06:02 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37110/tests/dromaeo/cssquery-prototype.html) 06:06:02 INFO - PROCESS | 4013 | RSS: Main: 233725952 06:06:02 INFO - PROCESS | 4013 | 06:09:05 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37110/tests/dromaeo/cssquery-yui.html) 06:09:06 INFO - PROCESS | 4013 | RSS: Main: 226664448 06:09:06 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:37110/tests/dromaeo/cssquery-yui.html (next: http://localhost:37110/tests/dromaeo/cssquery-dojo.html) 06:12:08 INFO - PROCESS | 4013 | RSS: Main: 262729728 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | __start_tp_report 06:12:08 INFO - PROCESS | 4013 | _x_x_mozilla_page_load 06:12:08 INFO - PROCESS | 4013 | _x_x_mozilla_page_load_details 06:12:08 INFO - PROCESS | 4013 | |i|pagename|runs| 06:12:08 INFO - PROCESS | 4013 | |0;dojo.html;3069.4628440022993;3106.0992312229455;3144.103930379842;3145.6697046810086;3180.793248438852;5181.740912954356;5270.367555893288;5283.2075188721665;5302.3106996090455;5318.76065577049;5266.052110620087;5290.127129023706;5303.522682958533;5362.865928351784;5431.701256430894;4845.127876982142;4867.050925069595;4868.391451068616;4878.146324393235;4919.557239848413;4886.63350248731;4925.507449255082;4951.133551628469;4968.975155124219;5000.574951129159;4739.668223224376;4806.182948898678;4852.660313778037;4911.336969509106;4943.604511639078;4846.6365022623095;4875.049365373754;4879.219324907997;4884.511548845123;4920.1635721927005;4732.455767586737;4747.857564273043;4764.952350476486;4765.594924431392;4802.735849528274;5131.384233891957;5150.4334523202415;5187.896242075175;5330.786768529254;5334.03987282289;5654.6324488908085;5654.9717251413895;5665.433456654343;5684.175794509814;5686.090225563931;5661.886762264773;5714.685692286923;5727.770889164429;5731.656100633933;5731.828045158611;5211.557017653466;5309.33633295838;5391.514763671288;5424.376196737387;5430.402655707869;5799.101139323411;5840.970795146082;5842.269716285465;5843.970780146072;5892.558058145656;5406.08096623575;5583.609147359646;5607.271054762855;5608.495235428831;5611.242482264842;5525.309336332958;5532.3637781655625;5533.972330138324;5535.806246781343;5538.47384498472;5552.056150454432;5653.180288858092;5664.037113690682;5667.036603777286;5667.8866422672145;5559.471850174308;5570.6657600544095;5612.410696876851;5614.9157762633595;5618;4282.850100246476;4284.271673815459;4285.507166675872;4311.094670119247;4325.76208308546;3777.792221427848;3809.7333186676665;3843.9231215375535;3896.649301562873;3931.64615184629;5365.38298095724;5369.650972686841;5374.973125134349;5379.35447746273;5424.349078110573;5478.972605136949;5688.77244910199;5693.373728889819;5694.174344719992;5694.629849059798;5295.6822590643915;5354.330708661418;5372.140457526777;5418.106012507892;5428.240046393508;4889.877753056202;4913.459519452857;4915.926261106087;4916;4960.8759781005765;5817.854553636193;5819.4762471376935;5891.528677705774;5901.262342207224;5902.350741418526;5733.913991290217;5750.568707347049;5753.108268218432;5764.625299355528;5799.710014499174;5913.438223368773;5920.763169473173;5921.792737254175;5926.762929482772;5926.881462370815;5415.5938304626525;5542.445755424425;5622.128570071645;5622.269105016485;5648.406917273627;5738.655680659173;5740.68426236561;5741.62679425836;5742.59801813869;5767.192593036894;5570.359408667893;5580.525655319181;5582.748776304995;5583.525400341016;5586.804461843816;5366.570674345965;5512.6968016759465;5561.221428999862;5626.043572592751;5628.465295796893;5460.044492213926;5478.123500239943;5484.341878974548;5491.423400542885;5499.780008799603;5553.16702494629;5580.135079062752;5585.301837270341;5591.524720398812;5637.633553818989;5308.681479111111;5350.705711185922;5449.863753406196;5517.5585953124455;5543.833684989457 06:12:08 INFO - PROCESS | 4013 | |1;ext.html;576.3228206856942;621.1366200980636;623.8128561431571;641.563736659072;649.4122818848938;36786;38089.23821523568;38141;38220.80889595555;38261;38640;39137.804310978405;39373.40939885904;39430.408543871796;39433.21133577334;8405.789855253623;8672.913270867306;8680.348973826956;8682.175193356621;8682.6092825823;8451.197136272074;8561.700340488083;8563.785905352384;8732.476051436934;8806.295496360275;8737.868931966026;8813.559322033905;8816.426932249384;8841.690540831072;8849.513276769776;8750.168733970262;8766.824663506693;8786.121387861227;8814.559272036373;8819.118088191193;8627.439216450974;8775.517346545937;8782;8790.077041910572;8792.956035219782;38982.220355592726;39297.214055719014;39336;39534;39564.20871582552;3579.5167652367118;3589.4974703541525;3751.381022131345;3934.783586902719;4206.8737937861915;30514.54228186579;30525.38949221025;30665.846670766725;30732;30960.690393096007;4152.875413737593;4165.229432554987;4233.456229441385;4250.256205164115;4260.637845783112;250359;251751;252062;252247.99999999817;252606;38681.22637547233;53144;53843.46156538463;53895.73052134793;53953.73023134859;50070.248946265834;50909.490905090475;50931.745341273054;51009.23486147711;51065;16345.754813677804;16612.08633525168;16626.418075367303;16647.084410357547;16653.50039498817;10207.897921020694;12408.317542535247;12507.936825369763;12582.496700132075;12595.811062834066;15019.324130414157;15029.098254104789;15216.239188040776;15235.92382038105;15335.233238338038;5703.914441283384;5840.8247752567495;5873.177755114288;5877.67752255739;5939.910901336483;1015.2943704125562;1039.2050081687514;1042.3954106618144;1093.9398333091597;1154.8556430446195;30696.84651576728;30958;31137.532937005963;31235.843820780752;31270;1091.7270682329417;1134.7163209197702;1174.142875700726;1239.910750385585;1272.2620879889641;14480.740614982049;15416.306266218047;15483.148426836633;15612.609684757745;15630.45293414725;354568;355974;360502;360525;361398;50387.74806125946;50838.74580627073;50843;50909.74545127251;50922.23616645753;1290.1098242213031;1294.6375014995817;1341.6578772412777;1421.289355322339;1520.118331367804;27159.86420067966;28083.859580701966;28580.42839143164;28901.855490722413;28929.42141157207;41193.58806412017;41378.586214137475;41739;41797.79101104475;41844.3723344144;201232;201746;201930;202188;202552;22346.329610111723;24497;24770;25123.357113218848;25365.74634253634;38075.80962095172;38138.23723525569;44303.11393772171;44327;44729.55270447254;37905;38379.616203837606;38408.423873642474;38515;38583.614163858;37496.43755343727;37732.811335943145;37751.81124094362;38072.80963595275;38823.805880970416;38071.809640951615;38300.6169938297;39397.60602393939;39492.60507394889;39554.40668390034;31756.206094847814;34004.48993265152;34166.65833341734;34218.14454638654;34530.48204276988;26634.866825665747;26688.59967100534;26859.32851678724;26975.46049079047;26987.325316867235 06:12:08 INFO - PROCESS | 4013 | |2;jquery.html;389.41198789827354;393.468817096919;394.7276379298284;400.35742633073914;402.621535756389;16872;17292.394766183184;17414;17428.215730292137;18239.452816415494;17565.385211517598;18118;18511.16699748511;18672.71990920134;18677.439676809718;5252;5374.435684253156;5524.254225679542;5536.446355364452;5562.276904002474;5480.808171713991;5494.066008778497;5526.58550608704;5528.668279903199;5530;5444.945550544483;5500.697461639628;5501.697406642633;5506.091494903356;5506.91739623906;5390.676559406428;5467.0705979983495;5483.287172667528;5511.641743286674;5513.889722205554;5232.7122008289525;5310.867228319285;5344.438833922421;5436.184572314145;5437.8368648940595;20490.487737806525;21401.464963376042;21462.463438414008;21570.35288941334;21946.122155113775;2212.6680997850453;2310.7342655594653;2323.7560056194193;2394.688690470245;2887.9613748797974;8235.50586964784;9404;9438;9876.555555000043;9916.305858589902;1981.3362523554626;1994.950126246841;1997.221083777328;2040.2247146084394;2055.2498338106634;63459;65834.67082664555;66557;66836.6658166706;67380.66309668469;10226.437545934896;10350.585976560853;10382.688519344432;10579.36523808574;10596.417197054236;14581.635459113395;14690.11859288446;14698.779518307234;14729.92635036818;14744.631384215267;7676.80807979805;8018.398620103516;8036.035675718951;8140.267375936194;8168.9183108169345;7791.4935529190425;7811.570363630055;7904.4071694623135;7936.84126317482;8010.799730006796;4365.3670217818235;4565.452145742465;4567.771611419482;4597.747123908217;4647.140279048387;1909.694448888171;1961.5194277401843;1972.8224459798687;1987.642224399622;2004.2183548416128;939;1004.1565085328359;1004.914582260516;1080.7352198711367;1118.183725880112;17457.381193376386;17566.03386813712;17715.202815873316;17918.55203619894;18205.27178912855;980.8479685648736;1029.1098200056897;1030.314840630987;1031.3966329697062;1107.0755918807724;9848.012178991326;10426.635067772744;10450.268481206394;10522.73693157662;10567.682969510926;427237;451056.7447162743;456377.46698211617;461977;469189;43941.560584394385;48940;49008;76424.61787691138;77625;935.8970513243673;1015.6546774096843;1017.760826205841;1027.4041056187393;1053.0364716284514;15017.249137543298;15409.614759631098;15537.84462155364;15861.52415427539;16770.496885093467;34783;34866;35368.93893183208;36009.279814404086;37264.627353726115;41268.55560055384;43493.78253108714;47281.76359118182;48001.75999119982;48198.51801482081;8131.837363252584;8178.304844088081;8310.626021828912;8418.915810842058;8750.781230469289;7642.197569255371;11881.762364752483;11891.524339026342;12107.455164517442;13228.801567976681;10885.564577416815;11078.11375090007;11246.606368777053;11309.69938457088;11333.659990200307;10757.139428845518;10767.192460565646;10852.403117828595;10886.129109671048;10889.673309800719;11128.332300062022;11219.60731374398;11405.087592992706;11592.942035290107;11743.11926605491;8434.915650843659;8541.53021583819;8569.82860342802;8599.441036332619;8643.956780216058;8817.823643527221;11187.384693841917;11686.88313116892;11700.122490813053;11758.764824703287 06:12:08 INFO - PROCESS | 4013 | |3;mootools.html;1366.6310096274012;1534.3325653340794;1546.737054700701;1714.6827836850184;1840.0615686000144;7264.963675181623;7888.2111788821085;8006.399520036006;8021.959890200548;8029.116797152323;7709.691612335514;7875.173106823787;7877.448578599486;7879.645415956282;7888.60556972152;1983.3752368004104;2259.5142044460395;2263.196565219348;2292.1862738727764;2338.6375111857687;2360.8229382796358;2371.632396978471;2374.608189648706;2387.0213212582844;2389.593769059264;2277.806386457153;2330.9883450582724;2331.522037982218;2333.4516388648653;2335.9182428615004;1949.210569719266;2222.5221577360862;2294.9196778112855;2297.4945511987335;2297.9655305170436;2167.7507086685077;2198;2206.735191776981;2206.9227577034726;2270.137347807839;7918.841623167505;7961;8093.676252949875;8175.5503447310375;8193.016837979421;4993.300937868701;5114.795408183668;5219.73901304937;5227.921581176285;5245.134552798783;3308.17295676081;3363.3441478911623;3424.9143771405666;3450.8447119879665;3451.8274086295582;1032.4889179855945;1046.283295942282;1099.367863478503;1100.944952752359;1101.7355834599718;11062.778744425146;11076.944615276952;11085.445727713583;11087;11095.223334366678;4509.481409637868;4537.0925814837165;4618.35343051973;4635.791389387486;4679.625629949596;9461.952690236505;9505.90494095064;9517.286203534763;9532.857007144898;9551.713448596553;4669.34629151919;5267.789288428497;5269.920951185735;5276.657017293864;5283.577313814885;4641.582257596832;4701.106789709944;4749.145153872267;4780.11567859947;4790.712557246577;3802.2775672622115;3819.1788765415567;3853.3064048470983;3919.666828319625;3929.390944403622;1272.52916420923;1275.7129645829614;1277.7125146841886;1288.5618889577402;1299.1815156451376;1031.5254982708038;1051.64244156987;1068.1508200980084;1069.1874175626424;1079.3469950679882;5802.303723553201;5983.341832398432;6017.638941663514;6119.816405507842;6156.199694039746;980.1081016275298;998.5356809083811;1001.2590682894751;1011.1506334678905;1039.8908114648004;3917.5298964123917;3998.4402183694306;4021.8190181441905;4060.127072679388;4064.4716186896108;10070.748231294276;10519.631812886511;10652.840207396895;10658.680239592824;10674.35953842772;10452.529636166391;10594.364338139736;10602.045815876609;10603.41681207541;10624.575016999233;7921.524708517507;7944.324732397811;8037;8051.5571643559;8077.838443231102;5620.831375058755;5729.770809167753;5771.509421699035;5898.852528686817;5900.527957763455;9458.574364153767;9557.283203759607;9646.517674116407;9835.16401105914;9847.45838978863;9718.271129665445;9760.365576237522;9859.556319965763;9890.307678462439;10037.046480584333;6310.2743184534365;6522.902156467751;6744.662766861736;6852.828679283058;6970.477214209056;8089.797755056171;8171.836563268583;8208.384371172306;8212.384071194803;8226.259636632733;6972.9302706972285;7073.504854660125;7221.45839062083;7317.19510853795;7325.816854578678;6964.268751781193;7012.649367531705;7127.216006239206;7169.139703235436;7238.674259658223;6528.21661400635;6659.900101498384;6765.627890466071;6778.4577233822165;6785.287544807724;5204.193350030751;5204.323437953042;5235.633505654568;5281.234221037851;5306.708131052829;5159.638825282194;5162.793488260428;5300.3639563252655;5319.973400132974;5392.784288628568 06:12:08 INFO - PROCESS | 4013 | |4;prototype.html;320.5896452540747;332.72051476759515;336.71042903103324;342.1173372698438;345.78215724093815;5122.564582010534;5176;5319.547838433733;5393.110136827424;5415;5205.739713014344;5270;5320.388155362135;5332.33345831771;5338.893222135555;4170.728902621335;4172.687048471377;4181.895452613679;4196.181744559812;4201.726887752294;3909.6090390960962;3990.2019596080754;4171.478565179353;4175.847235337316;4213.325867861143;4091.284025295576;4122.793860306988;4123.319652257389;4144.751314921099;4171.124063946575;4110.095778928646;4121.381792731085;4125.484314460692;4151.97924010381;4155.646770024551;3417.6582341765875;3663.19409729859;3666.156783939682;3677.3748462761127;3681.5582130144553;5055.562217691968;5100.668456550312;5106.948930510722;5107.821226257063;5113.284140220372;4680.204365257914;4687.273472611751;4698.530146985308;4709.952900470986;4723.102610503994;5390.865228369283;5478.877040087152;5541.501264886139;5575.8884822303735;5586.86032849182;3943.3296339622334;3944.2111577684577;3949.7037722170953;3954.228925359556;3967.1272320089533;5693.402192769782;5702.914456283159;5728.914066289009;5736.6558006519745;5792.594518383715;3989.601039896045;3992.6207010333974;4004.4794176756836;4013.6353639762037;4015.819288132041;3972.64246217836;4049.8785036448953;4057.411675307123;4065.1909900094765;4075.5924407559005;4635.466921304093;4636.582707556337;4647.651426142985;4653.278741795028;4669.7431641260055;5540.778368865281;5544.7782088716;5545.889082218414;5557.5831812614215;5567.916481252784;1350.7501112294258;1376.8640871281234;1414.6816966182528;1480.1267252320968;1489.5848943503715;969.5976169889417;974.9902500975041;978.2760757039739;992.7666998255404;993.2848349188573;5601.7759289628775;5628.71856407178;5650.97174514133;5662.85842853932;5666.716664166775;6029.427204415573;6034.969825150934;6053.303870054912;6060.969695151496;6074.119252708332;5134.974325128351;5383.461653834585;5447.863803404867;5580.525655319343;5617.859553511195;3254.7396208303753;3269.346130773855;3277.6886195811358;3285.7535684823733;3287.523309120164;6193.628382297076;6317.6209427434505;6353;6363.140975968277;6390.680465976682;6223.937760622426;6231.189945307081;6240.533474633457;6245.968770156211;6254.061890716429;6264.749410023639;6332.556721029576;6333.081703153109;6349.111124442582;6354.618722876549;5887.293524777054;6093.9085913712215;6124.29570599369;6130.295016073031;6131.325554188947;5999.370066142992;6043.969780151247;6072.332043475126;6093.268807742922;6104.542159338156;6102.481289090477;6268.341824108403;6285.842853928689;6322.399372059647;6358.904616430665;3812.866549670748;4192.023663199163;4192.350185721218;4215;4266.616004559604;5521.3926468087675;5572.637778544544;5580.540065159627;5614.382417934105;5620.072688006433;5619.634723743107;5629.4652008059165;5632.239647647515;5657.472482429804;5692.31692196939;5414.702191379354;5491.187907990274;5599.608027438203;5607.775688972395;5635.239242702347;5504.064593815441;5520.779168833202;5529.142982837667;5534;5538.723063846711;5579.9163012555655;5625.09998400254;5670.546356291569;5673.914891276551;5675.212308122928;5230.476952304739;5389.676619402849;5488;5504.559635229092;5514.5864060194845 06:12:08 INFO - PROCESS | 4013 | |5;yui.html;753.935915447187;772.1313522287427;789.3961119743398;795.4193438789683;810.9351251899849;14155.433782648695;14726;14979.475718349846;14982.400703971827;14998.02512836665;13258;13537.323133843318;13900.860991390084;13993.580192594212;14083.436662533511;844.6072576252056;852.7186028610574;858.3648100405686;859.0335872143838;859.1623167411786;708.3023222126202;822.0587427395628;848.4824257203101;848.9787755306136;850.7447765670305;882.9381943263974;883.425773247388;883.5449743382163;884.2528063786123;884.5046773806689;722.238038868993;871.3551971541077;873.7990262239689;874.711345256064;877.057163549184;625.859181684122;643.5430844100695;644.5713600455691;645.3675398109879;645.4481418387259;14197.503087391891;14237.501687440994;14333.42666293347;14334.856651433456;14366.138031718026;12398.62804115878;13150.079494435393;13335.333233338295;13866.722665546633;13942;11105.500252488657;11229.3262404256;11455.484503197293;11536;11554.364509951949;3806.333891568964;3841.481400010991;3849.7690138591774;3855.730098893079;3906.7655940643654;52014.73992630013;54144;55202.72398637981;55712;55755.16367254494;11013;11044.282121662067;11238.943805280922;11264.155188360906;11342.716432089264;19792.90103549502;19954;19996.300129495397;20073.498162545762;20077.397678069683;8259.752207433787;8292.58537073144;8432.325413966868;8628.094050124771;8668.046514883357;4708.458527269339;4765.571098601143;4803.375561177025;4849.733264670477;4902.534259245366;3449.8102604357;3511.2626348466597;3522.119470132467;3528.259065596202;3530.293941211768;621.9502439804804;624.1044101714054;638.9744410223632;639.9200099987502;643.4627086382923;697.888337865939;728.6029114132705;734.8750712378909;757.7007082202499;762.7902326860047;9448.716538503855;9619.807603847883;9713.9028609713;9860.260480463994;9872.555734991942;666.3569655282579;705.4708968273794;748.9438292128003;769.3076231391681;795.0896223823689;4276.337167739005;4319.784010799447;4323.3947247385395;4324.221640104812;4487.618552423015;60548.39451605516;60669.69665151646;61008;61068.38931610716;63729.681351592946;51029.74485127625;51566.226506602434;51963.74018129961;52535.999999999236;52653;48957.755211223004;49260.26109608359;49373.50626493761;49539.50460495421;50233.38409416664;8886.604215222904;8926.509042002492;9008.864867026869;9087.863682044906;9123.49820759838;33310.83344583261;33527.664723352456;33910.15224619404;34065.31869362549;34201.144971375914;39700.60299396969;40265;42472;42477.36283955805;42898.57101428946;12157.75684486323;12172.208806427909;12260.632181034583;12349.3825308736;12564.937175314066;13300.268485233406;13824.239666818421;13856.376463059389;14395;14516.346764395415;10379;12778;12943.870561294267;13421.597352079454;13724.794128087888;12505.374731263582;12564.87435125637;12677.30274834893;12841;13088.803667944798;11915.761684766083;12307.507699691912;12331.321777302335;13107.868921310665;13145.474181033034;10759.784804304027;11000.449977501254;11056.336619802838;11270.323780573191;11299.265547739371;11043.392613406018;11065.5020524075;11156;11327.71680707956;11438.828417573577 06:12:08 INFO - PROCESS | 4013 | __end_tp_report 06:12:08 INFO - PROCESS | 4013 | __start_cc_report 06:12:08 INFO - PROCESS | 4013 | _x_x_mozilla_cycle_collect,923 06:12:08 INFO - PROCESS | 4013 | __end_cc_report 06:12:08 INFO - PROCESS | 4013 | __startTimestamp1461849128972__endTimestamp 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | ------- Summary: start ------- 06:12:08 INFO - PROCESS | 4013 | Number of tests: 6 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#0] dojo.html Cycles:165 Average:5277.40 Median:5478.12 stddev:592.98 (10.8%) stddev-sans-first:568.94 06:12:08 INFO - PROCESS | 4013 | Values: 3069.5 3106.1 3144.1 3145.7 3180.8 5181.7 5270.4 5283.2 5302.3 5318.8 5266.1 5290.1 5303.5 5362.9 5431.7 4845.1 4867.1 4868.4 4878.1 4919.6 4886.6 4925.5 4951.1 4969.0 5000.6 4739.7 4806.2 4852.7 4911.3 4943.6 4846.6 4875.0 4879.2 4884.5 4920.2 4732.5 4747.9 4765.0 4765.6 4802.7 5131.4 5150.4 5187.9 5330.8 5334.0 5654.6 5655.0 5665.4 5684.2 5686.1 5661.9 5714.7 5727.8 5731.7 5731.8 5211.6 5309.3 5391.5 5424.4 5430.4 5799.1 5841.0 5842.3 5844.0 5892.6 5406.1 5583.6 5607.3 5608.5 5611.2 5525.3 5532.4 5534.0 5535.8 5538.5 5552.1 5653.2 5664.0 5667.0 5667.9 5559.5 5570.7 5612.4 5614.9 5618.0 4282.9 4284.3 4285.5 4311.1 4325.8 3777.8 3809.7 3843.9 3896.6 3931.6 5365.4 5369.7 5375.0 5379.4 5424.3 5479.0 5688.8 5693.4 5694.2 5694.6 5295.7 5354.3 5372.1 5418.1 5428.2 4889.9 4913.5 4915.9 4916.0 4960.9 5817.9 5819.5 5891.5 5901.3 5902.4 5733.9 5750.6 5753.1 5764.6 5799.7 5913.4 5920.8 5921.8 5926.8 5926.9 5415.6 5542.4 5622.1 5622.3 5648.4 5738.7 5740.7 5741.6 5742.6 5767.2 5570.4 5580.5 5582.7 5583.5 5586.8 5366.6 5512.7 5561.2 5626.0 5628.5 5460.0 5478.1 5484.3 5491.4 5499.8 5553.2 5580.1 5585.3 5591.5 5637.6 5308.7 5350.7 5449.9 5517.6 5543.8 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#1] ext.html Cycles:180 Average:43771.17 Median:38082.52 stddev:72951.74 (191.6%) stddev-sans-first:73084.30 06:12:08 INFO - PROCESS | 4013 | Values: 576.3 621.1 623.8 641.6 649.4 36786.0 38089.2 38141.0 38220.8 38261.0 38640.0 39137.8 39373.4 39430.4 39433.2 8405.8 8672.9 8680.3 8682.2 8682.6 8451.2 8561.7 8563.8 8732.5 8806.3 8737.9 8813.6 8816.4 8841.7 8849.5 8750.2 8766.8 8786.1 8814.6 8819.1 8627.4 8775.5 8782.0 8790.1 8793.0 38982.2 39297.2 39336.0 39534.0 39564.2 3579.5 3589.5 3751.4 3934.8 4206.9 30514.5 30525.4 30665.8 30732.0 30960.7 4152.9 4165.2 4233.5 4250.3 4260.6 250359.0 251751.0 252062.0 252248.0 252606.0 38681.2 53144.0 53843.5 53895.7 53953.7 50070.2 50909.5 50931.7 51009.2 51065.0 16345.8 16612.1 16626.4 16647.1 16653.5 10207.9 12408.3 12507.9 12582.5 12595.8 15019.3 15029.1 15216.2 15235.9 15335.2 5703.9 5840.8 5873.2 5877.7 5939.9 1015.3 1039.2 1042.4 1093.9 1154.9 30696.8 30958.0 31137.5 31235.8 31270.0 1091.7 1134.7 1174.1 1239.9 1272.3 14480.7 15416.3 15483.1 15612.6 15630.5 354568.0 355974.0 360502.0 360525.0 361398.0 50387.7 50838.7 50843.0 50909.7 50922.2 1290.1 1294.6 1341.7 1421.3 1520.1 27159.9 28083.9 28580.4 28901.9 28929.4 41193.6 41378.6 41739.0 41797.8 41844.4 201232.0 201746.0 201930.0 202188.0 202552.0 22346.3 24497.0 24770.0 25123.4 25365.7 38075.8 38138.2 44303.1 44327.0 44729.6 37905.0 38379.6 38408.4 38515.0 38583.6 37496.4 37732.8 37751.8 38072.8 38823.8 38071.8 38300.6 39397.6 39492.6 39554.4 31756.2 34004.5 34166.7 34218.1 34530.5 26634.9 26688.6 26859.3 26975.5 26987.3 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#2] jquery.html Cycles:180 Average:25707.63 Median:35117.47 stddev:74082.98 (211.0%) stddev-sans-first:74266.41 06:12:08 INFO - PROCESS | 4013 | Values: 389.4 393.5 394.7 400.4 402.6 16872.0 17292.4 17414.0 17428.2 18239.5 17565.4 18118.0 18511.2 18672.7 18677.4 5252.0 5374.4 5524.3 5536.4 5562.3 5480.8 5494.1 5526.6 5528.7 5530.0 5444.9 5500.7 5501.7 5506.1 5506.9 5390.7 5467.1 5483.3 5511.6 5513.9 5232.7 5310.9 5344.4 5436.2 5437.8 20490.5 21401.5 21462.5 21570.4 21946.1 2212.7 2310.7 2323.8 2394.7 2888.0 8235.5 9404.0 9438.0 9876.6 9916.3 1981.3 1995.0 1997.2 2040.2 2055.2 63459.0 65834.7 66557.0 66836.7 67380.7 10226.4 10350.6 10382.7 10579.4 10596.4 14581.6 14690.1 14698.8 14729.9 14744.6 7676.8 8018.4 8036.0 8140.3 8168.9 7791.5 7811.6 7904.4 7936.8 8010.8 4365.4 4565.5 4567.8 4597.7 4647.1 1909.7 1961.5 1972.8 1987.6 2004.2 939.0 1004.2 1004.9 1080.7 1118.2 17457.4 17566.0 17715.2 17918.6 18205.3 980.8 1029.1 1030.3 1031.4 1107.1 9848.0 10426.6 10450.3 10522.7 10567.7 427237.0 451056.7 456377.5 461977.0 469189.0 43941.6 48940.0 49008.0 76424.6 77625.0 935.9 1015.7 1017.8 1027.4 1053.0 15017.2 15409.6 15537.8 15861.5 16770.5 34783.0 34866.0 35368.9 36009.3 37264.6 41268.6 43493.8 47281.8 48001.8 48198.5 8131.8 8178.3 8310.6 8418.9 8750.8 7642.2 11881.8 11891.5 12107.5 13228.8 10885.6 11078.1 11246.6 11309.7 11333.7 10757.1 10767.2 10852.4 10886.1 10889.7 11128.3 11219.6 11405.1 11592.9 11743.1 8434.9 8541.5 8569.8 8599.4 8644.0 8817.8 11187.4 11686.9 11700.1 11758.8 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#3] mootools.html Cycles:180 Average:5539.67 Median:5054.05 stddev:3037.49 (60.1%) stddev-sans-first:3029.82 06:12:08 INFO - PROCESS | 4013 | Values: 1366.6 1534.3 1546.7 1714.7 1840.1 7265.0 7888.2 8006.4 8022.0 8029.1 7709.7 7875.2 7877.4 7879.6 7888.6 1983.4 2259.5 2263.2 2292.2 2338.6 2360.8 2371.6 2374.6 2387.0 2389.6 2277.8 2331.0 2331.5 2333.5 2335.9 1949.2 2222.5 2294.9 2297.5 2298.0 2167.8 2198.0 2206.7 2206.9 2270.1 7918.8 7961.0 8093.7 8175.6 8193.0 4993.3 5114.8 5219.7 5227.9 5245.1 3308.2 3363.3 3424.9 3450.8 3451.8 1032.5 1046.3 1099.4 1100.9 1101.7 11062.8 11076.9 11085.4 11087.0 11095.2 4509.5 4537.1 4618.4 4635.8 4679.6 9462.0 9505.9 9517.3 9532.9 9551.7 4669.3 5267.8 5269.9 5276.7 5283.6 4641.6 4701.1 4749.1 4780.1 4790.7 3802.3 3819.2 3853.3 3919.7 3929.4 1272.5 1275.7 1277.7 1288.6 1299.2 1031.5 1051.6 1068.2 1069.2 1079.3 5802.3 5983.3 6017.6 6119.8 6156.2 980.1 998.5 1001.3 1011.2 1039.9 3917.5 3998.4 4021.8 4060.1 4064.5 10070.7 10519.6 10652.8 10658.7 10674.4 10452.5 10594.4 10602.0 10603.4 10624.6 7921.5 7944.3 8037.0 8051.6 8077.8 5620.8 5729.8 5771.5 5898.9 5900.5 9458.6 9557.3 9646.5 9835.2 9847.5 9718.3 9760.4 9859.6 9890.3 10037.0 6310.3 6522.9 6744.7 6852.8 6970.5 8089.8 8171.8 8208.4 8212.4 8226.3 6972.9 7073.5 7221.5 7317.2 7325.8 6964.3 7012.6 7127.2 7169.1 7238.7 6528.2 6659.9 6765.6 6778.5 6785.3 5204.2 5204.3 5235.6 5281.2 5306.7 5159.6 5162.8 5300.4 5320.0 5392.8 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#4] prototype.html Cycles:180 Average:4775.68 Median:5431.43 stddev:1444.88 (26.6%) stddev-sans-first:1409.71 06:12:08 INFO - PROCESS | 4013 | Values: 320.6 332.7 336.7 342.1 345.8 5122.6 5176.0 5319.5 5393.1 5415.0 5205.7 5270.0 5320.4 5332.3 5338.9 4170.7 4172.7 4181.9 4196.2 4201.7 3909.6 3990.2 4171.5 4175.8 4213.3 4091.3 4122.8 4123.3 4144.8 4171.1 4110.1 4121.4 4125.5 4152.0 4155.6 3417.7 3663.2 3666.2 3677.4 3681.6 5055.6 5100.7 5106.9 5107.8 5113.3 4680.2 4687.3 4698.5 4710.0 4723.1 5390.9 5478.9 5541.5 5575.9 5586.9 3943.3 3944.2 3949.7 3954.2 3967.1 5693.4 5702.9 5728.9 5736.7 5792.6 3989.6 3992.6 4004.5 4013.6 4015.8 3972.6 4049.9 4057.4 4065.2 4075.6 4635.5 4636.6 4647.7 4653.3 4669.7 5540.8 5544.8 5545.9 5557.6 5567.9 1350.8 1376.9 1414.7 1480.1 1489.6 969.6 975.0 978.3 992.8 993.3 5601.8 5628.7 5651.0 5662.9 5666.7 6029.4 6035.0 6053.3 6061.0 6074.1 5135.0 5383.5 5447.9 5580.5 5617.9 3254.7 3269.3 3277.7 3285.8 3287.5 6193.6 6317.6 6353.0 6363.1 6390.7 6223.9 6231.2 6240.5 6246.0 6254.1 6264.7 6332.6 6333.1 6349.1 6354.6 5887.3 6093.9 6124.3 6130.3 6131.3 5999.4 6044.0 6072.3 6093.3 6104.5 6102.5 6268.3 6285.8 6322.4 6358.9 3812.9 4192.0 4192.4 4215.0 4266.6 5521.4 5572.6 5580.5 5614.4 5620.1 5619.6 5629.5 5632.2 5657.5 5692.3 5414.7 5491.2 5599.6 5607.8 5635.2 5504.1 5520.8 5529.1 5534.0 5538.7 5579.9 5625.1 5670.5 5673.9 5675.2 5230.5 5389.7 5488.0 5504.6 5514.6 06:12:08 INFO - PROCESS | 4013 | 06:12:08 INFO - PROCESS | 4013 | [#5] yui.html Cycles:180 Average:14682.45 Median:23609.18 stddev:16588.59 (70.3%) stddev-sans-first:16602.15 06:12:08 INFO - PROCESS | 4013 | Values: 753.9 772.1 789.4 795.4 810.9 14155.4 14726.0 14979.5 14982.4 14998.0 13258.0 13537.3 13900.9 13993.6 14083.4 844.6 852.7 858.4 859.0 859.2 708.3 822.1 848.5 849.0 850.7 882.9 883.4 883.5 884.3 884.5 722.2 871.4 873.8 874.7 877.1 625.9 643.5 644.6 645.4 645.4 14197.5 14237.5 14333.4 14334.9 14366.1 12398.6 13150.1 13335.3 13866.7 13942.0 11105.5 11229.3 11455.5 11536.0 11554.4 3806.3 3841.5 3849.8 3855.7 3906.8 52014.7 54144.0 55202.7 55712.0 55755.2 11013.0 11044.3 11238.9 11264.2 11342.7 19792.9 19954.0 19996.3 20073.5 20077.4 8259.8 8292.6 8432.3 8628.1 8668.0 4708.5 4765.6 4803.4 4849.7 4902.5 3449.8 3511.3 3522.1 3528.3 3530.3 622.0 624.1 639.0 639.9 643.5 697.9 728.6 734.9 757.7 762.8 9448.7 9619.8 9713.9 9860.3 9872.6 666.4 705.5 748.9 769.3 795.1 4276.3 4319.8 4323.4 4324.2 4487.6 60548.4 60669.7 61008.0 61068.4 63729.7 51029.7 51566.2 51963.7 52536.0 52653.0 48957.8 49260.3 49373.5 49539.5 50233.4 8886.6 8926.5 9008.9 9087.9 9123.5 33310.8 33527.7 33910.2 34065.3 34201.1 39700.6 40265.0 42472.0 42477.4 42898.6 12157.8 12172.2 12260.6 12349.4 12564.9 13300.3 13824.2 13856.4 14395.0 14516.3 10379.0 12778.0 12943.9 13421.6 13724.8 12505.4 12564.9 12677.3 12841.0 13088.8 11915.8 12307.5 12331.3 13107.9 13145.5 10759.8 11000.4 11056.3 11270.3 11299.3 11043.4 11065.5 11156.0 11327.7 11438.8 06:12:08 INFO - PROCESS | 4013 | -------- Summary: end -------- 06:12:08 INFO - PROCESS | 4013 | 06:12:09 INFO - TEST-INFO | 4013: exit 0 06:12:09 INFO - TEST-OK | dromaeo_css | took 1112162ms 06:12:09 INFO - TEST-START | kraken 06:12:09 INFO - operating with platform_type : linux_ 06:12:09 INFO - Initialising browser for kraken test... 06:12:09 INFO - TEST-INFO | started process 4192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRKbNO/profile http://localhost:37110/getInfo.html) 06:12:13 INFO - PROCESS | 4192 | __metrics Screen width/height:1600/1200 06:12:13 INFO - PROCESS | 4192 | colorDepth:24 06:12:13 INFO - PROCESS | 4192 | Browser inner width/height: 1024/697 06:12:13 INFO - PROCESS | 4192 | __metrics 06:12:14 ERROR - PROCESS | 4192 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:12:15 INFO - TEST-INFO | 4192: exit 0 06:12:15 INFO - Browser initialized. 06:12:15 INFO - Running cycle 1/1 for kraken test... 06:12:15 INFO - TEST-INFO | started process 4274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRKbNO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:27 INFO - PROCESS | 4274 | RSS: Main: 155025408 06:12:27 INFO - PROCESS | 4274 | 06:12:29 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37110/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:30 INFO - PROCESS | 4274 | RSS: Main: 209526784 06:12:30 INFO - PROCESS | 4274 | 06:12:33 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37110/tests/kraken/driver.html?testName=audio-dft) 06:12:33 INFO - PROCESS | 4274 | RSS: Main: 195489792 06:12:33 INFO - PROCESS | 4274 | 06:12:36 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37110/tests/kraken/driver.html?testName=audio-fft) 06:12:37 INFO - PROCESS | 4274 | RSS: Main: 265908224 06:12:37 INFO - PROCESS | 4274 | 06:12:39 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37110/tests/kraken/driver.html?testName=audio-oscillator) 06:12:40 INFO - PROCESS | 4274 | RSS: Main: 174075904 06:12:40 INFO - PROCESS | 4274 | 06:12:42 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:43 INFO - PROCESS | 4274 | RSS: Main: 178233344 06:12:43 INFO - PROCESS | 4274 | 06:12:45 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37110/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:46 INFO - PROCESS | 4274 | RSS: Main: 214544384 06:12:46 INFO - PROCESS | 4274 | 06:12:49 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37110/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:50 INFO - PROCESS | 4274 | RSS: Main: 215179264 06:12:50 INFO - PROCESS | 4274 | 06:12:53 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37110/tests/kraken/driver.html?testName=json-parse-financial) 06:12:53 INFO - PROCESS | 4274 | RSS: Main: 215347200 06:12:53 INFO - PROCESS | 4274 | 06:12:55 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:55 INFO - PROCESS | 4274 | RSS: Main: 204988416 06:12:55 INFO - PROCESS | 4274 | 06:12:57 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:58 INFO - PROCESS | 4274 | RSS: Main: 202952704 06:12:58 INFO - PROCESS | 4274 | 06:13:00 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:01 INFO - PROCESS | 4274 | RSS: Main: 216825856 06:13:01 INFO - PROCESS | 4274 | 06:13:03 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:04 INFO - PROCESS | 4274 | RSS: Main: 223739904 06:13:04 INFO - PROCESS | 4274 | 06:13:07 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:07 INFO - PROCESS | 4274 | RSS: Main: 221323264 06:13:07 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | Cycle 1(1): loaded http://localhost:37110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37110/tests/kraken/driver.html?testName=ai-astar) 06:13:09 INFO - PROCESS | 4274 | RSS: Main: 284463104 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | __start_tp_report 06:13:09 INFO - PROCESS | 4274 | _x_x_mozilla_page_load 06:13:09 INFO - PROCESS | 4274 | _x_x_mozilla_page_load_details 06:13:09 INFO - PROCESS | 4274 | |i|pagename|runs| 06:13:09 INFO - PROCESS | 4274 | |0;ai-astar;109;110;107;110;111;112;101;110;111;111 06:13:09 INFO - PROCESS | 4274 | |1;audio-beat-detection;165;126;156;179;139;161;151;130;178;125 06:13:09 INFO - PROCESS | 4274 | |2;audio-dft;161;162;160;160;160;160;161;159;161;161 06:13:09 INFO - PROCESS | 4274 | |3;audio-fft;76;74;133;113;76;73;74;109;98;73 06:13:09 INFO - PROCESS | 4274 | |4;audio-oscillator;92;93;148;92;92;93;157;92;91;149 06:13:09 INFO - PROCESS | 4274 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;117;116;117 06:13:09 INFO - PROCESS | 4274 | |6;imaging-darkroom;146;146;146;145;145;145;147;146;145;145 06:13:09 INFO - PROCESS | 4274 | |7;imaging-desaturate;94;95;94;94;95;94;95;95;95;95 06:13:09 INFO - PROCESS | 4274 | |8;json-parse-financial;55;55;57;55;57;58;65;71;54;55 06:13:09 INFO - PROCESS | 4274 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;61;67;62 06:13:09 INFO - PROCESS | 4274 | |10;stanford-crypto-aes;76;77;75;76;78;77;79;87;78;78 06:13:09 INFO - PROCESS | 4274 | |11;stanford-crypto-ccm;132;125;124;125;127;123;136;124;159;138 06:13:09 INFO - PROCESS | 4274 | |12;stanford-crypto-pbkdf2;199;208;196;198;201;198;201;196;204;198 06:13:09 INFO - PROCESS | 4274 | |13;stanford-crypto-sha256-iterative;70;72;69;70;69;69;70;68;69;69 06:13:09 INFO - PROCESS | 4274 | __end_tp_report 06:13:09 INFO - PROCESS | 4274 | __start_cc_report 06:13:09 INFO - PROCESS | 4274 | _x_x_mozilla_cycle_collect,1655 06:13:09 INFO - PROCESS | 4274 | __end_cc_report 06:13:09 INFO - PROCESS | 4274 | __startTimestamp1461849189868__endTimestamp 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | ------- Summary: start ------- 06:13:09 INFO - PROCESS | 4274 | Number of tests: 14 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.19 (2.9%) stddev-sans-first:3.38 06:13:09 INFO - PROCESS | 4274 | Values: 109.0 110.0 107.0 110.0 111.0 112.0 101.0 110.0 111.0 111.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.50 stddev:20.33 (12.8%) stddev-sans-first:20.92 06:13:09 INFO - PROCESS | 4274 | Values: 165.0 126.0 156.0 179.0 139.0 161.0 151.0 130.0 178.0 125.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 06:13:09 INFO - PROCESS | 4274 | Values: 161.0 162.0 160.0 160.0 160.0 160.0 161.0 159.0 161.0 161.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#3] audio-fft Cycles:10 Average:89.90 Median:74.00 stddev:21.82 (29.5%) stddev-sans-first:22.56 06:13:09 INFO - PROCESS | 4274 | Values: 76.0 74.0 133.0 113.0 76.0 73.0 74.0 109.0 98.0 73.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.00 stddev:28.69 (31.2%) stddev-sans-first:29.69 06:13:09 INFO - PROCESS | 4274 | Values: 92.0 93.0 148.0 92.0 92.0 93.0 157.0 92.0 91.0 149.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 06:13:09 INFO - PROCESS | 4274 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:13:09 INFO - PROCESS | 4274 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:13:09 INFO - PROCESS | 4274 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:5.49 (9.6%) stddev-sans-first:5.70 06:13:09 INFO - PROCESS | 4274 | Values: 55.0 55.0 57.0 55.0 57.0 58.0 65.0 71.0 54.0 55.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.50 stddev:1.85 (3.0%) stddev-sans-first:1.94 06:13:09 INFO - PROCESS | 4274 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 67.0 62.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:3.35 (4.3%) stddev-sans-first:3.46 06:13:09 INFO - PROCESS | 4274 | Values: 76.0 77.0 75.0 76.0 78.0 77.0 79.0 87.0 78.0 78.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.50 stddev:11.10 (8.6%) stddev-sans-first:11.77 06:13:09 INFO - PROCESS | 4274 | Values: 132.0 125.0 124.0 125.0 127.0 123.0 136.0 124.0 159.0 138.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.90 Median:200.00 stddev:3.75 (1.9%) stddev-sans-first:3.97 06:13:09 INFO - PROCESS | 4274 | Values: 199.0 208.0 196.0 198.0 201.0 198.0 201.0 196.0 204.0 198.0 06:13:09 INFO - PROCESS | 4274 | 06:13:09 INFO - PROCESS | 4274 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 06:13:09 INFO - PROCESS | 4274 | Values: 70.0 72.0 69.0 70.0 69.0 69.0 70.0 68.0 69.0 69.0 06:13:09 INFO - PROCESS | 4274 | -------- Summary: end -------- 06:13:09 INFO - PROCESS | 4274 | 06:13:10 INFO - TEST-INFO | 4274: exit 0 06:13:10 INFO - TEST-OK | kraken | took 61103ms 06:13:10 INFO - SUITE-END | took 1173s 06:13:11 INFO - Completed test suite (00:19:33) 06:13:11 INFO - javascript benchmark 06:13:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.4628440022993, 3106.0992312229455, 3144.103930379842, 3145.6697046810086, 3180.793248438852, 5181.740912954356, 5270.367555893288, 5283.2075188721665, 5302.3106996090455, 5318.76065577049, 5266.052110620087, 5290.127129023706, 5303.522682958533, 5362.865928351784, 5431.701256430894, 4845.127876982142, 4867.050925069595, 4868.391451068616, 4878.146324393235, 4919.557239848413, 4886.63350248731, 4925.507449255082, 4951.133551628469, 4968.975155124219, 5000.574951129159, 4739.668223224376, 4806.182948898678, 4852.660313778037, 4911.336969509106, 4943.604511639078, 4846.6365022623095, 4875.049365373754, 4879.219324907997, 4884.511548845123, 4920.1635721927005, 4732.455767586737, 4747.857564273043, 4764.952350476486, 4765.594924431392, 4802.735849528274, 5131.384233891957, 5150.4334523202415, 5187.896242075175, 5330.786768529254, 5334.03987282289, 5654.6324488908085, 5654.9717251413895, 5665.433456654343, 5684.175794509814, 5686.090225563931, 5661.886762264773, 5714.685692286923, 5727.770889164429, 5731.656100633933, 5731.828045158611, 5211.557017653466, 5309.33633295838, 5391.514763671288, 5424.376196737387, 5430.402655707869, 5799.101139323411, 5840.970795146082, 5842.269716285465, 5843.970780146072, 5892.558058145656, 5406.08096623575, 5583.609147359646, 5607.271054762855, 5608.495235428831, 5611.242482264842, 5525.309336332958, 5532.3637781655625, 5533.972330138324, 5535.806246781343, 5538.47384498472, 5552.056150454432, 5653.180288858092, 5664.037113690682, 5667.036603777286, 5667.8866422672145, 5559.471850174308, 5570.6657600544095, 5612.410696876851, 5614.9157762633595, 5618.0, 4282.850100246476, 4284.271673815459, 4285.507166675872, 4311.094670119247, 4325.76208308546, 3777.792221427848, 3809.7333186676665, 3843.9231215375535, 3896.649301562873, 3931.64615184629, 5365.38298095724, 5369.650972686841, 5374.973125134349, 5379.35447746273, 5424.349078110573, 5478.972605136949, 5688.77244910199, 5693.373728889819, 5694.174344719992, 5694.629849059798, 5295.6822590643915, 5354.330708661418, 5372.140457526777, 5418.106012507892, 5428.240046393508, 4889.877753056202, 4913.459519452857, 4915.926261106087, 4916.0, 4960.8759781005765, 5817.854553636193, 5819.4762471376935, 5891.528677705774, 5901.262342207224, 5902.350741418526, 5733.913991290217, 5750.568707347049, 5753.108268218432, 5764.625299355528, 5799.710014499174, 5913.438223368773, 5920.763169473173, 5921.792737254175, 5926.762929482772, 5926.881462370815, 5415.5938304626525, 5542.445755424425, 5622.128570071645, 5622.269105016485, 5648.406917273627, 5738.655680659173, 5740.68426236561, 5741.62679425836, 5742.59801813869, 5767.192593036894, 5570.359408667893, 5580.525655319181, 5582.748776304995, 5583.525400341016, 5586.804461843816, 5366.570674345965, 5512.6968016759465, 5561.221428999862, 5626.043572592751, 5628.465295796893, 5460.044492213926, 5478.123500239943, 5484.341878974548, 5491.423400542885, 5499.780008799603, 5553.16702494629, 5580.135079062752, 5585.301837270341, 5591.524720398812, 5637.633553818989, 5308.681479111111, 5350.705711185922, 5449.863753406196, 5517.5585953124455, 5543.833684989457], "value": 5238.002720504041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3228206856942, 621.1366200980636, 623.8128561431571, 641.563736659072, 649.4122818848938, 36786.0, 38089.23821523568, 38141.0, 38220.80889595555, 38261.0, 38640.0, 39137.804310978405, 39373.40939885904, 39430.408543871796, 39433.21133577334, 8405.789855253623, 8672.913270867306, 8680.348973826956, 8682.175193356621, 8682.6092825823, 8451.197136272074, 8561.700340488083, 8563.785905352384, 8732.476051436934, 8806.295496360275, 8737.868931966026, 8813.559322033905, 8816.426932249384, 8841.690540831072, 8849.513276769776, 8750.168733970262, 8766.824663506693, 8786.121387861227, 8814.559272036373, 8819.118088191193, 8627.439216450974, 8775.517346545937, 8782.0, 8790.077041910572, 8792.956035219782, 38982.220355592726, 39297.214055719014, 39336.0, 39534.0, 39564.20871582552, 3579.5167652367118, 3589.4974703541525, 3751.381022131345, 3934.783586902719, 4206.8737937861915, 30514.54228186579, 30525.38949221025, 30665.846670766725, 30732.0, 30960.690393096007, 4152.875413737593, 4165.229432554987, 4233.456229441385, 4250.256205164115, 4260.637845783112, 250359.0, 251751.0, 252062.0, 252247.99999999817, 252606.0, 38681.22637547233, 53144.0, 53843.46156538463, 53895.73052134793, 53953.73023134859, 50070.248946265834, 50909.490905090475, 50931.745341273054, 51009.23486147711, 51065.0, 16345.754813677804, 16612.08633525168, 16626.418075367303, 16647.084410357547, 16653.50039498817, 10207.897921020694, 12408.317542535247, 12507.936825369763, 12582.496700132075, 12595.811062834066, 15019.324130414157, 15029.098254104789, 15216.239188040776, 15235.92382038105, 15335.233238338038, 5703.914441283384, 5840.8247752567495, 5873.177755114288, 5877.67752255739, 5939.910901336483, 1015.2943704125562, 1039.2050081687514, 1042.3954106618144, 1093.9398333091597, 1154.8556430446195, 30696.84651576728, 30958.0, 31137.532937005963, 31235.843820780752, 31270.0, 1091.7270682329417, 1134.7163209197702, 1174.142875700726, 1239.910750385585, 1272.2620879889641, 14480.740614982049, 15416.306266218047, 15483.148426836633, 15612.609684757745, 15630.45293414725, 354568.0, 355974.0, 360502.0, 360525.0, 361398.0, 50387.74806125946, 50838.74580627073, 50843.0, 50909.74545127251, 50922.23616645753, 1290.1098242213031, 1294.6375014995817, 1341.6578772412777, 1421.289355322339, 1520.118331367804, 27159.86420067966, 28083.859580701966, 28580.42839143164, 28901.855490722413, 28929.42141157207, 41193.58806412017, 41378.586214137475, 41739.0, 41797.79101104475, 41844.3723344144, 201232.0, 201746.0, 201930.0, 202188.0, 202552.0, 22346.329610111723, 24497.0, 24770.0, 25123.357113218848, 25365.74634253634, 38075.80962095172, 38138.23723525569, 44303.11393772171, 44327.0, 44729.55270447254, 37905.0, 38379.616203837606, 38408.423873642474, 38515.0, 38583.614163858, 37496.43755343727, 37732.811335943145, 37751.81124094362, 38072.80963595275, 38823.805880970416, 38071.809640951615, 38300.6169938297, 39397.60602393939, 39492.60507394889, 39554.40668390034, 31756.206094847814, 34004.48993265152, 34166.65833341734, 34218.14454638654, 34530.48204276988, 26634.866825665747, 26688.59967100534, 26859.32851678724, 26975.46049079047, 26987.325316867235], "value": 18119.612288174478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.41198789827354, 393.468817096919, 394.7276379298284, 400.35742633073914, 402.621535756389, 16872.0, 17292.394766183184, 17414.0, 17428.215730292137, 18239.452816415494, 17565.385211517598, 18118.0, 18511.16699748511, 18672.71990920134, 18677.439676809718, 5252.0, 5374.435684253156, 5524.254225679542, 5536.446355364452, 5562.276904002474, 5480.808171713991, 5494.066008778497, 5526.58550608704, 5528.668279903199, 5530.0, 5444.945550544483, 5500.697461639628, 5501.697406642633, 5506.091494903356, 5506.91739623906, 5390.676559406428, 5467.0705979983495, 5483.287172667528, 5511.641743286674, 5513.889722205554, 5232.7122008289525, 5310.867228319285, 5344.438833922421, 5436.184572314145, 5437.8368648940595, 20490.487737806525, 21401.464963376042, 21462.463438414008, 21570.35288941334, 21946.122155113775, 2212.6680997850453, 2310.7342655594653, 2323.7560056194193, 2394.688690470245, 2887.9613748797974, 8235.50586964784, 9404.0, 9438.0, 9876.555555000043, 9916.305858589902, 1981.3362523554626, 1994.950126246841, 1997.221083777328, 2040.2247146084394, 2055.2498338106634, 63459.0, 65834.67082664555, 66557.0, 66836.6658166706, 67380.66309668469, 10226.437545934896, 10350.585976560853, 10382.688519344432, 10579.36523808574, 10596.417197054236, 14581.635459113395, 14690.11859288446, 14698.779518307234, 14729.92635036818, 14744.631384215267, 7676.80807979805, 8018.398620103516, 8036.035675718951, 8140.267375936194, 8168.9183108169345, 7791.4935529190425, 7811.570363630055, 7904.4071694623135, 7936.84126317482, 8010.799730006796, 4365.3670217818235, 4565.452145742465, 4567.771611419482, 4597.747123908217, 4647.140279048387, 1909.694448888171, 1961.5194277401843, 1972.8224459798687, 1987.642224399622, 2004.2183548416128, 939.0, 1004.1565085328359, 1004.914582260516, 1080.7352198711367, 1118.183725880112, 17457.381193376386, 17566.03386813712, 17715.202815873316, 17918.55203619894, 18205.27178912855, 980.8479685648736, 1029.1098200056897, 1030.314840630987, 1031.3966329697062, 1107.0755918807724, 9848.012178991326, 10426.635067772744, 10450.268481206394, 10522.73693157662, 10567.682969510926, 427237.0, 451056.7447162743, 456377.46698211617, 461977.0, 469189.0, 43941.560584394385, 48940.0, 49008.0, 76424.61787691138, 77625.0, 935.8970513243673, 1015.6546774096843, 1017.760826205841, 1027.4041056187393, 1053.0364716284514, 15017.249137543298, 15409.614759631098, 15537.84462155364, 15861.52415427539, 16770.496885093467, 34783.0, 34866.0, 35368.93893183208, 36009.279814404086, 37264.627353726115, 41268.55560055384, 43493.78253108714, 47281.76359118182, 48001.75999119982, 48198.51801482081, 8131.837363252584, 8178.304844088081, 8310.626021828912, 8418.915810842058, 8750.781230469289, 7642.197569255371, 11881.762364752483, 11891.524339026342, 12107.455164517442, 13228.801567976681, 10885.564577416815, 11078.11375090007, 11246.606368777053, 11309.69938457088, 11333.659990200307, 10757.139428845518, 10767.192460565646, 10852.403117828595, 10886.129109671048, 10889.673309800719, 11128.332300062022, 11219.60731374398, 11405.087592992706, 11592.942035290107, 11743.11926605491, 8434.915650843659, 8541.53021583819, 8569.82860342802, 8599.441036332619, 8643.956780216058, 8817.823643527221, 11187.384693841917, 11686.88313116892, 11700.122490813053, 11758.764824703287], "value": 8666.882465493523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.6310096274012, 1534.3325653340794, 1546.737054700701, 1714.6827836850184, 1840.0615686000144, 7264.963675181623, 7888.2111788821085, 8006.399520036006, 8021.959890200548, 8029.116797152323, 7709.691612335514, 7875.173106823787, 7877.448578599486, 7879.645415956282, 7888.60556972152, 1983.3752368004104, 2259.5142044460395, 2263.196565219348, 2292.1862738727764, 2338.6375111857687, 2360.8229382796358, 2371.632396978471, 2374.608189648706, 2387.0213212582844, 2389.593769059264, 2277.806386457153, 2330.9883450582724, 2331.522037982218, 2333.4516388648653, 2335.9182428615004, 1949.210569719266, 2222.5221577360862, 2294.9196778112855, 2297.4945511987335, 2297.9655305170436, 2167.7507086685077, 2198.0, 2206.735191776981, 2206.9227577034726, 2270.137347807839, 7918.841623167505, 7961.0, 8093.676252949875, 8175.5503447310375, 8193.016837979421, 4993.300937868701, 5114.795408183668, 5219.73901304937, 5227.921581176285, 5245.134552798783, 3308.17295676081, 3363.3441478911623, 3424.9143771405666, 3450.8447119879665, 3451.8274086295582, 1032.4889179855945, 1046.283295942282, 1099.367863478503, 1100.944952752359, 1101.7355834599718, 11062.778744425146, 11076.944615276952, 11085.445727713583, 11087.0, 11095.223334366678, 4509.481409637868, 4537.0925814837165, 4618.35343051973, 4635.791389387486, 4679.625629949596, 9461.952690236505, 9505.90494095064, 9517.286203534763, 9532.857007144898, 9551.713448596553, 4669.34629151919, 5267.789288428497, 5269.920951185735, 5276.657017293864, 5283.577313814885, 4641.582257596832, 4701.106789709944, 4749.145153872267, 4780.11567859947, 4790.712557246577, 3802.2775672622115, 3819.1788765415567, 3853.3064048470983, 3919.666828319625, 3929.390944403622, 1272.52916420923, 1275.7129645829614, 1277.7125146841886, 1288.5618889577402, 1299.1815156451376, 1031.5254982708038, 1051.64244156987, 1068.1508200980084, 1069.1874175626424, 1079.3469950679882, 5802.303723553201, 5983.341832398432, 6017.638941663514, 6119.816405507842, 6156.199694039746, 980.1081016275298, 998.5356809083811, 1001.2590682894751, 1011.1506334678905, 1039.8908114648004, 3917.5298964123917, 3998.4402183694306, 4021.8190181441905, 4060.127072679388, 4064.4716186896108, 10070.748231294276, 10519.631812886511, 10652.840207396895, 10658.680239592824, 10674.35953842772, 10452.529636166391, 10594.364338139736, 10602.045815876609, 10603.41681207541, 10624.575016999233, 7921.524708517507, 7944.324732397811, 8037.0, 8051.5571643559, 8077.838443231102, 5620.831375058755, 5729.770809167753, 5771.509421699035, 5898.852528686817, 5900.527957763455, 9458.574364153767, 9557.283203759607, 9646.517674116407, 9835.16401105914, 9847.45838978863, 9718.271129665445, 9760.365576237522, 9859.556319965763, 9890.307678462439, 10037.046480584333, 6310.2743184534365, 6522.902156467751, 6744.662766861736, 6852.828679283058, 6970.477214209056, 8089.797755056171, 8171.836563268583, 8208.384371172306, 8212.384071194803, 8226.259636632733, 6972.9302706972285, 7073.504854660125, 7221.45839062083, 7317.19510853795, 7325.816854578678, 6964.268751781193, 7012.649367531705, 7127.216006239206, 7169.139703235436, 7238.674259658223, 6528.21661400635, 6659.900101498384, 6765.627890466071, 6778.4577233822165, 6785.287544807724, 5204.193350030751, 5204.323437953042, 5235.633505654568, 5281.234221037851, 5306.708131052829, 5159.638825282194, 5162.793488260428, 5300.3639563252655, 5319.973400132974, 5392.784288628568], "value": 4506.5563027813705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.5896452540747, 332.72051476759515, 336.71042903103324, 342.1173372698438, 345.78215724093815, 5122.564582010534, 5176.0, 5319.547838433733, 5393.110136827424, 5415.0, 5205.739713014344, 5270.0, 5320.388155362135, 5332.33345831771, 5338.893222135555, 4170.728902621335, 4172.687048471377, 4181.895452613679, 4196.181744559812, 4201.726887752294, 3909.6090390960962, 3990.2019596080754, 4171.478565179353, 4175.847235337316, 4213.325867861143, 4091.284025295576, 4122.793860306988, 4123.319652257389, 4144.751314921099, 4171.124063946575, 4110.095778928646, 4121.381792731085, 4125.484314460692, 4151.97924010381, 4155.646770024551, 3417.6582341765875, 3663.19409729859, 3666.156783939682, 3677.3748462761127, 3681.5582130144553, 5055.562217691968, 5100.668456550312, 5106.948930510722, 5107.821226257063, 5113.284140220372, 4680.204365257914, 4687.273472611751, 4698.530146985308, 4709.952900470986, 4723.102610503994, 5390.865228369283, 5478.877040087152, 5541.501264886139, 5575.8884822303735, 5586.86032849182, 3943.3296339622334, 3944.2111577684577, 3949.7037722170953, 3954.228925359556, 3967.1272320089533, 5693.402192769782, 5702.914456283159, 5728.914066289009, 5736.6558006519745, 5792.594518383715, 3989.601039896045, 3992.6207010333974, 4004.4794176756836, 4013.6353639762037, 4015.819288132041, 3972.64246217836, 4049.8785036448953, 4057.411675307123, 4065.1909900094765, 4075.5924407559005, 4635.466921304093, 4636.582707556337, 4647.651426142985, 4653.278741795028, 4669.7431641260055, 5540.778368865281, 5544.7782088716, 5545.889082218414, 5557.5831812614215, 5567.916481252784, 1350.7501112294258, 1376.8640871281234, 1414.6816966182528, 1480.1267252320968, 1489.5848943503715, 969.5976169889417, 974.9902500975041, 978.2760757039739, 992.7666998255404, 993.2848349188573, 5601.7759289628775, 5628.71856407178, 5650.97174514133, 5662.85842853932, 5666.716664166775, 6029.427204415573, 6034.969825150934, 6053.303870054912, 6060.969695151496, 6074.119252708332, 5134.974325128351, 5383.461653834585, 5447.863803404867, 5580.525655319343, 5617.859553511195, 3254.7396208303753, 3269.346130773855, 3277.6886195811358, 3285.7535684823733, 3287.523309120164, 6193.628382297076, 6317.6209427434505, 6353.0, 6363.140975968277, 6390.680465976682, 6223.937760622426, 6231.189945307081, 6240.533474633457, 6245.968770156211, 6254.061890716429, 6264.749410023639, 6332.556721029576, 6333.081703153109, 6349.111124442582, 6354.618722876549, 5887.293524777054, 6093.9085913712215, 6124.29570599369, 6130.295016073031, 6131.325554188947, 5999.370066142992, 6043.969780151247, 6072.332043475126, 6093.268807742922, 6104.542159338156, 6102.481289090477, 6268.341824108403, 6285.842853928689, 6322.399372059647, 6358.904616430665, 3812.866549670748, 4192.023663199163, 4192.350185721218, 4215.0, 4266.616004559604, 5521.3926468087675, 5572.637778544544, 5580.540065159627, 5614.382417934105, 5620.072688006433, 5619.634723743107, 5629.4652008059165, 5632.239647647515, 5657.472482429804, 5692.31692196939, 5414.702191379354, 5491.187907990274, 5599.608027438203, 5607.775688972395, 5635.239242702347, 5504.064593815441, 5520.779168833202, 5529.142982837667, 5534.0, 5538.723063846711, 5579.9163012555655, 5625.09998400254, 5670.546356291569, 5673.914891276551, 5675.212308122928, 5230.476952304739, 5389.676619402849, 5488.0, 5504.559635229092, 5514.5864060194845], "value": 4318.598517487394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.935915447187, 772.1313522287427, 789.3961119743398, 795.4193438789683, 810.9351251899849, 14155.433782648695, 14726.0, 14979.475718349846, 14982.400703971827, 14998.02512836665, 13258.0, 13537.323133843318, 13900.860991390084, 13993.580192594212, 14083.436662533511, 844.6072576252056, 852.7186028610574, 858.3648100405686, 859.0335872143838, 859.1623167411786, 708.3023222126202, 822.0587427395628, 848.4824257203101, 848.9787755306136, 850.7447765670305, 882.9381943263974, 883.425773247388, 883.5449743382163, 884.2528063786123, 884.5046773806689, 722.238038868993, 871.3551971541077, 873.7990262239689, 874.711345256064, 877.057163549184, 625.859181684122, 643.5430844100695, 644.5713600455691, 645.3675398109879, 645.4481418387259, 14197.503087391891, 14237.501687440994, 14333.42666293347, 14334.856651433456, 14366.138031718026, 12398.62804115878, 13150.079494435393, 13335.333233338295, 13866.722665546633, 13942.0, 11105.500252488657, 11229.3262404256, 11455.484503197293, 11536.0, 11554.364509951949, 3806.333891568964, 3841.481400010991, 3849.7690138591774, 3855.730098893079, 3906.7655940643654, 52014.73992630013, 54144.0, 55202.72398637981, 55712.0, 55755.16367254494, 11013.0, 11044.282121662067, 11238.943805280922, 11264.155188360906, 11342.716432089264, 19792.90103549502, 19954.0, 19996.300129495397, 20073.498162545762, 20077.397678069683, 8259.752207433787, 8292.58537073144, 8432.325413966868, 8628.094050124771, 8668.046514883357, 4708.458527269339, 4765.571098601143, 4803.375561177025, 4849.733264670477, 4902.534259245366, 3449.8102604357, 3511.2626348466597, 3522.119470132467, 3528.259065596202, 3530.293941211768, 621.9502439804804, 624.1044101714054, 638.9744410223632, 639.9200099987502, 643.4627086382923, 697.888337865939, 728.6029114132705, 734.8750712378909, 757.7007082202499, 762.7902326860047, 9448.716538503855, 9619.807603847883, 9713.9028609713, 9860.260480463994, 9872.555734991942, 666.3569655282579, 705.4708968273794, 748.9438292128003, 769.3076231391681, 795.0896223823689, 4276.337167739005, 4319.784010799447, 4323.3947247385395, 4324.221640104812, 4487.618552423015, 60548.39451605516, 60669.69665151646, 61008.0, 61068.38931610716, 63729.681351592946, 51029.74485127625, 51566.226506602434, 51963.74018129961, 52535.999999999236, 52653.0, 48957.755211223004, 49260.26109608359, 49373.50626493761, 49539.50460495421, 50233.38409416664, 8886.604215222904, 8926.509042002492, 9008.864867026869, 9087.863682044906, 9123.49820759838, 33310.83344583261, 33527.664723352456, 33910.15224619404, 34065.31869362549, 34201.144971375914, 39700.60299396969, 40265.0, 42472.0, 42477.36283955805, 42898.57101428946, 12157.75684486323, 12172.208806427909, 12260.632181034583, 12349.3825308736, 12564.937175314066, 13300.268485233406, 13824.239666818421, 13856.376463059389, 14395.0, 14516.346764395415, 10379.0, 12778.0, 12943.870561294267, 13421.597352079454, 13724.794128087888, 12505.374731263582, 12564.87435125637, 12677.30274834893, 12841.0, 13088.803667944798, 11915.761684766083, 12307.507699691912, 12331.321777302335, 13107.868921310665, 13145.474181033034, 10759.784804304027, 11000.449977501254, 11056.336619802838, 11270.323780573191, 11299.265547739371, 11043.392613406018, 11065.5020524075, 11156.0, 11327.71680707956, 11438.828417573577], "value": 6807.808768628392, "unit": "score"}], "name": "dromaeo_css", "value": 6911.445142049784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 107.0, 110.0, 111.0, 112.0, 101.0, 110.0, 111.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 126.0, 156.0, 179.0, 139.0, 161.0, 151.0, 130.0, 178.0, 125.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 160.0, 160.0, 161.0, 159.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 133.0, 113.0, 76.0, 73.0, 74.0, 109.0, 98.0, 73.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 92.0, 92.0, 93.0, 157.0, 92.0, 91.0, 149.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 57.0, 58.0, 65.0, 71.0, 54.0, 55.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 67.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 76.0, 78.0, 77.0, 79.0, 87.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 124.0, 125.0, 127.0, 123.0, 136.0, 124.0, 159.0, 138.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 208.0, 196.0, 198.0, 201.0, 198.0, 201.0, 196.0, 204.0, 198.0], "value": 199.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 70.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1576.6000000000001, "alertThreshold": 2.0}]} 06:13:11 INFO - Return code: 0 06:13:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:11 ERROR - # TBPL SUCCESS # 06:13:11 INFO - Running post-action listener: _resource_record_post_action 06:13:11 INFO - Running post-run listener: _resource_record_post_run 06:13:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 434176; Write bytes: 287903744; Read time: 328; Write time: 252480 06:13:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1257472; Read time: 0; Write time: 76 06:13:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 434176; Write bytes: 286646272; Read time: 328; Write time: 252404 06:13:12 INFO - Running post-run listener: _upload_blobber_files 06:13:12 INFO - Blob upload gear active. 06:13:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:12 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 06:13:12 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:12 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:12 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:13 INFO - (blobuploader) - INFO - Done attempting. 06:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:15 INFO - (blobuploader) - INFO - Done attempting. 06:13:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:15 INFO - Return code: 0 06:13:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981e1ab7b8d004661b741425bcc3f5046594d45ba34799c1baf85723e8f40ccc712a91b3024bba9e0018e53b72eb1e82568eae5213c5c888a8a104e27f4b9684", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc257f5ac55c29de594c3de9bc7abdf604e0ac95201096672cc53c66fa3577b5d5aa5e7375244bd8750cc9033e0a4a47e7d6dbbcc0b5ca0de8582f75c2a35853"} 06:13:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:15 INFO - Contents: 06:13:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981e1ab7b8d004661b741425bcc3f5046594d45ba34799c1baf85723e8f40ccc712a91b3024bba9e0018e53b72eb1e82568eae5213c5c888a8a104e27f4b9684", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc257f5ac55c29de594c3de9bc7abdf604e0ac95201096672cc53c66fa3577b5d5aa5e7375244bd8750cc9033e0a4a47e7d6dbbcc0b5ca0de8582f75c2a35853"} 06:13:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:15 INFO - Copying logs to upload dir... 06:13:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.515148 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-28 06:13:15.275542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 06:13:15.279471) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 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/sha512/981e1ab7b8d004661b741425bcc3f5046594d45ba34799c1baf85723e8f40ccc712a91b3024bba9e0018e53b72eb1e82568eae5213c5c888a8a104e27f4b9684", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc257f5ac55c29de594c3de9bc7abdf604e0ac95201096672cc53c66fa3577b5d5aa5e7375244bd8750cc9033e0a4a47e7d6dbbcc0b5ca0de8582f75c2a35853"} build_url:https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/W1Z0qIP1Rhy9NgeeEdZPqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981e1ab7b8d004661b741425bcc3f5046594d45ba34799c1baf85723e8f40ccc712a91b3024bba9e0018e53b72eb1e82568eae5213c5c888a8a104e27f4b9684", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc257f5ac55c29de594c3de9bc7abdf604e0ac95201096672cc53c66fa3577b5d5aa5e7375244bd8750cc9033e0a4a47e7d6dbbcc0b5ca0de8582f75c2a35853"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 06:13:15.306182) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 06:13:15.306545) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461846541.636821-1252512533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 06:13:15.391720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 06:13:15.392057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 06:13:15.392407) ========= ========= Total master_lag: 0.20 =========