builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1464339438.45 results: success (0) buildid: 20160526231045 builduid: f205f9222a3b4fb79c1695d436806960 revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.450026) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.450517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.450831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.466316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.466724) ========= 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=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 01:57:18-- 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% 225M=0s 2016-05-27 01:57:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097538 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.582385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.582698) ========= 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=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013718 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:18.634231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 01:57:18.634815) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9cbc4f2d34a30255c3a093f6005f87b453491a7a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9cbc4f2d34a30255c3a093f6005f87b453491a7a --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=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 01:57:18,937 truncating revision to first 12 chars 2016-05-27 01:57:18,937 Setting DEBUG logging. 2016-05-27 01:57:18,937 attempt 1/10 2016-05-27 01:57:18,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9cbc4f2d34a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 01:57:19,785 unpacking tar archive at: mozilla-aurora-9cbc4f2d34a3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 01:57:19.846107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.846397) ========= script_repo_revision: 9cbc4f2d34a30255c3a093f6005f87b453491a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.846792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.847068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 01:57:19.856381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 01:57:19.856668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:20 INFO - MultiFileLogger online at 20160527 01:57:20 in /builds/slave/test 01:57:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:57:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:57:20 INFO - {'append_to_log': False, 01:57:20 INFO - 'base_work_dir': '/builds/slave/test', 01:57:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:57:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:57:20 INFO - 'branch': 'Mozilla-Aurora', 01:57:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:20 INFO - 'config_files': ('talos/linux_config.py',), 01:57:20 INFO - 'default_actions': ('clobber', 01:57:20 INFO - 'read-buildbot-config', 01:57:20 INFO - 'download-and-extract', 01:57:20 INFO - 'populate-webroot', 01:57:20 INFO - 'create-virtualenv', 01:57:20 INFO - 'install', 01:57:20 INFO - 'run-tests'), 01:57:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:20 INFO - 'download_minidump_stackwalk': True, 01:57:20 INFO - 'download_symbols': 'ondemand', 01:57:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:20 INFO - 'installer_path': 'installer.exe', 01:57:20 INFO - 'log_level': 'info', 01:57:20 INFO - 'log_name': 'talos', 01:57:20 INFO - 'log_to_console': True, 01:57:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:20 INFO - 'opt_config_files': (), 01:57:20 INFO - 'pip_index': False, 01:57:20 INFO - 'sps_profile': False, 01:57:20 INFO - 'sps_profile_interval': 0, 01:57:20 INFO - 'suite': 'dromaeojs-e10s', 01:57:20 INFO - 'system_bits': '32', 01:57:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:20 INFO - 'title': 'talos-linux64-ix-021', 01:57:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:20 INFO - 'use_talos_json': True, 01:57:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:57:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:20 INFO - 'work_dir': 'build'} 01:57:20 INFO - ##### 01:57:20 INFO - ##### Running clobber step. 01:57:20 INFO - ##### 01:57:20 INFO - Running pre-action listener: _resource_record_pre_action 01:57:20 INFO - Running main action method: clobber 01:57:20 INFO - rmtree: /builds/slave/test/build 01:57:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:57:21 INFO - Running post-action listener: _resource_record_post_action 01:57:21 INFO - ##### 01:57:21 INFO - ##### Running read-buildbot-config step. 01:57:21 INFO - ##### 01:57:21 INFO - Running pre-action listener: _resource_record_pre_action 01:57:21 INFO - Running main action method: read_buildbot_config 01:57:21 INFO - Using buildbot properties: 01:57:21 INFO - { 01:57:21 INFO - "project": "", 01:57:21 INFO - "product": "firefox", 01:57:21 INFO - "script_repo_revision": "production", 01:57:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:57:21 INFO - "repository": "", 01:57:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 01:57:21 INFO - "buildid": "20160526231045", 01:57:21 INFO - "pgo_build": "True", 01:57:21 INFO - "basedir": "/builds/slave/test", 01:57:21 INFO - "buildnumber": 294, 01:57:21 INFO - "slavename": "talos-linux64-ix-021", 01:57:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:57:21 INFO - "platform": "ubuntu64_hw", 01:57:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:57:21 INFO - "branch": "mozilla-aurora", 01:57:21 INFO - "repo_path": "releases/mozilla-aurora", 01:57:21 INFO - "revision": "9cbc4f2d34a30255c3a093f6005f87b453491a7a", 01:57:21 INFO - "stage_platform": "linux64-pgo", 01:57:21 INFO - "builduid": "f205f9222a3b4fb79c1695d436806960", 01:57:21 INFO - "slavebuilddir": "test" 01:57:21 INFO - } 01:57:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 01:57:21 INFO - Running post-action listener: _resource_record_post_action 01:57:21 INFO - ##### 01:57:21 INFO - ##### Running download-and-extract step. 01:57:21 INFO - ##### 01:57:21 INFO - Running pre-action listener: _resource_record_pre_action 01:57:21 INFO - Running main action method: download_and_extract 01:57:21 INFO - mkdir: /builds/slave/test/build/tests 01:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:21 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:57:29 INFO - Downloaded 1361 bytes. 01:57:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 01:57:29 INFO - Using the following test package requirements: 01:57:29 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 01:57:29 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:57:29 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:57:29 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'jsshell-linux-x86_64.zip'], 01:57:29 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:57:29 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 01:57:29 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:57:29 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:57:29 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:57:29 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 01:57:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:57:29 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:29 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:57:35 INFO - Downloaded 24136564 bytes. 01:57:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:57:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:57:36 INFO - Return code: 0 01:57:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:57: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')]} 01:57:36 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 01:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:57:39 INFO - Downloaded 24136564 bytes. 01:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:57:41 INFO - Return code: 0 01:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:41 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 01:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 01:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 01:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:57:45 INFO - Downloaded 10840145 bytes. 01:57:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:57:45 INFO - Return code: 0 01:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:45 INFO - https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:57:47 INFO - Downloaded 62771461 bytes. 01:57:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:47 INFO - mkdir: /builds/slave/test/properties 01:57:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:57:47 INFO - Writing to file /builds/slave/test/properties/build_url 01:57:47 INFO - Contents: 01:57:47 INFO - build_url:https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 01:57:48 INFO - Running post-action listener: _resource_record_post_action 01:57:48 INFO - Running post-action listener: set_extra_try_arguments 01:57:48 INFO - ##### 01:57:48 INFO - ##### Running populate-webroot step. 01:57:48 INFO - ##### 01:57:48 INFO - Running pre-action listener: _resource_record_pre_action 01:57:48 INFO - Running main action method: populate_webroot 01:57:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:57:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:57:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:57:48 INFO - '--tppagecycles', 01:57:48 INFO - '7'], 01:57:48 INFO - 'tests': ['tsvgm']}}, 01:57:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:57:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:57:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:57:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:57:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:57:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['damp', 'tps']}, 01:57:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'tests': ['damp', 'tps']}, 01:57:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['dromaeo_dom']}, 01:57:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:57:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'other-e10s': {'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['a11yr', 01:57:48 INFO - 'ts_paint', 01:57:48 INFO - 'tpaint', 01:57:48 INFO - 'sessionrestore', 01:57:48 INFO - 'sessionrestore_no_auto_restore', 01:57:48 INFO - 'tabpaint']}, 01:57:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['tsvgx', 01:57:48 INFO - 'tsvgr_opacity', 01:57:48 INFO - 'tart', 01:57:48 INFO - 'tscrollx', 01:57:48 INFO - 'cart']}, 01:57:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:57:48 INFO - 'tsvgr_opacity', 01:57:48 INFO - 'tart', 01:57:48 INFO - 'tscrollx', 01:57:48 INFO - 'cart']}, 01:57:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'talos_options': ['--disable-e10s'], 01:57:48 INFO - 'tests': ['tp5o']}, 01:57:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'tests': ['tp5o']}, 01:57:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'talos_options': ['--disable-e10s', 01:57:48 INFO - '--xperf_path', 01:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:48 INFO - 'tests': ['tp5n']}, 01:57:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:57:48 INFO - 'talos_options': ['--xperf_path', 01:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:57:48 INFO - 'tests': ['tp5n']}}, 01:57:48 INFO - 'talos.zip': {'path': '', 01:57:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:57:48 INFO - Running post-action listener: _resource_record_post_action 01:57:48 INFO - ##### 01:57:48 INFO - ##### Running create-virtualenv step. 01:57:48 INFO - ##### 01:57:48 INFO - Running pre-action listener: _resource_record_pre_action 01:57:48 INFO - Running main action method: create_virtualenv 01:57:48 INFO - Creating virtualenv /builds/slave/test/build/venv 01:57:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:57:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:57:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:57:48 INFO - Using real prefix '/usr' 01:57:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:57:48 INFO - Installing distribute.............................................................................................................................................................................................done. 01:57:50 INFO - Installing pip.................done. 01:57:50 INFO - Return code: 0 01:57:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:50 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:57:50 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 01:57:50 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 01:57:50 INFO - Using env: {'DISPLAY': ':0', 01:57:50 INFO - 'HOME': '/home/cltbld', 01:57:50 INFO - 'LANG': 'en_US.UTF-8', 01:57:50 INFO - 'LANGUAGE': 'en_US:en', 01:57:50 INFO - 'LOGNAME': 'cltbld', 01:57:50 INFO - 'MAIL': '/var/mail/cltbld', 01:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:50 INFO - 'MOZ_NO_REMOTE': '1', 01:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:50 INFO - 'NO_EM_RESTART': '1', 01:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:50 INFO - 'PWD': '/builds/slave/test', 01:57:50 INFO - 'SHELL': '/bin/bash', 01:57:50 INFO - 'SHLVL': '1', 01:57:50 INFO - 'TERM': 'linux', 01:57:50 INFO - 'TMOUT': '86400', 01:57:50 INFO - 'USER': 'cltbld', 01:57:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:50 INFO - '_': '/tools/buildbot/bin/python'} 01:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:50 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 01:57:50 INFO - Cleaning up... 01:57:50 INFO - Return code: 0 01:57:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:50 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:57:50 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 01:57:50 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 01:57:50 INFO - Using env: {'DISPLAY': ':0', 01:57:50 INFO - 'HOME': '/home/cltbld', 01:57:50 INFO - 'LANG': 'en_US.UTF-8', 01:57:50 INFO - 'LANGUAGE': 'en_US:en', 01:57:50 INFO - 'LOGNAME': 'cltbld', 01:57:50 INFO - 'MAIL': '/var/mail/cltbld', 01:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:50 INFO - 'MOZ_NO_REMOTE': '1', 01:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:50 INFO - 'NO_EM_RESTART': '1', 01:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:50 INFO - 'PWD': '/builds/slave/test', 01:57:50 INFO - 'SHELL': '/bin/bash', 01:57:50 INFO - 'SHLVL': '1', 01:57:50 INFO - 'TERM': 'linux', 01:57:50 INFO - 'TMOUT': '86400', 01:57:50 INFO - 'USER': 'cltbld', 01:57:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:50 INFO - '_': '/tools/buildbot/bin/python'} 01:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:51 INFO - Downloading/unpacking psutil>=0.7.1 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:57:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:53 INFO - Installing collected packages: psutil 01:57:53 INFO - Running setup.py install for psutil 01:57:53 INFO - building 'psutil._psutil_linux' extension 01:57:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:57:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:57:53 INFO - building 'psutil._psutil_posix' extension 01:57:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:57:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:57:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:57:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:57:53 INFO - Successfully installed psutil 01:57:53 INFO - Cleaning up... 01:57:53 INFO - Return code: 0 01:57:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:57:53 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')]} 01:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:53 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')]} 01:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:53 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:57:53 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 01:57:53 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 01:57:53 INFO - Using env: {'DISPLAY': ':0', 01:57:53 INFO - 'HOME': '/home/cltbld', 01:57:53 INFO - 'LANG': 'en_US.UTF-8', 01:57:53 INFO - 'LANGUAGE': 'en_US:en', 01:57:53 INFO - 'LOGNAME': 'cltbld', 01:57:53 INFO - 'MAIL': '/var/mail/cltbld', 01:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:53 INFO - 'MOZ_NO_REMOTE': '1', 01:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:53 INFO - 'NO_EM_RESTART': '1', 01:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:53 INFO - 'PWD': '/builds/slave/test', 01:57:53 INFO - 'SHELL': '/bin/bash', 01:57:53 INFO - 'SHLVL': '1', 01:57:53 INFO - 'TERM': 'linux', 01:57:53 INFO - 'TMOUT': '86400', 01:57:53 INFO - 'USER': 'cltbld', 01:57:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:53 INFO - '_': '/tools/buildbot/bin/python'} 01:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:53 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 01:57:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:57:55 INFO - Installing collected packages: mozsystemmonitor 01:57:55 INFO - Running setup.py install for mozsystemmonitor 01:57:55 INFO - Successfully installed mozsystemmonitor 01:57:55 INFO - Cleaning up... 01:57:55 INFO - Return code: 0 01:57:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:55 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:57:55 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 01:57:55 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 01:57:55 INFO - Using env: {'DISPLAY': ':0', 01:57:55 INFO - 'HOME': '/home/cltbld', 01:57:55 INFO - 'LANG': 'en_US.UTF-8', 01:57:55 INFO - 'LANGUAGE': 'en_US:en', 01:57:55 INFO - 'LOGNAME': 'cltbld', 01:57:55 INFO - 'MAIL': '/var/mail/cltbld', 01:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:55 INFO - 'MOZ_NO_REMOTE': '1', 01:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:55 INFO - 'NO_EM_RESTART': '1', 01:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:55 INFO - 'PWD': '/builds/slave/test', 01:57:55 INFO - 'SHELL': '/bin/bash', 01:57:55 INFO - 'SHLVL': '1', 01:57:55 INFO - 'TERM': 'linux', 01:57:55 INFO - 'TMOUT': '86400', 01:57:55 INFO - 'USER': 'cltbld', 01:57:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:55 INFO - '_': '/tools/buildbot/bin/python'} 01:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:57:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:57:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:57:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 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 01:57:58 INFO - Downloading docopt-0.6.1.tar.gz 01:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:57:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:57:58 INFO - Running setup.py install for blobuploader 01:57:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:57:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:57:58 INFO - Running setup.py install for requests 01:57:59 INFO - Running setup.py install for docopt 01:57:59 INFO - Successfully installed blobuploader requests docopt 01:57:59 INFO - Cleaning up... 01:57:59 INFO - Return code: 0 01:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57: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')]} 01:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57: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')]} 01:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:59 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:57:59 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 01:57:59 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 01:57:59 INFO - Using env: {'DISPLAY': ':0', 01:57:59 INFO - 'HOME': '/home/cltbld', 01:57:59 INFO - 'LANG': 'en_US.UTF-8', 01:57:59 INFO - 'LANGUAGE': 'en_US:en', 01:57:59 INFO - 'LOGNAME': 'cltbld', 01:57:59 INFO - 'MAIL': '/var/mail/cltbld', 01:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:59 INFO - 'MOZ_NO_REMOTE': '1', 01:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:57:59 INFO - 'NO_EM_RESTART': '1', 01:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:59 INFO - 'PWD': '/builds/slave/test', 01:57:59 INFO - 'SHELL': '/bin/bash', 01:57:59 INFO - 'SHLVL': '1', 01:57:59 INFO - 'TERM': 'linux', 01:57:59 INFO - 'TMOUT': '86400', 01:57:59 INFO - 'USER': 'cltbld', 01:57:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:59 INFO - '_': '/tools/buildbot/bin/python'} 01:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:57:59 INFO - Running setup.py (path:/tmp/pip-wsK1UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:57:59 INFO - Running setup.py (path:/tmp/pip-Q3EkMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:57:59 INFO - Running setup.py (path:/tmp/pip-tJLUTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:57:59 INFO - Running setup.py (path:/tmp/pip-RucsNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:57:59 INFO - Running setup.py (path:/tmp/pip-jCNzt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:00 INFO - Running setup.py (path:/tmp/pip-LDCMRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:00 INFO - Running setup.py (path:/tmp/pip-MtxwxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:00 INFO - Running setup.py (path:/tmp/pip-KybHzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:00 INFO - Running setup.py (path:/tmp/pip-2uMfWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:00 INFO - Running setup.py (path:/tmp/pip-sJGWX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:00 INFO - Running setup.py (path:/tmp/pip-ImXxxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:00 INFO - Running setup.py (path:/tmp/pip-Pw730m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:00 INFO - Running setup.py (path:/tmp/pip-d2ifrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:00 INFO - Running setup.py (path:/tmp/pip-RiPRYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:00 INFO - Running setup.py (path:/tmp/pip-9cuKio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:00 INFO - Running setup.py (path:/tmp/pip-itjKEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:00 INFO - Running setup.py (path:/tmp/pip-63GZf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:00 INFO - Running setup.py install for manifestparser 01:58:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:58:00 INFO - Running setup.py install for mozcrash 01:58:01 INFO - Running setup.py install for mozdebug 01:58:01 INFO - Running setup.py install for mozdevice 01:58:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for mozfile 01:58:01 INFO - Running setup.py install for mozhttpd 01:58:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for mozinfo 01:58:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for mozInstall 01:58:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for mozleak 01:58:01 INFO - Running setup.py install for mozlog 01:58:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for moznetwork 01:58:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:58:01 INFO - Running setup.py install for mozprocess 01:58:02 INFO - Running setup.py install for mozprofile 01:58:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:58:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:58:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:58:02 INFO - Running setup.py install for mozrunner 01:58:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:58:02 INFO - Running setup.py install for mozscreenshot 01:58:02 INFO - Running setup.py install for moztest 01:58:02 INFO - Running setup.py install for mozversion 01:58:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:58:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:02 INFO - Cleaning up... 01:58:02 INFO - Return code: 0 01:58:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:02 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:58:02 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 01:58:02 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 01:58:02 INFO - Using env: {'DISPLAY': ':0', 01:58:02 INFO - 'HOME': '/home/cltbld', 01:58:02 INFO - 'LANG': 'en_US.UTF-8', 01:58:02 INFO - 'LANGUAGE': 'en_US:en', 01:58:02 INFO - 'LOGNAME': 'cltbld', 01:58:02 INFO - 'MAIL': '/var/mail/cltbld', 01:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:02 INFO - 'MOZ_NO_REMOTE': '1', 01:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:02 INFO - 'NO_EM_RESTART': '1', 01:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:02 INFO - 'PWD': '/builds/slave/test', 01:58:02 INFO - 'SHELL': '/bin/bash', 01:58:02 INFO - 'SHLVL': '1', 01:58:02 INFO - 'TERM': 'linux', 01:58:02 INFO - 'TMOUT': '86400', 01:58:02 INFO - 'USER': 'cltbld', 01:58:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:02 INFO - '_': '/tools/buildbot/bin/python'} 01:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:02 INFO - Running setup.py (path:/tmp/pip-j_EBgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:02 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)) 01:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:02 INFO - Running setup.py (path:/tmp/pip-FtYiV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:03 INFO - Running setup.py (path:/tmp/pip-a8fNu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:03 INFO - Running setup.py (path:/tmp/pip-upNs_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:03 INFO - Running setup.py (path:/tmp/pip-jT9bHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:03 INFO - Running setup.py (path:/tmp/pip-67onpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:03 INFO - Running setup.py (path:/tmp/pip-i74kro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:03 INFO - Running setup.py (path:/tmp/pip-w7zrfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:03 INFO - Running setup.py (path:/tmp/pip-zJYS4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:03 INFO - Running setup.py (path:/tmp/pip-inblvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:03 INFO - Running setup.py (path:/tmp/pip-9DgYZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:03 INFO - Running setup.py (path:/tmp/pip-C5urfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:03 INFO - Running setup.py (path:/tmp/pip-k3ka9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:03 INFO - Running setup.py (path:/tmp/pip-HVY97P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:03 INFO - Running setup.py (path:/tmp/pip-crtm1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:03 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)) 01:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:03 INFO - Running setup.py (path:/tmp/pip-u979kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:04 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)) 01:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:04 INFO - Running setup.py (path:/tmp/pip-PnvyWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:04 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)) 01:58:04 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)) 01:58:04 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)) 01:58:04 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)) 01:58:04 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)) 01:58:04 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)) 01:58:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:58:04 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 01:58:04 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 01:58:04 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 01:58:04 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 01:58:04 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 01:58:04 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 01:58:05 INFO - Downloading blessings-1.6.tar.gz 01:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:06 INFO - Installing collected packages: blessings 01:58:06 INFO - Running setup.py install for blessings 01:58:06 INFO - Successfully installed blessings 01:58:06 INFO - Cleaning up... 01:58:06 INFO - Return code: 0 01:58:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:06 INFO - Reading from file tmpfile_stdout 01:58:06 INFO - Current package versions: 01:58:06 INFO - argparse == 1.2.1 01:58:06 INFO - blessings == 1.6 01:58:06 INFO - blobuploader == 1.2.4 01:58:06 INFO - docopt == 0.6.1 01:58:06 INFO - manifestparser == 1.1 01:58:06 INFO - mozInstall == 1.12 01:58:06 INFO - mozcrash == 0.17 01:58:06 INFO - mozdebug == 0.1 01:58:06 INFO - mozdevice == 0.48 01:58:06 INFO - mozfile == 1.2 01:58:06 INFO - mozhttpd == 0.7 01:58:06 INFO - mozinfo == 0.9 01:58:06 INFO - mozleak == 0.1 01:58:06 INFO - mozlog == 3.1 01:58:06 INFO - moznetwork == 0.27 01:58:06 INFO - mozprocess == 0.22 01:58:06 INFO - mozprofile == 0.28 01:58:06 INFO - mozrunner == 6.11 01:58:06 INFO - mozscreenshot == 0.1 01:58:06 INFO - mozsystemmonitor == 0.0 01:58:06 INFO - moztest == 0.7 01:58:06 INFO - mozversion == 1.4 01:58:06 INFO - psutil == 3.1.1 01:58:06 INFO - requests == 1.2.3 01:58:06 INFO - wsgiref == 0.1.2 01:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:06 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:58:06 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 01:58:06 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 01:58:06 INFO - Using env: {'DISPLAY': ':0', 01:58:06 INFO - 'HOME': '/home/cltbld', 01:58:06 INFO - 'LANG': 'en_US.UTF-8', 01:58:06 INFO - 'LANGUAGE': 'en_US:en', 01:58:06 INFO - 'LOGNAME': 'cltbld', 01:58:06 INFO - 'MAIL': '/var/mail/cltbld', 01:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:06 INFO - 'MOZ_NO_REMOTE': '1', 01:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:06 INFO - 'NO_EM_RESTART': '1', 01:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:06 INFO - 'PWD': '/builds/slave/test', 01:58:06 INFO - 'SHELL': '/bin/bash', 01:58:06 INFO - 'SHLVL': '1', 01:58:06 INFO - 'TERM': 'linux', 01:58:06 INFO - 'TMOUT': '86400', 01:58:06 INFO - 'USER': 'cltbld', 01:58:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:06 INFO - '_': '/tools/buildbot/bin/python'} 01:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 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)) 01:58:06 INFO - Cleaning up... 01:58:06 INFO - Return code: 0 01:58:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:06 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:58:06 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 01:58:06 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 01:58:06 INFO - Using env: {'DISPLAY': ':0', 01:58:06 INFO - 'HOME': '/home/cltbld', 01:58:06 INFO - 'LANG': 'en_US.UTF-8', 01:58:06 INFO - 'LANGUAGE': 'en_US:en', 01:58:06 INFO - 'LOGNAME': 'cltbld', 01:58:06 INFO - 'MAIL': '/var/mail/cltbld', 01:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:06 INFO - 'MOZ_NO_REMOTE': '1', 01:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:06 INFO - 'NO_EM_RESTART': '1', 01:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:06 INFO - 'PWD': '/builds/slave/test', 01:58:06 INFO - 'SHELL': '/bin/bash', 01:58:06 INFO - 'SHLVL': '1', 01:58:06 INFO - 'TERM': 'linux', 01:58:06 INFO - 'TMOUT': '86400', 01:58:06 INFO - 'USER': 'cltbld', 01:58:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:06 INFO - '_': '/tools/buildbot/bin/python'} 01:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:06 INFO - Downloading/unpacking jsonschema 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:06 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 01:58:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:08 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:09 INFO - warning: no files found matching '*.txt' 01:58:09 INFO - no previously-included directories found matching 'build' 01:58:09 INFO - no previously-included directories found matching 'dist' 01:58:09 INFO - no previously-included directories found matching '.git*' 01:58:09 INFO - Installing collected packages: jsonschema, functools32 01:58:09 INFO - Running setup.py install for functools32 01:58:09 INFO - warning: no files found matching '*.txt' 01:58:09 INFO - no previously-included directories found matching 'build' 01:58:09 INFO - no previously-included directories found matching 'dist' 01:58:09 INFO - no previously-included directories found matching '.git*' 01:58:09 INFO - Successfully installed jsonschema functools32 01:58:09 INFO - Cleaning up... 01:58:09 INFO - Return code: 0 01:58:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:09 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 0x7f7a1f4b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, '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': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', '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 01:58:09 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 01:58:09 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 01:58:09 INFO - Using env: {'DISPLAY': ':0', 01:58:09 INFO - 'HOME': '/home/cltbld', 01:58:09 INFO - 'LANG': 'en_US.UTF-8', 01:58:09 INFO - 'LANGUAGE': 'en_US:en', 01:58:09 INFO - 'LOGNAME': 'cltbld', 01:58:09 INFO - 'MAIL': '/var/mail/cltbld', 01:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:09 INFO - 'MOZ_NO_REMOTE': '1', 01:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:09 INFO - 'NO_EM_RESTART': '1', 01:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:09 INFO - 'PWD': '/builds/slave/test', 01:58:09 INFO - 'SHELL': '/bin/bash', 01:58:09 INFO - 'SHLVL': '1', 01:58:09 INFO - 'TERM': 'linux', 01:58:09 INFO - 'TMOUT': '86400', 01:58:09 INFO - 'USER': 'cltbld', 01:58:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:09 INFO - '_': '/tools/buildbot/bin/python'} 01:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:09 INFO - Downloading/unpacking flake8 01:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58: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 01:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:12 INFO - no previously-included directories found matching 'docs/_build' 01:58:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:58:12 INFO - Running setup.py install for pep8 01:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:12 INFO - no previously-included directories found matching 'docs/_build' 01:58:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:58:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:58:12 INFO - Cleaning up... 01:58:12 INFO - Return code: 0 01:58:12 INFO - Running post-action listener: _resource_record_post_action 01:58:12 INFO - Running post-action listener: _start_resource_monitoring 01:58:12 INFO - Starting resource monitoring. 01:58:12 INFO - ##### 01:58:12 INFO - ##### Running install step. 01:58:12 INFO - ##### 01:58:12 INFO - Running pre-action listener: _resource_record_pre_action 01:58:12 INFO - Running main action method: install 01:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:12 INFO - Reading from file tmpfile_stdout 01:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:58:12 INFO - Reading from file tmpfile_stdout 01:58:12 INFO - Output received: 01:58:12 INFO - Usage: mozinstall [options] installer 01:58:12 INFO - Options: 01:58:12 INFO - -h, --help show this help message and exit 01:58:12 INFO - -d DEST, --destination=DEST 01:58:12 INFO - Directory to install application into. [default: 01:58:12 INFO - "/builds/slave/test"] 01:58:12 INFO - --app=APP Application being installed. [default: firefox] 01:58:12 INFO - mkdir: /builds/slave/test/build/application 01:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:58:28 INFO - Reading from file tmpfile_stdout 01:58:28 INFO - Output received: 01:58:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:58:28 INFO - Running post-action listener: _resource_record_post_action 01:58:28 INFO - ##### 01:58:28 INFO - ##### Running run-tests step. 01:58:28 INFO - ##### 01:58:28 INFO - Running pre-action listener: _resource_record_pre_action 01:58:28 INFO - Running main action method: run_tests 01:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:58:28 INFO - Python 2.7.3 01:58:28 INFO - Return code: 0 01:58:28 INFO - grabbing minidump binary from tooltool 01:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:28 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 0x1ee5410>, '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 0x1ee6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:58:28 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 01:58:28 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 01:58:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:28 INFO - Return code: 0 01:58:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:58:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:58:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:58:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:58:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:58:29 INFO - Return code: 0 01:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:58:29 INFO - Using env: {'DISPLAY': ':0', 01:58:29 INFO - 'HOME': '/home/cltbld', 01:58:29 INFO - 'LANG': 'en_US.UTF-8', 01:58:29 INFO - 'LANGUAGE': 'en_US:en', 01:58:29 INFO - 'LOGNAME': 'cltbld', 01:58:29 INFO - 'MAIL': '/var/mail/cltbld', 01:58:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:58:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:29 INFO - 'MOZ_NO_REMOTE': '1', 01:58:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:29 INFO - 'NO_EM_RESTART': '1', 01:58:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:29 INFO - 'PWD': '/builds/slave/test', 01:58:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:58:29 INFO - 'SHELL': '/bin/bash', 01:58:29 INFO - 'SHLVL': '1', 01:58:29 INFO - 'TERM': 'linux', 01:58:29 INFO - 'TMOUT': '86400', 01:58:29 INFO - 'USER': 'cltbld', 01:58:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458', 01:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:29 INFO - '_': '/tools/buildbot/bin/python'} 01:58:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:58:29 INFO - mozversion application_buildid: 20160526231045 01:58:29 INFO - mozversion application_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 01:58:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:58:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:29 INFO - mozversion application_name: Firefox 01:58:29 INFO - mozversion application_remotingname: firefox-dev 01:58:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:58:29 INFO - mozversion application_vendor: Mozilla 01:58:29 INFO - mozversion application_version: 48.0a2 01:58:29 INFO - mozversion platform_buildid: 20160526231045 01:58:29 INFO - mozversion platform_changeset: 9cbc4f2d34a30255c3a093f6005f87b453491a7a 01:58:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:58:29 INFO - mozversion platform_version: 48.0a2 01:58:29 INFO - using testdate: 1464339509 01:58:29 INFO - actual date: 1464339509 01:58:29 INFO - starting webserver on 'localhost:50559' 01:58:29 INFO - SUITE-START | Running 2 tests 01:58:29 INFO - TEST-START | dromaeo_css 01:58:29 INFO - operating with platform_type : linux_ 01:58:29 INFO - Initialising browser for dromaeo_css test... 01:58:29 INFO - TEST-INFO | started process 28193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOMr8E/profile http://localhost:50559/getInfo.html) 01:58:34 INFO - PROCESS | 28193 | 01:58:34 INFO - PROCESS | 28193 | (process:28271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:58:35 INFO - PROCESS | 28193 | __metrics Screen width/height:1600/1200 01:58:35 INFO - PROCESS | 28193 | colorDepth:24 01:58:35 INFO - PROCESS | 28193 | Browser inner width/height: 1024/697 01:58:35 INFO - PROCESS | 28193 | __metrics 01:58:36 ERROR - PROCESS | 28193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 01:58:37 INFO - TEST-INFO | 28193: exit 0 01:58:37 INFO - Browser initialized. 01:58:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:58:37 INFO - TEST-INFO | started process 28322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdOMr8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:39 INFO - PROCESS | 28322 | 01:58:39 INFO - PROCESS | 28322 | (process:28393): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:58:49 INFO - PROCESS | 28322 | RSS: Main: 152825856 01:58:49 INFO - PROCESS | 28322 | 01:59:38 INFO - PROCESS | 28322 | 1464339578935 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] 02:01:46 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50559/tests/dromaeo/cssquery-ext.html) 02:01:46 INFO - PROCESS | 28322 | RSS: Main: 155889664 02:01:46 INFO - PROCESS | 28322 | 02:04:48 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-ext.html (next: http://localhost:50559/tests/dromaeo/cssquery-jquery.html) 02:04:49 INFO - PROCESS | 28322 | RSS: Main: 153812992 02:04:49 INFO - PROCESS | 28322 | 02:07:51 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50559/tests/dromaeo/cssquery-mootools.html) 02:07:51 INFO - PROCESS | 28322 | RSS: Main: 153767936 02:07:51 INFO - PROCESS | 28322 | 02:10:53 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50559/tests/dromaeo/cssquery-prototype.html) 02:10:54 INFO - PROCESS | 28322 | RSS: Main: 153145344 02:10:54 INFO - PROCESS | 28322 | 02:13:56 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50559/tests/dromaeo/cssquery-yui.html) 02:13:57 INFO - PROCESS | 28322 | RSS: Main: 154804224 02:13:57 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | Cycle 1(1): loaded http://localhost:50559/tests/dromaeo/cssquery-yui.html (next: http://localhost:50559/tests/dromaeo/cssquery-dojo.html) 02:16:59 INFO - PROCESS | 28322 | RSS: Main: 156389376 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | __start_tp_report 02:16:59 INFO - PROCESS | 28322 | _x_x_mozilla_page_load 02:16:59 INFO - PROCESS | 28322 | _x_x_mozilla_page_load_details 02:16:59 INFO - PROCESS | 28322 | |i|pagename|runs| 02:16:59 INFO - PROCESS | 28322 | |0;dojo.html;3276.9672303276966;3309.3381323735252;3347.933041339175;3365.209175843675;3382.1206486313567;5453.1002384606545;5454.563634909207;5473.507384335409;5475.561955043597;5491.752871120799;5431.321084864392;5452.754626041828;5482.588805839558;5496.862578435531;5501.119820828668;4940.777665005075;4959.256111583273;5025;5037.319961805146;5054.595632349422;4881.341018962448;4967.552920237178;4982.775775090112;5078.771455284503;5112.821051263207;4873.269009648546;4901.803927842882;4966.9751651241695;4967.577755890754;4969;4863.294822250789;4877.853664390074;4880.682755620874;4894.216925291972;4925.211966085445;4797.040591881638;4812.687175333627;4865.172920603506;4866.172750632401;4910.828121015783;5297.788088476456;5326.7070311132875;5330.466953304638;5340.332458442695;5380.946190538123;5811.854703632443;5823.330317013513;5828.0966450200285;5829.883402331972;5832.591718579701;5859.531237501033;5901.468867801918;5903.203067585864;6002.279726432812;6023.337432882379;5458.590605704549;5505.284313039319;5509.228707980846;5517.806876759294;5520.420355862657;5938.049912014057;5974.940250597525;5978.671173085522;5979.86382587307;5981.581289309794;5523.364813046551;5677.858053548612;5729.512991395778;5782.132680098019;5803.419658034247;5791.913121303184;5794.62334948227;5804.245448091806;5811.88376232473;5819.388964158702;5652.434756524314;5712.485876271156;5791.5656325775735;5797.565182611321;5798.188253644493;5813.651180929158;5887.705614719247;5894.4400281974;5901.911471327933;5936.13925980739;4373.956260437419;4422.75674837887;4427.247367947457;4427.667924905645;4448.5773851484055;3962.0887195945093;3968.3650615901893;3982.681385489154;3991.501062367204;3999.0202400412086;5481.890362192814;5624.156376543551;5646.802361917313;5667.659940403589;5690.146478028329;5912.3496415394275;5932.703364831741;5936.22829032223;5948.910766338508;5949;5452.836414907559;5552.056150454432;5657.6322539035655;5677.914831277534;5684.175794509855;5045.789010637421;5082.263071854634;5097.8725531862;5106.106431374569;5127.53852153308;5969.552283578749;6071.180390647294;6076.361981991828;6078.6048906820915;6082;5738.68437235956;5760.596758226884;5867.647941123546;5891.528677705687;5938.376470470625;5954.225950626391;5960.314563825215;5970.641761494324;5985.072313791369;6003.0695242237525;5683.687397193029;5690.544756419559;5697.4302569742695;5698.1452782083015;5704.1443783432815;5667.064934285797;5735.684537350319;5740.942590574041;5783.103618939072;5795.39148389413;5672.971635141798;5685.289338832646;5721.427857214246;5734.111212762028;5738.713064346849;5663.603547751618;5681;5695.914561281501;5701.6864072474755;5714.742836572281;5484.067708489487;5587.69267690281;5650.23721797552;5657.547396208376;5710.314762228559;5649.491545760901;5709.743061562157;5709.857253568694;5736.971315143398;5751.626144300607;5508.394076651645;5569.805056822992;5622.915656265078;5623.128415095667;5627.662340259598 02:16:59 INFO - PROCESS | 28322 | |1;ext.html;661.3750006244098;666.7632990288447;668.749219042859;671.1610486891386;676.3608390071383;34870.476942845846;35094.64905350949;35129.12177195572;35141.82429087854;35147.121321966966;37538.81230593843;38237;38390.23219535615;38508.229835403276;38576.614233857654;8506.191911768388;8734.825303493926;8760.342974276955;8766.386352955296;8772.473651580895;8489.74530764078;8601.95699021507;8604.741857744277;8847.247983921374;8849.734507964771;8769.342299327544;8799.252063574604;8806.427582207169;8821.11788821116;8837;8715.825683486326;8784.341174411913;8788.956055219747;8840.115988401172;8864.0692727264;8846.911530884674;8927.196552310323;8940.776480587972;8954.328425368123;8958.193762561335;38198.42702359467;38203.61796382028;38480.037999049964;38504.80747596244;38570;3403.285310084885;3454.5681789776277;3484.3379757846183;3550.715942724576;3557.1996300832366;29464.410711785644;30082.24794380136;30095;30252.84873575618;30624.54063189054;4554.2485489894125;4558.612517935946;4578.10726908253;4622.768861556942;4631.421072365954;327653.44693106244;328770;329340;329468.9999999976;329720;33813.32373352519;50931.745341273796;51086;51107.233391499154;51166.48833511692;31690;31790.841045794623;31852.68147318497;31909.840450797597;32060;14311.642208944651;14474.203918784357;14507.637309067357;14530.346134423977;14614.780778288334;12281.877181228074;12290.324032178138;12342.197757145757;12380.133390662748;12414.193077449936;8337.95831020853;8355.331573474228;8445.113263107409;8451.83096338082;8460.280876125598;3393.8133402662597;3402.7788193767324;3422.7775194612273;3472.6700963408434;3479.060653623558;1039.9012093851072;1052.2476429353048;1065.4459680966008;1067.4395942130288;1090.6782499162766;26444.206673799818;26667.066652667065;26718.5992210117;26951.865240674062;27132.728672713416;1038.8805287391895;1083.4907593431076;1087.1357270969597;1118.1055155875267;1159.0322081062407;13543.98420118495;13665.111767735065;13825.79261311081;13874.098183618033;13949.39581948089;505077;506385;540875;544365;547797;46758.766206169435;47323.52676473191;47391.5260847394;47547.28679069817;47585.524144758805;1300.5318085489216;1303.5567906911506;1311.6065180445828;1343.2477812425072;1461.6857375664283;30765.538516922712;31639.841800790848;31642.841785791843;32136;32326;43821;44376.334354985345;44654.776726116164;44690.55309446864;44696;451383;456196;456395;456511;456918;29873.25316867009;29948.401031978803;30091.097267082023;40550.1889962205;41140;39984.80007599943;40605.39091913564;40727.18545629011;40735.59264407318;41659.7917010413;34764.304713905076;35310.29379412449;35720.285594288485;36920.81539592285;37056.814715926244;35801.82099089488;36033.27933441369;36223.818880905426;37081.443778343884;37100.62899370972;40065.799671001456;40158.19683606253;40235.1952960945;40385.59614403819;40956.38565421581;32922;36238.45642315315;38152.42771358376;38716.41925371178;39377.80311098426;26354.20937371882;27358.45283094367;27554.448911022067;27787.722122779323;33249.33501329912 02:16:59 INFO - PROCESS | 28322 | |2;jquery.html;395.75463212808046;401.161572313864;406.0457923878885;412.62038924189744;415.60309904041645;13942.930285348559;16653;17179.226934787934;17648.11759412029;17973.460796176118;15872.12703301318;15909.602259943507;16062.83937160628;16420.83579164208;16529.752053719203;5497.917531237024;5725;5731.197632331477;5741.684207368593;5768.048272035109;5480.808171713991;5643.181738647893;5647.322321321447;5652.576056795757;5657.23627310314;5614.859628509279;5618.5786066045;5632.324121105473;5651.208830763697;5662.6036177467595;5301.867453313679;5532.834014979557;5556.16657501374;5564.527015203692;5640.717964101799;5376.1398176292;5394.083005889008;5415.079436495806;5445.782168713246;5540.722963851791;11797.29216247028;12057.577984770578;12098;12208.267503949703;12213.206141600767;2247.752747197807;2326.3835083702834;2373.940651483727;2438.5732496813166;2457.2751038443703;8987.730368088967;9574.47340396278;10795.352278863293;10818.621348252773;13959.581212563638;2005.31819181479;2031.8374530037709;2048.5800410915726;2078.864873783199;2089.4149638101358;79957.20042799614;81326.9999999994;81495.59252203761;81789.59105204495;82489.58755206245;10626;10720.517576709066;10739.14086873064;10870.619528316629;11117.055050320814;13319.66700832487;13806.516771913135;14676.339564719614;14773.778393324108;14795.408183672533;7498.4001279897475;7511.51175173612;7656.157822639505;7681.539107653559;7714.151443341228;7571.659275332513;7632.084149901936;7664.11862635804;7724.575148366781;7770.41721870862;4521.11838191556;4535.478419981679;4595.839145629887;4625.791839367236;4661.86014419568;1850.296887182889;1964.165229777339;1982.7918068602878;1982.8909409982589;1989.1049027937486;941.3222479814523;980.1032055669126;988.9901100989042;1002.6741309074434;1024.073213741565;16877;17318.307267709402;17529.7370539442;17883.28466861337;17967.550811229823;959.9040095990345;990.7374545745239;992.4442312305132;1003.8193125237527;1011.2870426349406;9573.425594464215;9821.656242031495;9969.900300997042;9997.300188986701;10109;549375;550548;562894;581675;585734;55103;56887;90680.54659726658;94837.5258123705;95381;998.2612866478753;1026.3328836256642;1041.8437234414898;1054.1935419404163;1059;15490;15589.766153507933;15670.9216453917;15694.293756780744;15971.44099956496;33027.83486082554;38118.61881381151;38887;39092.41361379639;39387.60612393839;49138.262926055424;49504.75247623883;49906.75046624744;49952;49959;8154.266116049584;8236.917630823615;8304.294134998592;8369.204925532065;8427.62075706607;11995.520179192734;12433.751324973631;12635.115541912346;12807.423665935241;12867.742645147231;11211.66365009051;12036.819447708467;12056.095792815398;12148.453319600463;12207.69480762988;7295.744648937261;10510.264281500222;11812.76374472523;11905.94047029794;12157.148999569945;11652.94173529127;11991.400429978292;12122.27266364021;12269.325187114795;12348.876511234772;8324.62539185726;8362.581870906308;8371.581420929051;8403.579561344011;8816.647334106563;11091.279066860629;11864.762704745684;11942.686304506671;12265;12372.319522426353 02:16:59 INFO - PROCESS | 28322 | |3;mootools.html;1283.1787655900223;1376.2912100268363;1383.854695256998;1659.5768079139818;1683.0322564525393;7162.212156662763;7406.740764073258;7756.767296981093;7952.602369881512;7967.681292748291;7026.648667566614;7505.699772009127;7704.229577042307;7718.189590093029;7869.881951770713;2245.2253972379544;2265.546890621874;2282.566312400647;2284.189112864934;2286.7141607299086;2241.1819685814644;2254.9887250563725;2263.162629826958;2269.8184145268337;2270.931872043833;2224.955500889981;2236.0385034435267;2242.7869352411576;2246.651768975811;2278.1115365007577;2281.7946384825364;2290.713660792401;2298.10373954158;2304.435413323738;2321.5356928614174;2287.0508738873514;2290.896909639054;2292.3123063081007;2293.483966107629;2294.2314324701247;8016.478928869663;8031.237032481905;8054.033515978062;8069.7175598853755;8105.797355066112;4720.669553131283;4813.855584332476;4814.398200224972;4823;4871.12319782439;3177.4121787469394;3189.8245596492184;3269.3297873935785;3276.459384201604;3284.3759685659647;1105.6240878101485;1108.706192858893;1114.6154576671036;1121.3944469986197;1148.4315263944318;11148.442577871074;11222.382768947704;11231.60689375876;11240.943795281053;11276.210665253353;4113.91772164555;4165.604267594574;4190.434291370687;4197.370394440797;4200.264953633102;9632.373895696757;9646.565904534313;9692.127708506268;9713.36863103896;9754.95122524397;4891.706497610155;4934.827281045146;4940.431850337185;4958.454569997298;4963.057019166419;3942.56631770505;4411.713238639478;4494.595486406239;4540.682152249311;4568.977155114203;3682.8342724576924;3738.102855314705;3759.436084587334;3798.9430158547643;3804.524434445694;1171.4025846818183;1179.8584169899666;1183.331417748969;1186.5846953566183;1190.7261329894172;969.2294625772528;981.5632043740467;983.6508039645965;989.6041583366567;1006.7986402719486;5431.2396264522995;5531.474509921551;5549.972250138723;5591.720413979285;5629.24005259293;910.1944778870615;990.757264470195;999.605155963405;1024.4416792847917;1080.9459527023616;3770.830312635938;3810.580836108026;3822.0444888777806;3827.9808600956817;3874.3413619684156;9627.663031793854;9818.116369526777;9881.80236395268;9956.103950644478;10054.798904021878;9301.255899528021;9591.232701383873;9862.802743945082;9875.654352097787;9891.35706179096;7235.529690570096;7256;7305.232950540223;7342.9632851835395;7405.1484079330485;5354.812581559627;5391.379991301051;5514.503694667339;5630.155476678531;5880.294364676266;8524.36067294943;8582.485050896967;8742.475451472932;8829.558522074;8853.20321171072;8482.660693572188;8724.520151391735;8737.169968852948;8848.46909185451;8907.910920890708;6295.5907865988565;6608.008798680236;6641.867162656817;6946.79159625212;7014.193367762773;7127.037849890198;7258.491905566771;7267.600281984542;7290.125184977836;7351.191368949304;6774.93225067743;7004.334588214111;7037.577745335297;7159.892601610876;7248.855022899618;6784.3894049535775;6858.759943401957;6926.307369263033;6979.755708550177;7027.121609798775;6701.028350889192;6702.128723266139;6744.325567443413;6870.20992585859;6900;4957.950420495749;5047.419546752024;5093.439721630692;5099.311592934906;5109.335786347751;5032.823851165192;5033.672811267256;5070.264811602223;5096.46487118862;5116.258142569381 02:16:59 INFO - PROCESS | 28322 | |4;prototype.html;318.8055286275372;319.6632615580108;320.5112203889069;325.3639135490117;327.8278903575624;6604.60372377657;6634.402903738669;6635.369639884216;6637.1703537057865;6689.264180940093;6496.6102033878;6500.41496265336;6500.934990650092;6502.154719886408;6511.055896894947;4575.107853968478;4699.436067671867;4870.707757534542;4875.488073752258;4893.608511319104;4853.635977301698;4863.440704319013;4872.439669438025;4885.853424397274;4903.8774030649165;4817.51824817519;4824.011077729075;4824.734639594821;4828.903421931559;4839.903201935959;4823.252395878627;4830.3237546743485;4836.46798852126;4842.055799119174;4850.417949846006;4169.082801783603;4209.494860616745;4210.494740631113;4213.747175169499;4215.43091682622;6056;6230.283517395467;6268.78059267928;6275.6548389838545;6312.305646378941;5623.100303951348;5635.351934527541;5638.520725738317;5656.377798442168;5661;6878;6918.965405172992;6928.16861976566;6948.444124470081;6950.061741664861;4587.816487340502;4610.67725259232;4614.907701845944;4615.123126605968;4616.215243408628;7235.565866048054;7244.420446364278;7287.562746235243;7300.269973002711;7308.524945878501;4519.096180763795;4689.460712018162;4700.318453824177;4712.740799256006;4721;4749.050189962021;4758.690685105457;4775.928361074587;4784.043191361741;4786.880327991828;5580.91628625571;5600.411956744483;5610.719464026783;5633.3240011198095;5647.37878833328;6983.127109111361;7026.718931242795;7043.119610048744;7048.625518024039;7051.92948070523;1657.7927759030122;1681.7645529625863;1682.5877659973385;1686.8060173080253;1686.9240884160242;1030.5620111452602;1057.7884423115408;1067.2209287220217;1075.870895492546;1086.0225796782959;6724.361185687352;6747.257801641816;6766.018927255521;6780.355866192704;6783.660816959133;6977.686004129826;7233.05970223878;7247.4926755126635;7260.891086633705;7270.890936635955;6693.698783554752;6758.459323254227;6800.115984921928;6803.353681400259;6811.284815094443;3889.3388124018984;3891.2995660780766;3895.7078219133678;3906.062544989239;3906.511686039245;7468.626568671545;7505.474616776883;7541.321281084729;7568.091828980558;7595.392368610498;7303.89044164338;7372.778816635509;7415.666295016737;7433.591152486557;7436.73971410998;7495.700171993169;7522.849543009219;7534.434917381109;7545.886811697829;7580;7282.526635768658;7283.344498994904;7303.488755787044;7308.086489188851;7349.228331025379;7162;7184;7206.946020384165;7213.531120477152;7222;7294.343509084208;7505.924940750741;7522.5862577558755;7550.848983020419;7579.810504737426;4796.400449943757;4822.758862056813;4830.9854930465;4854.247591623162;4855.174620314484;7228.698834209893;7265.346118849329;7267.745628902963;7269;7284.761590529517;7087.291270872872;7097.325754053357;7101.7159313628945;7108.431325494052;7109.395701365442;6819.113515242987;7008.053912721717;7028.894566581607;7067.222605513287;7105.25394833535;6946.409555187865;6955.652217389009;6959.860802784017;6966.721331146698;6980.616066116412;7059.223485416497;7128.322809333105;7135.678894449866;7138.0363650906465;7149.285071493017;6906.654667266516;6910.654467276717;6936.918924322784;6949.583025018313;6952.721891124501 02:16:59 INFO - PROCESS | 28322 | |5;yui.html;739.9741009064684;740.9182593413617;761.744815486812;770.6786418271017;777.6034222546504;13120.606381808537;13335.799963000563;13479.932600336997;13535.52625658102;13538.864611353883;12235.265884046963;12238.20451670643;12310;12311.445984930677;12349.938250308758;533.4239021856386;539.8434454008333;555.6082961512134;557.760163129854;565.1466285908267;550.0154723045744;550.3725752641972;552.0063885006991;553.1039715660636;555.7110302642624;727.799855039863;732.0812380462538;737.2774680812806;738.2359258167797;739.9704011839547;612.7763366371287;614.6527212125158;615.6521565315583;616.5345164400893;616.9012957926733;430.34372581812676;433.26128950139935;433.4408612889369;434.3940203416217;440.12195669638953;13658.931705341409;13658.931705341409;13696.452141914311;13708.794368084487;13725.176489410667;13223.272720000396;13450.394732237073;13483.393247303895;13529.864701353057;13725.519606813714;11687.883121168765;11747.7063073423;11898.286102833858;12705.364731763375;12950.417231224617;3745.4756334113245;3805.7906815125157;3829.2341531693774;3892.338302488584;3952.5256969163884;57388.71305643487;57611;57798.13302800462;57944.71027644877;58410.70794646042;10180.745481363025;10280;10534.841977370346;10719.78560428787;10835.566577336818;18390.908045459953;18401.079946002646;18520.536986575175;18541.44375668732;20049;8154.714584989615;8453.619587118472;8567.443116197428;8578.4424012439;8832.64669413229;4827.517248275144;4895.412550493964;4931.112399768004;4934.087193869145;4941.50584941503;3175.079227024183;3203.6636153203576;3228.4188846007946;3229.273413481948;3229.3218424131196;594.1355327997753;609.7225762278152;620.1163342237294;621.273110460762;623.420219196152;730.4558104212396;742.5581778841581;750.5909279442717;754.5095687802972;770.3529035610114;9341.299402544837;9446.149846513847;9596.376235544667;9849.803003939882;9913.008699130174;696.3906581740977;731.974380896666;756.2890882570366;757.8787394016931;766.2911806578892;4420.624246939046;4501.504834468205;4541.682082254277;4554.476235232991;4574.702644328108;66378.66810665916;68435;68754.31245687579;69095;69125.30874691189;57902.71048644814;58832.705836470544;58968.41031589629;59435.70282148562;59637.403625964056;49423.50576494261;49702;50432.495675043516;53033.734831326365;53602;8932.240759535252;8998.415103018282;9103.180713735796;9108.954455227682;9147.679831205876;36990.44514332234;37647.2470550582;37727.62272377241;38859.805700971316;39091.41362879616;44071.77964110159;44307.77846110749;48526.75736621294;50804.49195508145;51417.485825142765;11042.834357484804;11092.11263098934;11153.83269250978;11266.303483378257;11293.71765705864;11683.649490515298;11685.707857303636;11869;14040.859591404364;14547.345369458188;11790.882091178979;12933.159344642569;12961.287129207607;13733;13812;12187.756244874876;12307.076969227164;12925.870741292843;13084.542041028519;13099.738005240033;11152.275102118336;11444.256123351955;11888.583899563473;11998.520059197534;12761.872381276069;10642.84035739449;10755;10794.136469082297;10937.289076210021;11512.884871151182;10175.643852465128;10732.356058636195;10975.341479511255;10994.395308258123;11014.284071535325 02:16:59 INFO - PROCESS | 28322 | __end_tp_report 02:16:59 INFO - PROCESS | 28322 | __start_cc_report 02:16:59 INFO - PROCESS | 28322 | _x_x_mozilla_cycle_collect,339 02:16:59 INFO - PROCESS | 28322 | __end_cc_report 02:16:59 INFO - PROCESS | 28322 | __startTimestamp1464340619559__endTimestamp 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | ------- Summary: start ------- 02:16:59 INFO - PROCESS | 28322 | Number of tests: 6 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#0] dojo.html Cycles:165 Average:5423.14 Median:5657.63 stddev:600.06 (10.6%) stddev-sans-first:577.80 02:16:59 INFO - PROCESS | 28322 | Values: 3277.0 3309.3 3347.9 3365.2 3382.1 5453.1 5454.6 5473.5 5475.6 5491.8 5431.3 5452.8 5482.6 5496.9 5501.1 4940.8 4959.3 5025.0 5037.3 5054.6 4881.3 4967.6 4982.8 5078.8 5112.8 4873.3 4901.8 4967.0 4967.6 4969.0 4863.3 4877.9 4880.7 4894.2 4925.2 4797.0 4812.7 4865.2 4866.2 4910.8 5297.8 5326.7 5330.5 5340.3 5380.9 5811.9 5823.3 5828.1 5829.9 5832.6 5859.5 5901.5 5903.2 6002.3 6023.3 5458.6 5505.3 5509.2 5517.8 5520.4 5938.0 5974.9 5978.7 5979.9 5981.6 5523.4 5677.9 5729.5 5782.1 5803.4 5791.9 5794.6 5804.2 5811.9 5819.4 5652.4 5712.5 5791.6 5797.6 5798.2 5813.7 5887.7 5894.4 5901.9 5936.1 4374.0 4422.8 4427.2 4427.7 4448.6 3962.1 3968.4 3982.7 3991.5 3999.0 5481.9 5624.2 5646.8 5667.7 5690.1 5912.3 5932.7 5936.2 5948.9 5949.0 5452.8 5552.1 5657.6 5677.9 5684.2 5045.8 5082.3 5097.9 5106.1 5127.5 5969.6 6071.2 6076.4 6078.6 6082.0 5738.7 5760.6 5867.6 5891.5 5938.4 5954.2 5960.3 5970.6 5985.1 6003.1 5683.7 5690.5 5697.4 5698.1 5704.1 5667.1 5735.7 5740.9 5783.1 5795.4 5673.0 5685.3 5721.4 5734.1 5738.7 5663.6 5681.0 5695.9 5701.7 5714.7 5484.1 5587.7 5650.2 5657.5 5710.3 5649.5 5709.7 5709.9 5737.0 5751.6 5508.4 5569.8 5622.9 5623.1 5627.7 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#1] ext.html Cycles:180 Average:56858.68 Median:37319.72 stddev:118666.93 (318.0%) stddev-sans-first:118924.81 02:16:59 INFO - PROCESS | 28322 | Values: 661.4 666.8 668.7 671.2 676.4 34870.5 35094.6 35129.1 35141.8 35147.1 37538.8 38237.0 38390.2 38508.2 38576.6 8506.2 8734.8 8760.3 8766.4 8772.5 8489.7 8602.0 8604.7 8847.2 8849.7 8769.3 8799.3 8806.4 8821.1 8837.0 8715.8 8784.3 8789.0 8840.1 8864.1 8846.9 8927.2 8940.8 8954.3 8958.2 38198.4 38203.6 38480.0 38504.8 38570.0 3403.3 3454.6 3484.3 3550.7 3557.2 29464.4 30082.2 30095.0 30252.8 30624.5 4554.2 4558.6 4578.1 4622.8 4631.4 327653.4 328770.0 329340.0 329469.0 329720.0 33813.3 50931.7 51086.0 51107.2 51166.5 31690.0 31790.8 31852.7 31909.8 32060.0 14311.6 14474.2 14507.6 14530.3 14614.8 12281.9 12290.3 12342.2 12380.1 12414.2 8338.0 8355.3 8445.1 8451.8 8460.3 3393.8 3402.8 3422.8 3472.7 3479.1 1039.9 1052.2 1065.4 1067.4 1090.7 26444.2 26667.1 26718.6 26951.9 27132.7 1038.9 1083.5 1087.1 1118.1 1159.0 13544.0 13665.1 13825.8 13874.1 13949.4 505077.0 506385.0 540875.0 544365.0 547797.0 46758.8 47323.5 47391.5 47547.3 47585.5 1300.5 1303.6 1311.6 1343.2 1461.7 30765.5 31639.8 31642.8 32136.0 32326.0 43821.0 44376.3 44654.8 44690.6 44696.0 451383.0 456196.0 456395.0 456511.0 456918.0 29873.3 29948.4 30091.1 40550.2 41140.0 39984.8 40605.4 40727.2 40735.6 41659.8 34764.3 35310.3 35720.3 36920.8 37056.8 35801.8 36033.3 36223.8 37081.4 37100.6 40065.8 40158.2 40235.2 40385.6 40956.4 32922.0 36238.5 38152.4 38716.4 39377.8 26354.2 27358.5 27554.4 27787.7 33249.3 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#2] jquery.html Cycles:180 Average:29746.47 Median:19891.68 stddev:92869.20 (466.9%) stddev-sans-first:93103.57 02:16:59 INFO - PROCESS | 28322 | Values: 395.8 401.2 406.0 412.6 415.6 13942.9 16653.0 17179.2 17648.1 17973.5 15872.1 15909.6 16062.8 16420.8 16529.8 5497.9 5725.0 5731.2 5741.7 5768.0 5480.8 5643.2 5647.3 5652.6 5657.2 5614.9 5618.6 5632.3 5651.2 5662.6 5301.9 5532.8 5556.2 5564.5 5640.7 5376.1 5394.1 5415.1 5445.8 5540.7 11797.3 12057.6 12098.0 12208.3 12213.2 2247.8 2326.4 2373.9 2438.6 2457.3 8987.7 9574.5 10795.4 10818.6 13959.6 2005.3 2031.8 2048.6 2078.9 2089.4 79957.2 81327.0 81495.6 81789.6 82489.6 10626.0 10720.5 10739.1 10870.6 11117.1 13319.7 13806.5 14676.3 14773.8 14795.4 7498.4 7511.5 7656.2 7681.5 7714.2 7571.7 7632.1 7664.1 7724.6 7770.4 4521.1 4535.5 4595.8 4625.8 4661.9 1850.3 1964.2 1982.8 1982.9 1989.1 941.3 980.1 989.0 1002.7 1024.1 16877.0 17318.3 17529.7 17883.3 17967.6 959.9 990.7 992.4 1003.8 1011.3 9573.4 9821.7 9969.9 9997.3 10109.0 549375.0 550548.0 562894.0 581675.0 585734.0 55103.0 56887.0 90680.5 94837.5 95381.0 998.3 1026.3 1041.8 1054.2 1059.0 15490.0 15589.8 15670.9 15694.3 15971.4 33027.8 38118.6 38887.0 39092.4 39387.6 49138.3 49504.8 49906.8 49952.0 49959.0 8154.3 8236.9 8304.3 8369.2 8427.6 11995.5 12433.8 12635.1 12807.4 12867.7 11211.7 12036.8 12056.1 12148.5 12207.7 7295.7 10510.3 11812.8 11905.9 12157.1 11652.9 11991.4 12122.3 12269.3 12348.9 8324.6 8362.6 8371.6 8403.6 8816.6 11091.3 11864.8 11942.7 12265.0 12372.3 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#3] mootools.html Cycles:180 Average:5297.52 Median:5097.89 stddev:2885.02 (56.6%) stddev-sans-first:2877.33 02:16:59 INFO - PROCESS | 28322 | Values: 1283.2 1376.3 1383.9 1659.6 1683.0 7162.2 7406.7 7756.8 7952.6 7967.7 7026.6 7505.7 7704.2 7718.2 7869.9 2245.2 2265.5 2282.6 2284.2 2286.7 2241.2 2255.0 2263.2 2269.8 2270.9 2225.0 2236.0 2242.8 2246.7 2278.1 2281.8 2290.7 2298.1 2304.4 2321.5 2287.1 2290.9 2292.3 2293.5 2294.2 8016.5 8031.2 8054.0 8069.7 8105.8 4720.7 4813.9 4814.4 4823.0 4871.1 3177.4 3189.8 3269.3 3276.5 3284.4 1105.6 1108.7 1114.6 1121.4 1148.4 11148.4 11222.4 11231.6 11240.9 11276.2 4113.9 4165.6 4190.4 4197.4 4200.3 9632.4 9646.6 9692.1 9713.4 9755.0 4891.7 4934.8 4940.4 4958.5 4963.1 3942.6 4411.7 4494.6 4540.7 4569.0 3682.8 3738.1 3759.4 3798.9 3804.5 1171.4 1179.9 1183.3 1186.6 1190.7 969.2 981.6 983.7 989.6 1006.8 5431.2 5531.5 5550.0 5591.7 5629.2 910.2 990.8 999.6 1024.4 1080.9 3770.8 3810.6 3822.0 3828.0 3874.3 9627.7 9818.1 9881.8 9956.1 10054.8 9301.3 9591.2 9862.8 9875.7 9891.4 7235.5 7256.0 7305.2 7343.0 7405.1 5354.8 5391.4 5514.5 5630.2 5880.3 8524.4 8582.5 8742.5 8829.6 8853.2 8482.7 8724.5 8737.2 8848.5 8907.9 6295.6 6608.0 6641.9 6946.8 7014.2 7127.0 7258.5 7267.6 7290.1 7351.2 6774.9 7004.3 7037.6 7159.9 7248.9 6784.4 6858.8 6926.3 6979.8 7027.1 6701.0 6702.1 6744.3 6870.2 6900.0 4958.0 5047.4 5093.4 5099.3 5109.3 5032.8 5033.7 5070.3 5096.5 5116.3 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#4] prototype.html Cycles:180 Average:5800.07 Median:6709.03 stddev:1828.16 (27.2%) stddev-sans-first:1786.40 02:16:59 INFO - PROCESS | 28322 | Values: 318.8 319.7 320.5 325.4 327.8 6604.6 6634.4 6635.4 6637.2 6689.3 6496.6 6500.4 6500.9 6502.2 6511.1 4575.1 4699.4 4870.7 4875.5 4893.6 4853.6 4863.4 4872.4 4885.9 4903.9 4817.5 4824.0 4824.7 4828.9 4839.9 4823.3 4830.3 4836.5 4842.1 4850.4 4169.1 4209.5 4210.5 4213.7 4215.4 6056.0 6230.3 6268.8 6275.7 6312.3 5623.1 5635.4 5638.5 5656.4 5661.0 6878.0 6919.0 6928.2 6948.4 6950.1 4587.8 4610.7 4614.9 4615.1 4616.2 7235.6 7244.4 7287.6 7300.3 7308.5 4519.1 4689.5 4700.3 4712.7 4721.0 4749.1 4758.7 4775.9 4784.0 4786.9 5580.9 5600.4 5610.7 5633.3 5647.4 6983.1 7026.7 7043.1 7048.6 7051.9 1657.8 1681.8 1682.6 1686.8 1686.9 1030.6 1057.8 1067.2 1075.9 1086.0 6724.4 6747.3 6766.0 6780.4 6783.7 6977.7 7233.1 7247.5 7260.9 7270.9 6693.7 6758.5 6800.1 6803.4 6811.3 3889.3 3891.3 3895.7 3906.1 3906.5 7468.6 7505.5 7541.3 7568.1 7595.4 7303.9 7372.8 7415.7 7433.6 7436.7 7495.7 7522.8 7534.4 7545.9 7580.0 7282.5 7283.3 7303.5 7308.1 7349.2 7162.0 7184.0 7206.9 7213.5 7222.0 7294.3 7505.9 7522.6 7550.8 7579.8 4796.4 4822.8 4831.0 4854.2 4855.2 7228.7 7265.3 7267.7 7269.0 7284.8 7087.3 7097.3 7101.7 7108.4 7109.4 6819.1 7008.1 7028.9 7067.2 7105.3 6946.4 6955.7 6959.9 6966.7 6980.6 7059.2 7128.3 7135.7 7138.0 7149.3 6906.7 6910.7 6936.9 6949.6 6952.7 02:16:59 INFO - PROCESS | 28322 | 02:16:59 INFO - PROCESS | 28322 | [#5] yui.html Cycles:180 Average:15258.88 Median:24246.20 stddev:18399.09 (75.9%) stddev-sans-first:18418.40 02:16:59 INFO - PROCESS | 28322 | Values: 740.0 740.9 761.7 770.7 777.6 13120.6 13335.8 13479.9 13535.5 13538.9 12235.3 12238.2 12310.0 12311.4 12349.9 533.4 539.8 555.6 557.8 565.1 550.0 550.4 552.0 553.1 555.7 727.8 732.1 737.3 738.2 740.0 612.8 614.7 615.7 616.5 616.9 430.3 433.3 433.4 434.4 440.1 13658.9 13658.9 13696.5 13708.8 13725.2 13223.3 13450.4 13483.4 13529.9 13725.5 11687.9 11747.7 11898.3 12705.4 12950.4 3745.5 3805.8 3829.2 3892.3 3952.5 57388.7 57611.0 57798.1 57944.7 58410.7 10180.7 10280.0 10534.8 10719.8 10835.6 18390.9 18401.1 18520.5 18541.4 20049.0 8154.7 8453.6 8567.4 8578.4 8832.6 4827.5 4895.4 4931.1 4934.1 4941.5 3175.1 3203.7 3228.4 3229.3 3229.3 594.1 609.7 620.1 621.3 623.4 730.5 742.6 750.6 754.5 770.4 9341.3 9446.1 9596.4 9849.8 9913.0 696.4 732.0 756.3 757.9 766.3 4420.6 4501.5 4541.7 4554.5 4574.7 66378.7 68435.0 68754.3 69095.0 69125.3 57902.7 58832.7 58968.4 59435.7 59637.4 49423.5 49702.0 50432.5 53033.7 53602.0 8932.2 8998.4 9103.2 9109.0 9147.7 36990.4 37647.2 37727.6 38859.8 39091.4 44071.8 44307.8 48526.8 50804.5 51417.5 11042.8 11092.1 11153.8 11266.3 11293.7 11683.6 11685.7 11869.0 14040.9 14547.3 11790.9 12933.2 12961.3 13733.0 13812.0 12187.8 12307.1 12925.9 13084.5 13099.7 11152.3 11444.3 11888.6 11998.5 12761.9 10642.8 10755.0 10794.1 10937.3 11512.9 10175.6 10732.4 10975.3 10994.4 11014.3 02:16:59 INFO - PROCESS | 28322 | -------- Summary: end -------- 02:16:59 INFO - PROCESS | 28322 | 02:17:00 INFO - TEST-INFO | 28322: exit 0 02:17:00 INFO - TEST-OK | dromaeo_css | took 1110794ms 02:17:00 INFO - TEST-START | kraken 02:17:00 INFO - operating with platform_type : linux_ 02:17:00 INFO - Initialising browser for kraken test... 02:17:00 INFO - TEST-INFO | started process 28563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRYEvo5/profile http://localhost:50559/getInfo.html) 02:17:04 INFO - PROCESS | 28563 | 02:17:04 INFO - PROCESS | 28563 | (process:28644): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:17:05 INFO - PROCESS | 28563 | __metrics Screen width/height:1600/1200 02:17:05 INFO - PROCESS | 28563 | colorDepth:24 02:17:05 INFO - PROCESS | 28563 | Browser inner width/height: 1024/697 02:17:05 INFO - PROCESS | 28563 | __metrics 02:17:06 ERROR - PROCESS | 28563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:17:07 INFO - TEST-INFO | 28563: exit 0 02:17:07 INFO - Browser initialized. 02:17:07 INFO - Running cycle 1/1 for kraken test... 02:17:07 INFO - TEST-INFO | started process 28696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRYEvo5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:09 INFO - PROCESS | 28696 | 02:17:09 INFO - PROCESS | 28696 | (process:28770): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:17:19 INFO - PROCESS | 28696 | RSS: Main: 152109056 02:17:19 INFO - PROCESS | 28696 | 02:17:21 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50559/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:22 INFO - PROCESS | 28696 | RSS: Main: 156971008 02:17:22 INFO - PROCESS | 28696 | 02:17:25 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50559/tests/kraken/driver.html?testName=audio-dft) 02:17:25 INFO - PROCESS | 28696 | RSS: Main: 157417472 02:17:25 INFO - PROCESS | 28696 | 02:17:28 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50559/tests/kraken/driver.html?testName=audio-fft) 02:17:29 INFO - PROCESS | 28696 | RSS: Main: 157224960 02:17:29 INFO - PROCESS | 28696 | 02:17:31 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50559/tests/kraken/driver.html?testName=audio-oscillator) 02:17:32 INFO - PROCESS | 28696 | RSS: Main: 157368320 02:17:32 INFO - PROCESS | 28696 | 02:17:34 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:34 INFO - PROCESS | 28696 | RSS: Main: 157175808 02:17:34 INFO - PROCESS | 28696 | 02:17:37 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50559/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:38 INFO - PROCESS | 28696 | RSS: Main: 157626368 02:17:38 INFO - PROCESS | 28696 | 02:17:41 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50559/tests/kraken/driver.html?testName=imaging-desaturate) 02:17:42 INFO - PROCESS | 28696 | RSS: Main: 157077504 02:17:42 INFO - PROCESS | 28696 | 02:17:45 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50559/tests/kraken/driver.html?testName=json-parse-financial) 02:17:45 INFO - PROCESS | 28696 | RSS: Main: 157593600 02:17:45 INFO - PROCESS | 28696 | 02:17:47 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:17:48 INFO - PROCESS | 28696 | RSS: Main: 157097984 02:17:48 INFO - PROCESS | 28696 | 02:17:49 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:17:50 INFO - PROCESS | 28696 | RSS: Main: 157093888 02:17:50 INFO - PROCESS | 28696 | 02:17:52 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:17:53 INFO - PROCESS | 28696 | RSS: Main: 157462528 02:17:53 INFO - PROCESS | 28696 | 02:17:55 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:17:56 INFO - PROCESS | 28696 | RSS: Main: 157839360 02:17:56 INFO - PROCESS | 28696 | 02:17:58 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:17:59 INFO - PROCESS | 28696 | RSS: Main: 157556736 02:17:59 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | Cycle 1(1): loaded http://localhost:50559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50559/tests/kraken/driver.html?testName=ai-astar) 02:18:01 INFO - PROCESS | 28696 | RSS: Main: 159301632 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | __start_tp_report 02:18:01 INFO - PROCESS | 28696 | _x_x_mozilla_page_load 02:18:01 INFO - PROCESS | 28696 | _x_x_mozilla_page_load_details 02:18:01 INFO - PROCESS | 28696 | |i|pagename|runs| 02:18:01 INFO - PROCESS | 28696 | |0;ai-astar;112;111;103;110;113;113;102;110;112;111 02:18:01 INFO - PROCESS | 28696 | |1;audio-beat-detection;158;133;157;175;126;156;159;124;180;127 02:18:01 INFO - PROCESS | 28696 | |2;audio-dft;161;162;162;163;163;162;162;162;161;165 02:18:01 INFO - PROCESS | 28696 | |3;audio-fft;76;76;77;169;77;75;77;83;182;78 02:18:01 INFO - PROCESS | 28696 | |4;audio-oscillator;93;92;162;93;94;93;143;94;93;151 02:18:01 INFO - PROCESS | 28696 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;117;118 02:18:01 INFO - PROCESS | 28696 | |6;imaging-darkroom;147;147;147;147;145;151;149;146;146;148 02:18:01 INFO - PROCESS | 28696 | |7;imaging-desaturate;94;95;95;97;96;96;95;94;95;95 02:18:01 INFO - PROCESS | 28696 | |8;json-parse-financial;55;58;56;57;60;56;57;88;54;56 02:18:01 INFO - PROCESS | 28696 | |9;json-stringify-tinderbox;57;58;58;58;57;58;57;59;57;58 02:18:01 INFO - PROCESS | 28696 | |10;stanford-crypto-aes;74;75;81;76;75;83;75;74;76;74 02:18:01 INFO - PROCESS | 28696 | |11;stanford-crypto-ccm;119;114;120;123;125;121;119;115;142;127 02:18:01 INFO - PROCESS | 28696 | |12;stanford-crypto-pbkdf2;165;163;161;163;162;159;161;175;163;157 02:18:01 INFO - PROCESS | 28696 | |13;stanford-crypto-sha256-iterative;69;71;68;66;68;66;66;68;65;69 02:18:01 INFO - PROCESS | 28696 | __end_tp_report 02:18:01 INFO - PROCESS | 28696 | __start_cc_report 02:18:01 INFO - PROCESS | 28696 | _x_x_mozilla_cycle_collect,844 02:18:01 INFO - PROCESS | 28696 | __end_cc_report 02:18:01 INFO - PROCESS | 28696 | __startTimestamp1464340681484__endTimestamp 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | ------- Summary: start ------- 02:18:01 INFO - PROCESS | 28696 | Number of tests: 14 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.95 (3.5%) stddev-sans-first:4.10 02:18:01 INFO - PROCESS | 28696 | Values: 112.0 111.0 103.0 110.0 113.0 113.0 102.0 110.0 112.0 111.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:157.50 stddev:20.61 (13.1%) stddev-sans-first:21.63 02:18:01 INFO - PROCESS | 28696 | Values: 158.0 133.0 157.0 175.0 126.0 156.0 159.0 124.0 180.0 127.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 02:18:01 INFO - PROCESS | 28696 | Values: 161.0 162.0 162.0 163.0 163.0 162.0 162.0 162.0 161.0 165.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#3] audio-fft Cycles:10 Average:97.00 Median:77.00 stddev:41.54 (54.0%) stddev-sans-first:43.36 02:18:01 INFO - PROCESS | 28696 | Values: 76.0 76.0 77.0 169.0 77.0 75.0 77.0 83.0 182.0 78.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:93.00 stddev:28.79 (31.0%) stddev-sans-first:29.81 02:18:01 INFO - PROCESS | 28696 | Values: 93.0 92.0 162.0 93.0 94.0 93.0 143.0 94.0 93.0 151.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:18:01 INFO - PROCESS | 28696 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.70 (1.2%) stddev-sans-first:1.80 02:18:01 INFO - PROCESS | 28696 | Values: 147.0 147.0 147.0 147.0 145.0 151.0 149.0 146.0 146.0 148.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 02:18:01 INFO - PROCESS | 28696 | Values: 94.0 95.0 95.0 97.0 96.0 96.0 95.0 94.0 95.0 95.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:57.00 stddev:10.08 (17.7%) stddev-sans-first:10.54 02:18:01 INFO - PROCESS | 28696 | Values: 55.0 58.0 56.0 57.0 60.0 56.0 57.0 88.0 54.0 56.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 02:18:01 INFO - PROCESS | 28696 | Values: 57.0 58.0 58.0 58.0 57.0 58.0 57.0 59.0 57.0 58.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:3.13 (4.1%) stddev-sans-first:3.21 02:18:01 INFO - PROCESS | 28696 | Values: 74.0 75.0 81.0 76.0 75.0 83.0 75.0 74.0 76.0 74.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.00 stddev:7.95 (6.5%) stddev-sans-first:8.33 02:18:01 INFO - PROCESS | 28696 | Values: 119.0 114.0 120.0 123.0 125.0 121.0 119.0 115.0 142.0 127.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:4.82 (3.0%) stddev-sans-first:5.05 02:18:01 INFO - PROCESS | 28696 | Values: 165.0 163.0 161.0 163.0 162.0 159.0 161.0 175.0 163.0 157.0 02:18:01 INFO - PROCESS | 28696 | 02:18:01 INFO - PROCESS | 28696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.88 02:18:01 INFO - PROCESS | 28696 | Values: 69.0 71.0 68.0 66.0 68.0 66.0 66.0 68.0 65.0 69.0 02:18:01 INFO - PROCESS | 28696 | -------- Summary: end -------- 02:18:01 INFO - PROCESS | 28696 | 02:18:02 INFO - TEST-INFO | 28696: exit 0 02:18:02 INFO - TEST-OK | kraken | took 62263ms 02:18:02 INFO - SUITE-END | took 1173s 02:18:02 INFO - Completed test suite (00:19:33) 02:18:02 INFO - javascript benchmark 02:18:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.9672303276966, 3309.3381323735252, 3347.933041339175, 3365.209175843675, 3382.1206486313567, 5453.1002384606545, 5454.563634909207, 5473.507384335409, 5475.561955043597, 5491.752871120799, 5431.321084864392, 5452.754626041828, 5482.588805839558, 5496.862578435531, 5501.119820828668, 4940.777665005075, 4959.256111583273, 5025.0, 5037.319961805146, 5054.595632349422, 4881.341018962448, 4967.552920237178, 4982.775775090112, 5078.771455284503, 5112.821051263207, 4873.269009648546, 4901.803927842882, 4966.9751651241695, 4967.577755890754, 4969.0, 4863.294822250789, 4877.853664390074, 4880.682755620874, 4894.216925291972, 4925.211966085445, 4797.040591881638, 4812.687175333627, 4865.172920603506, 4866.172750632401, 4910.828121015783, 5297.788088476456, 5326.7070311132875, 5330.466953304638, 5340.332458442695, 5380.946190538123, 5811.854703632443, 5823.330317013513, 5828.0966450200285, 5829.883402331972, 5832.591718579701, 5859.531237501033, 5901.468867801918, 5903.203067585864, 6002.279726432812, 6023.337432882379, 5458.590605704549, 5505.284313039319, 5509.228707980846, 5517.806876759294, 5520.420355862657, 5938.049912014057, 5974.940250597525, 5978.671173085522, 5979.86382587307, 5981.581289309794, 5523.364813046551, 5677.858053548612, 5729.512991395778, 5782.132680098019, 5803.419658034247, 5791.913121303184, 5794.62334948227, 5804.245448091806, 5811.88376232473, 5819.388964158702, 5652.434756524314, 5712.485876271156, 5791.5656325775735, 5797.565182611321, 5798.188253644493, 5813.651180929158, 5887.705614719247, 5894.4400281974, 5901.911471327933, 5936.13925980739, 4373.956260437419, 4422.75674837887, 4427.247367947457, 4427.667924905645, 4448.5773851484055, 3962.0887195945093, 3968.3650615901893, 3982.681385489154, 3991.501062367204, 3999.0202400412086, 5481.890362192814, 5624.156376543551, 5646.802361917313, 5667.659940403589, 5690.146478028329, 5912.3496415394275, 5932.703364831741, 5936.22829032223, 5948.910766338508, 5949.0, 5452.836414907559, 5552.056150454432, 5657.6322539035655, 5677.914831277534, 5684.175794509855, 5045.789010637421, 5082.263071854634, 5097.8725531862, 5106.106431374569, 5127.53852153308, 5969.552283578749, 6071.180390647294, 6076.361981991828, 6078.6048906820915, 6082.0, 5738.68437235956, 5760.596758226884, 5867.647941123546, 5891.528677705687, 5938.376470470625, 5954.225950626391, 5960.314563825215, 5970.641761494324, 5985.072313791369, 6003.0695242237525, 5683.687397193029, 5690.544756419559, 5697.4302569742695, 5698.1452782083015, 5704.1443783432815, 5667.064934285797, 5735.684537350319, 5740.942590574041, 5783.103618939072, 5795.39148389413, 5672.971635141798, 5685.289338832646, 5721.427857214246, 5734.111212762028, 5738.713064346849, 5663.603547751618, 5681.0, 5695.914561281501, 5701.6864072474755, 5714.742836572281, 5484.067708489487, 5587.69267690281, 5650.23721797552, 5657.547396208376, 5710.314762228559, 5649.491545760901, 5709.743061562157, 5709.857253568694, 5736.971315143398, 5751.626144300607, 5508.394076651645, 5569.805056822992, 5622.915656265078, 5623.128415095667, 5627.662340259598], "value": 5384.56059696884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.3750006244098, 666.7632990288447, 668.749219042859, 671.1610486891386, 676.3608390071383, 34870.476942845846, 35094.64905350949, 35129.12177195572, 35141.82429087854, 35147.121321966966, 37538.81230593843, 38237.0, 38390.23219535615, 38508.229835403276, 38576.614233857654, 8506.191911768388, 8734.825303493926, 8760.342974276955, 8766.386352955296, 8772.473651580895, 8489.74530764078, 8601.95699021507, 8604.741857744277, 8847.247983921374, 8849.734507964771, 8769.342299327544, 8799.252063574604, 8806.427582207169, 8821.11788821116, 8837.0, 8715.825683486326, 8784.341174411913, 8788.956055219747, 8840.115988401172, 8864.0692727264, 8846.911530884674, 8927.196552310323, 8940.776480587972, 8954.328425368123, 8958.193762561335, 38198.42702359467, 38203.61796382028, 38480.037999049964, 38504.80747596244, 38570.0, 3403.285310084885, 3454.5681789776277, 3484.3379757846183, 3550.715942724576, 3557.1996300832366, 29464.410711785644, 30082.24794380136, 30095.0, 30252.84873575618, 30624.54063189054, 4554.2485489894125, 4558.612517935946, 4578.10726908253, 4622.768861556942, 4631.421072365954, 327653.44693106244, 328770.0, 329340.0, 329468.9999999976, 329720.0, 33813.32373352519, 50931.745341273796, 51086.0, 51107.233391499154, 51166.48833511692, 31690.0, 31790.841045794623, 31852.68147318497, 31909.840450797597, 32060.0, 14311.642208944651, 14474.203918784357, 14507.637309067357, 14530.346134423977, 14614.780778288334, 12281.877181228074, 12290.324032178138, 12342.197757145757, 12380.133390662748, 12414.193077449936, 8337.95831020853, 8355.331573474228, 8445.113263107409, 8451.83096338082, 8460.280876125598, 3393.8133402662597, 3402.7788193767324, 3422.7775194612273, 3472.6700963408434, 3479.060653623558, 1039.9012093851072, 1052.2476429353048, 1065.4459680966008, 1067.4395942130288, 1090.6782499162766, 26444.206673799818, 26667.066652667065, 26718.5992210117, 26951.865240674062, 27132.728672713416, 1038.8805287391895, 1083.4907593431076, 1087.1357270969597, 1118.1055155875267, 1159.0322081062407, 13543.98420118495, 13665.111767735065, 13825.79261311081, 13874.098183618033, 13949.39581948089, 505077.0, 506385.0, 540875.0, 544365.0, 547797.0, 46758.766206169435, 47323.52676473191, 47391.5260847394, 47547.28679069817, 47585.524144758805, 1300.5318085489216, 1303.5567906911506, 1311.6065180445828, 1343.2477812425072, 1461.6857375664283, 30765.538516922712, 31639.841800790848, 31642.841785791843, 32136.0, 32326.0, 43821.0, 44376.334354985345, 44654.776726116164, 44690.55309446864, 44696.0, 451383.0, 456196.0, 456395.0, 456511.0, 456918.0, 29873.25316867009, 29948.401031978803, 30091.097267082023, 40550.1889962205, 41140.0, 39984.80007599943, 40605.39091913564, 40727.18545629011, 40735.59264407318, 41659.7917010413, 34764.304713905076, 35310.29379412449, 35720.285594288485, 36920.81539592285, 37056.814715926244, 35801.82099089488, 36033.27933441369, 36223.818880905426, 37081.443778343884, 37100.62899370972, 40065.799671001456, 40158.19683606253, 40235.1952960945, 40385.59614403819, 40956.38565421581, 32922.0, 36238.45642315315, 38152.42771358376, 38716.41925371178, 39377.80311098426, 26354.20937371882, 27358.45283094367, 27554.448911022067, 27787.722122779323, 33249.33501329912], "value": 18025.77077485319, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.75463212808046, 401.161572313864, 406.0457923878885, 412.62038924189744, 415.60309904041645, 13942.930285348559, 16653.0, 17179.226934787934, 17648.11759412029, 17973.460796176118, 15872.12703301318, 15909.602259943507, 16062.83937160628, 16420.83579164208, 16529.752053719203, 5497.917531237024, 5725.0, 5731.197632331477, 5741.684207368593, 5768.048272035109, 5480.808171713991, 5643.181738647893, 5647.322321321447, 5652.576056795757, 5657.23627310314, 5614.859628509279, 5618.5786066045, 5632.324121105473, 5651.208830763697, 5662.6036177467595, 5301.867453313679, 5532.834014979557, 5556.16657501374, 5564.527015203692, 5640.717964101799, 5376.1398176292, 5394.083005889008, 5415.079436495806, 5445.782168713246, 5540.722963851791, 11797.29216247028, 12057.577984770578, 12098.0, 12208.267503949703, 12213.206141600767, 2247.752747197807, 2326.3835083702834, 2373.940651483727, 2438.5732496813166, 2457.2751038443703, 8987.730368088967, 9574.47340396278, 10795.352278863293, 10818.621348252773, 13959.581212563638, 2005.31819181479, 2031.8374530037709, 2048.5800410915726, 2078.864873783199, 2089.4149638101358, 79957.20042799614, 81326.9999999994, 81495.59252203761, 81789.59105204495, 82489.58755206245, 10626.0, 10720.517576709066, 10739.14086873064, 10870.619528316629, 11117.055050320814, 13319.66700832487, 13806.516771913135, 14676.339564719614, 14773.778393324108, 14795.408183672533, 7498.4001279897475, 7511.51175173612, 7656.157822639505, 7681.539107653559, 7714.151443341228, 7571.659275332513, 7632.084149901936, 7664.11862635804, 7724.575148366781, 7770.41721870862, 4521.11838191556, 4535.478419981679, 4595.839145629887, 4625.791839367236, 4661.86014419568, 1850.296887182889, 1964.165229777339, 1982.7918068602878, 1982.8909409982589, 1989.1049027937486, 941.3222479814523, 980.1032055669126, 988.9901100989042, 1002.6741309074434, 1024.073213741565, 16877.0, 17318.307267709402, 17529.7370539442, 17883.28466861337, 17967.550811229823, 959.9040095990345, 990.7374545745239, 992.4442312305132, 1003.8193125237527, 1011.2870426349406, 9573.425594464215, 9821.656242031495, 9969.900300997042, 9997.300188986701, 10109.0, 549375.0, 550548.0, 562894.0, 581675.0, 585734.0, 55103.0, 56887.0, 90680.54659726658, 94837.5258123705, 95381.0, 998.2612866478753, 1026.3328836256642, 1041.8437234414898, 1054.1935419404163, 1059.0, 15490.0, 15589.766153507933, 15670.9216453917, 15694.293756780744, 15971.44099956496, 33027.83486082554, 38118.61881381151, 38887.0, 39092.41361379639, 39387.60612393839, 49138.262926055424, 49504.75247623883, 49906.75046624744, 49952.0, 49959.0, 8154.266116049584, 8236.917630823615, 8304.294134998592, 8369.204925532065, 8427.62075706607, 11995.520179192734, 12433.751324973631, 12635.115541912346, 12807.423665935241, 12867.742645147231, 11211.66365009051, 12036.819447708467, 12056.095792815398, 12148.453319600463, 12207.69480762988, 7295.744648937261, 10510.264281500222, 11812.76374472523, 11905.94047029794, 12157.148999569945, 11652.94173529127, 11991.400429978292, 12122.27266364021, 12269.325187114795, 12348.876511234772, 8324.62539185726, 8362.581870906308, 8371.581420929051, 8403.579561344011, 8816.647334106563, 11091.279066860629, 11864.762704745684, 11942.686304506671, 12265.0, 12372.319522426353], "value": 8780.632529761786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.1787655900223, 1376.2912100268363, 1383.854695256998, 1659.5768079139818, 1683.0322564525393, 7162.212156662763, 7406.740764073258, 7756.767296981093, 7952.602369881512, 7967.681292748291, 7026.648667566614, 7505.699772009127, 7704.229577042307, 7718.189590093029, 7869.881951770713, 2245.2253972379544, 2265.546890621874, 2282.566312400647, 2284.189112864934, 2286.7141607299086, 2241.1819685814644, 2254.9887250563725, 2263.162629826958, 2269.8184145268337, 2270.931872043833, 2224.955500889981, 2236.0385034435267, 2242.7869352411576, 2246.651768975811, 2278.1115365007577, 2281.7946384825364, 2290.713660792401, 2298.10373954158, 2304.435413323738, 2321.5356928614174, 2287.0508738873514, 2290.896909639054, 2292.3123063081007, 2293.483966107629, 2294.2314324701247, 8016.478928869663, 8031.237032481905, 8054.033515978062, 8069.7175598853755, 8105.797355066112, 4720.669553131283, 4813.855584332476, 4814.398200224972, 4823.0, 4871.12319782439, 3177.4121787469394, 3189.8245596492184, 3269.3297873935785, 3276.459384201604, 3284.3759685659647, 1105.6240878101485, 1108.706192858893, 1114.6154576671036, 1121.3944469986197, 1148.4315263944318, 11148.442577871074, 11222.382768947704, 11231.60689375876, 11240.943795281053, 11276.210665253353, 4113.91772164555, 4165.604267594574, 4190.434291370687, 4197.370394440797, 4200.264953633102, 9632.373895696757, 9646.565904534313, 9692.127708506268, 9713.36863103896, 9754.95122524397, 4891.706497610155, 4934.827281045146, 4940.431850337185, 4958.454569997298, 4963.057019166419, 3942.56631770505, 4411.713238639478, 4494.595486406239, 4540.682152249311, 4568.977155114203, 3682.8342724576924, 3738.102855314705, 3759.436084587334, 3798.9430158547643, 3804.524434445694, 1171.4025846818183, 1179.8584169899666, 1183.331417748969, 1186.5846953566183, 1190.7261329894172, 969.2294625772528, 981.5632043740467, 983.6508039645965, 989.6041583366567, 1006.7986402719486, 5431.2396264522995, 5531.474509921551, 5549.972250138723, 5591.720413979285, 5629.24005259293, 910.1944778870615, 990.757264470195, 999.605155963405, 1024.4416792847917, 1080.9459527023616, 3770.830312635938, 3810.580836108026, 3822.0444888777806, 3827.9808600956817, 3874.3413619684156, 9627.663031793854, 9818.116369526777, 9881.80236395268, 9956.103950644478, 10054.798904021878, 9301.255899528021, 9591.232701383873, 9862.802743945082, 9875.654352097787, 9891.35706179096, 7235.529690570096, 7256.0, 7305.232950540223, 7342.9632851835395, 7405.1484079330485, 5354.812581559627, 5391.379991301051, 5514.503694667339, 5630.155476678531, 5880.294364676266, 8524.36067294943, 8582.485050896967, 8742.475451472932, 8829.558522074, 8853.20321171072, 8482.660693572188, 8724.520151391735, 8737.169968852948, 8848.46909185451, 8907.910920890708, 6295.5907865988565, 6608.008798680236, 6641.867162656817, 6946.79159625212, 7014.193367762773, 7127.037849890198, 7258.491905566771, 7267.600281984542, 7290.125184977836, 7351.191368949304, 6774.93225067743, 7004.334588214111, 7037.577745335297, 7159.892601610876, 7248.855022899618, 6784.3894049535775, 6858.759943401957, 6926.307369263033, 6979.755708550177, 7027.121609798775, 6701.028350889192, 6702.128723266139, 6744.325567443413, 6870.20992585859, 6900.0, 4957.950420495749, 5047.419546752024, 5093.439721630692, 5099.311592934906, 5109.335786347751, 5032.823851165192, 5033.672811267256, 5070.264811602223, 5096.46487118862, 5116.258142569381], "value": 4329.6434869596505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8055286275372, 319.6632615580108, 320.5112203889069, 325.3639135490117, 327.8278903575624, 6604.60372377657, 6634.402903738669, 6635.369639884216, 6637.1703537057865, 6689.264180940093, 6496.6102033878, 6500.41496265336, 6500.934990650092, 6502.154719886408, 6511.055896894947, 4575.107853968478, 4699.436067671867, 4870.707757534542, 4875.488073752258, 4893.608511319104, 4853.635977301698, 4863.440704319013, 4872.439669438025, 4885.853424397274, 4903.8774030649165, 4817.51824817519, 4824.011077729075, 4824.734639594821, 4828.903421931559, 4839.903201935959, 4823.252395878627, 4830.3237546743485, 4836.46798852126, 4842.055799119174, 4850.417949846006, 4169.082801783603, 4209.494860616745, 4210.494740631113, 4213.747175169499, 4215.43091682622, 6056.0, 6230.283517395467, 6268.78059267928, 6275.6548389838545, 6312.305646378941, 5623.100303951348, 5635.351934527541, 5638.520725738317, 5656.377798442168, 5661.0, 6878.0, 6918.965405172992, 6928.16861976566, 6948.444124470081, 6950.061741664861, 4587.816487340502, 4610.67725259232, 4614.907701845944, 4615.123126605968, 4616.215243408628, 7235.565866048054, 7244.420446364278, 7287.562746235243, 7300.269973002711, 7308.524945878501, 4519.096180763795, 4689.460712018162, 4700.318453824177, 4712.740799256006, 4721.0, 4749.050189962021, 4758.690685105457, 4775.928361074587, 4784.043191361741, 4786.880327991828, 5580.91628625571, 5600.411956744483, 5610.719464026783, 5633.3240011198095, 5647.37878833328, 6983.127109111361, 7026.718931242795, 7043.119610048744, 7048.625518024039, 7051.92948070523, 1657.7927759030122, 1681.7645529625863, 1682.5877659973385, 1686.8060173080253, 1686.9240884160242, 1030.5620111452602, 1057.7884423115408, 1067.2209287220217, 1075.870895492546, 1086.0225796782959, 6724.361185687352, 6747.257801641816, 6766.018927255521, 6780.355866192704, 6783.660816959133, 6977.686004129826, 7233.05970223878, 7247.4926755126635, 7260.891086633705, 7270.890936635955, 6693.698783554752, 6758.459323254227, 6800.115984921928, 6803.353681400259, 6811.284815094443, 3889.3388124018984, 3891.2995660780766, 3895.7078219133678, 3906.062544989239, 3906.511686039245, 7468.626568671545, 7505.474616776883, 7541.321281084729, 7568.091828980558, 7595.392368610498, 7303.89044164338, 7372.778816635509, 7415.666295016737, 7433.591152486557, 7436.73971410998, 7495.700171993169, 7522.849543009219, 7534.434917381109, 7545.886811697829, 7580.0, 7282.526635768658, 7283.344498994904, 7303.488755787044, 7308.086489188851, 7349.228331025379, 7162.0, 7184.0, 7206.946020384165, 7213.531120477152, 7222.0, 7294.343509084208, 7505.924940750741, 7522.5862577558755, 7550.848983020419, 7579.810504737426, 4796.400449943757, 4822.758862056813, 4830.9854930465, 4854.247591623162, 4855.174620314484, 7228.698834209893, 7265.346118849329, 7267.745628902963, 7269.0, 7284.761590529517, 7087.291270872872, 7097.325754053357, 7101.7159313628945, 7108.431325494052, 7109.395701365442, 6819.113515242987, 7008.053912721717, 7028.894566581607, 7067.222605513287, 7105.25394833535, 6946.409555187865, 6955.652217389009, 6959.860802784017, 6966.721331146698, 6980.616066116412, 7059.223485416497, 7128.322809333105, 7135.678894449866, 7138.0363650906465, 7149.285071493017, 6906.654667266516, 6910.654467276717, 6936.918924322784, 6949.583025018313, 6952.721891124501], "value": 5180.597662396244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.9741009064684, 740.9182593413617, 761.744815486812, 770.6786418271017, 777.6034222546504, 13120.606381808537, 13335.799963000563, 13479.932600336997, 13535.52625658102, 13538.864611353883, 12235.265884046963, 12238.20451670643, 12310.0, 12311.445984930677, 12349.938250308758, 533.4239021856386, 539.8434454008333, 555.6082961512134, 557.760163129854, 565.1466285908267, 550.0154723045744, 550.3725752641972, 552.0063885006991, 553.1039715660636, 555.7110302642624, 727.799855039863, 732.0812380462538, 737.2774680812806, 738.2359258167797, 739.9704011839547, 612.7763366371287, 614.6527212125158, 615.6521565315583, 616.5345164400893, 616.9012957926733, 430.34372581812676, 433.26128950139935, 433.4408612889369, 434.3940203416217, 440.12195669638953, 13658.931705341409, 13658.931705341409, 13696.452141914311, 13708.794368084487, 13725.176489410667, 13223.272720000396, 13450.394732237073, 13483.393247303895, 13529.864701353057, 13725.519606813714, 11687.883121168765, 11747.7063073423, 11898.286102833858, 12705.364731763375, 12950.417231224617, 3745.4756334113245, 3805.7906815125157, 3829.2341531693774, 3892.338302488584, 3952.5256969163884, 57388.71305643487, 57611.0, 57798.13302800462, 57944.71027644877, 58410.70794646042, 10180.745481363025, 10280.0, 10534.841977370346, 10719.78560428787, 10835.566577336818, 18390.908045459953, 18401.079946002646, 18520.536986575175, 18541.44375668732, 20049.0, 8154.714584989615, 8453.619587118472, 8567.443116197428, 8578.4424012439, 8832.64669413229, 4827.517248275144, 4895.412550493964, 4931.112399768004, 4934.087193869145, 4941.50584941503, 3175.079227024183, 3203.6636153203576, 3228.4188846007946, 3229.273413481948, 3229.3218424131196, 594.1355327997753, 609.7225762278152, 620.1163342237294, 621.273110460762, 623.420219196152, 730.4558104212396, 742.5581778841581, 750.5909279442717, 754.5095687802972, 770.3529035610114, 9341.299402544837, 9446.149846513847, 9596.376235544667, 9849.803003939882, 9913.008699130174, 696.3906581740977, 731.974380896666, 756.2890882570366, 757.8787394016931, 766.2911806578892, 4420.624246939046, 4501.504834468205, 4541.682082254277, 4554.476235232991, 4574.702644328108, 66378.66810665916, 68435.0, 68754.31245687579, 69095.0, 69125.30874691189, 57902.71048644814, 58832.705836470544, 58968.41031589629, 59435.70282148562, 59637.403625964056, 49423.50576494261, 49702.0, 50432.495675043516, 53033.734831326365, 53602.0, 8932.240759535252, 8998.415103018282, 9103.180713735796, 9108.954455227682, 9147.679831205876, 36990.44514332234, 37647.2470550582, 37727.62272377241, 38859.805700971316, 39091.41362879616, 44071.77964110159, 44307.77846110749, 48526.75736621294, 50804.49195508145, 51417.485825142765, 11042.834357484804, 11092.11263098934, 11153.83269250978, 11266.303483378257, 11293.71765705864, 11683.649490515298, 11685.707857303636, 11869.0, 14040.859591404364, 14547.345369458188, 11790.882091178979, 12933.159344642569, 12961.287129207607, 13733.0, 13812.0, 12187.756244874876, 12307.076969227164, 12925.870741292843, 13084.542041028519, 13099.738005240033, 11152.275102118336, 11444.256123351955, 11888.583899563473, 11998.520059197534, 12761.872381276069, 10642.84035739449, 10755.0, 10794.136469082297, 10937.289076210021, 11512.884871151182, 10175.643852465128, 10732.356058636195, 10975.341479511255, 10994.395308258123, 11014.284071535325], "value": 6482.60403248533, "unit": "score"}], "name": "dromaeo_css", "value": 7060.974086269368, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 103.0, 110.0, 113.0, 113.0, 102.0, 110.0, 112.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 157.0, 175.0, 126.0, 156.0, 159.0, 124.0, 180.0, 127.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 169.0, 77.0, 75.0, 77.0, 83.0, 182.0, 78.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 162.0, 93.0, 94.0, 93.0, 143.0, 94.0, 93.0, 151.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 145.0, 151.0, 149.0, 146.0, 146.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 57.0, 60.0, 56.0, 57.0, 88.0, 54.0, 56.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 59.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 81.0, 76.0, 75.0, 83.0, 75.0, 74.0, 76.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 120.0, 123.0, 125.0, 121.0, 119.0, 115.0, 142.0, 127.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 163.0, 162.0, 159.0, 161.0, 175.0, 163.0, 157.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 66.0, 68.0, 66.0, 66.0, 68.0, 65.0, 69.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1535.9, "alertThreshold": 2.0}]} 02:18:02 INFO - Return code: 0 02:18:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:18:02 ERROR - # TBPL SUCCESS # 02:18:02 INFO - Running post-action listener: _resource_record_post_action 02:18:02 INFO - Running post-run listener: _resource_record_post_run 02:18:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 262144; Write bytes: 498188288; Read time: 20; Write time: 1489612 02:18:03 INFO - install - Wall time: 16s; CPU: 21.0%; Read bytes: 0; Write bytes: 250073088; Read time: 0; Write time: 1126000 02:18:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248115200; Read time: 20; Write time: 363612 02:18:03 INFO - Running post-run listener: _upload_blobber_files 02:18:03 INFO - Blob upload gear active. 02:18:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:18:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:18:04 INFO - (blobuploader) - INFO - Open directory for files ... 02:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:05 INFO - (blobuploader) - INFO - Done attempting. 02:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:06 INFO - (blobuploader) - INFO - Done attempting. 02:18:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:18:06 INFO - Return code: 0 02:18:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:18:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:18:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d688d5704f0e6fcb433c336f157576c0df8e97dc50e5d48eccd3b1fbc2eccd14ed136e67f791bc90b4345b08cf11009319769b674f8280224f112f70b44bf9ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9ab01252533e0f78480bc4bc5a51861726771690949886705b5e480e5ff33a5b9e2ad2e7394452ab6e741e8ca763e3fbc147adbd9026ba04fdb1c8cb72e4a12"} 02:18:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:18:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:18:06 INFO - Contents: 02:18:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d688d5704f0e6fcb433c336f157576c0df8e97dc50e5d48eccd3b1fbc2eccd14ed136e67f791bc90b4345b08cf11009319769b674f8280224f112f70b44bf9ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9ab01252533e0f78480bc4bc5a51861726771690949886705b5e480e5ff33a5b9e2ad2e7394452ab6e741e8ca763e3fbc147adbd9026ba04fdb1c8cb72e4a12"} 02:18:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:18:06 INFO - Copying logs to upload dir... 02:18:06 INFO - mkdir: /builds/slave/test/build/upload/logs 02:18:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.967882 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-27 02:18:05.841070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:05.844867) ========= 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=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d688d5704f0e6fcb433c336f157576c0df8e97dc50e5d48eccd3b1fbc2eccd14ed136e67f791bc90b4345b08cf11009319769b674f8280224f112f70b44bf9ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9ab01252533e0f78480bc4bc5a51861726771690949886705b5e480e5ff33a5b9e2ad2e7394452ab6e741e8ca763e3fbc147adbd9026ba04fdb1c8cb72e4a12"} build_url:https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/DeshrcsVRlKBAzVvOt_Bjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d688d5704f0e6fcb433c336f157576c0df8e97dc50e5d48eccd3b1fbc2eccd14ed136e67f791bc90b4345b08cf11009319769b674f8280224f112f70b44bf9ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9ab01252533e0f78480bc4bc5a51861726771690949886705b5e480e5ff33a5b9e2ad2e7394452ab6e741e8ca763e3fbc147adbd9026ba04fdb1c8cb72e4a12"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:05.870208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:05.870532) ========= 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=df17445c3590ff7897617a0e00000225-1464336946.828595-1023395458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 02:18:05.953285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:18:05.953611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 02:18:05.953902) ========= ========= Total master_lag: 0.18 =========