builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1460715492.8 results: success (0) buildid: 20160415004038 builduid: 67d6d06e83554bda87b9211ef3b633d1 revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.804732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.805252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.805570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.832128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.832418) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 03:18:13-- 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% 67.0M=0s 2016-04-15 03:18:13 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.978543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:12.978867) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016083 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.032484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.032848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4633816cde73beee6ed194e571c3a2ba14b15069 --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 4633816cde73beee6ed194e571c3a2ba14b15069 --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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 03:18:13,767 truncating revision to first 12 chars 2016-04-15 03:18:13,767 Setting DEBUG logging. 2016-04-15 03:18:13,767 attempt 1/10 2016-04-15 03:18:13,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4633816cde73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 03:18:14,027 unpacking tar archive at: mozilla-aurora-4633816cde73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.574693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.575019) ========= script_repo_revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.575486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.575793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:18:13.584579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-15 03:18:13.584930) ========= /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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:14 INFO - MultiFileLogger online at 20160415 03:18:14 in /builds/slave/test 03:18:14 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 03:18:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:14 INFO - {'append_to_log': False, 03:18:14 INFO - 'base_work_dir': '/builds/slave/test', 03:18:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:18:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:14 INFO - 'branch': 'Mozilla-Aurora', 03:18:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:14 INFO - 'config_files': ('talos/linux_config.py',), 03:18:14 INFO - 'default_actions': ('clobber', 03:18:14 INFO - 'read-buildbot-config', 03:18:14 INFO - 'download-and-extract', 03:18:14 INFO - 'populate-webroot', 03:18:14 INFO - 'create-virtualenv', 03:18:14 INFO - 'install', 03:18:14 INFO - 'run-tests'), 03:18:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:14 INFO - 'download_minidump_stackwalk': True, 03:18:14 INFO - 'download_symbols': 'ondemand', 03:18:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:14 INFO - 'installer_path': 'installer.exe', 03:18:14 INFO - 'log_level': 'info', 03:18:14 INFO - 'log_name': 'talos', 03:18:14 INFO - 'log_to_console': True, 03:18:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:14 INFO - 'opt_config_files': (), 03:18:14 INFO - 'pip_index': False, 03:18:14 INFO - 'sps_profile': False, 03:18:14 INFO - 'sps_profile_interval': 0, 03:18:14 INFO - 'suite': 'dromaeojs-e10s', 03:18:14 INFO - 'system_bits': '32', 03:18:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:14 INFO - 'title': 'talos-linux64-ix-039', 03:18:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:14 INFO - 'use_talos_json': True, 03:18:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:14 INFO - 'work_dir': 'build'} 03:18:14 INFO - ##### 03:18:14 INFO - ##### Running clobber step. 03:18:14 INFO - ##### 03:18:14 INFO - Running pre-action listener: _resource_record_pre_action 03:18:14 INFO - Running main action method: clobber 03:18:14 INFO - rmtree: /builds/slave/test/build 03:18:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:15 INFO - Running post-action listener: _resource_record_post_action 03:18:15 INFO - ##### 03:18:15 INFO - ##### Running read-buildbot-config step. 03:18:15 INFO - ##### 03:18:15 INFO - Running pre-action listener: _resource_record_pre_action 03:18:15 INFO - Running main action method: read_buildbot_config 03:18:15 INFO - Using buildbot properties: 03:18:15 INFO - { 03:18:15 INFO - "project": "", 03:18:15 INFO - "product": "firefox", 03:18:15 INFO - "script_repo_revision": "production", 03:18:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:18:15 INFO - "repository": "", 03:18:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:18:15 INFO - "buildid": "20160415004038", 03:18:15 INFO - "stage_platform": "linux64-pgo", 03:18:15 INFO - "basedir": "/builds/slave/test", 03:18:15 INFO - "nightly_build": "True", 03:18:15 INFO - "buildnumber": 243, 03:18:15 INFO - "slavename": "talos-linux64-ix-039", 03:18:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:15 INFO - "platform": "ubuntu64_hw", 03:18:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:18:15 INFO - "branch": "mozilla-aurora", 03:18:15 INFO - "repo_path": "releases/mozilla-aurora", 03:18:15 INFO - "revision": "4633816cde73beee6ed194e571c3a2ba14b15069", 03:18:15 INFO - "pgo_build": "True", 03:18:15 INFO - "builduid": "67d6d06e83554bda87b9211ef3b633d1", 03:18:15 INFO - "slavebuilddir": "test" 03:18:15 INFO - } 03:18:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:18:15 INFO - Running post-action listener: _resource_record_post_action 03:18:15 INFO - ##### 03:18:15 INFO - ##### Running download-and-extract step. 03:18:15 INFO - ##### 03:18:15 INFO - Running pre-action listener: _resource_record_pre_action 03:18:15 INFO - Running main action method: download_and_extract 03:18:15 INFO - mkdir: /builds/slave/test/build/tests 03:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:15 INFO - https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:18:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:18:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:18:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:18:25 INFO - Downloaded 1448 bytes. 03:18:25 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:18:25 INFO - Using the following test package requirements: 03:18:25 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:18:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:18:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'jsshell-linux-x86_64.zip'], 03:18:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:18:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:18:25 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:18:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:18:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:18:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:18:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:18:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:25 INFO - https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:30 INFO - Downloaded 23352611 bytes. 03:18:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:31 INFO - Return code: 0 03:18:31 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:31 INFO - https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:18:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:18:41 INFO - Downloaded 23352611 bytes. 03:18:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:18:43 INFO - Return code: 0 03:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:43 INFO - https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:18:44 INFO - Downloaded 10845168 bytes. 03:18:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:18:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:18:44 INFO - Return code: 0 03:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:44 INFO - https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:18:45 INFO - Downloaded 60563158 bytes. 03:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:18:45 INFO - mkdir: /builds/slave/test/properties 03:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:45 INFO - Contents: 03:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:18:46 INFO - Running post-action listener: _resource_record_post_action 03:18:46 INFO - Running post-action listener: set_extra_try_arguments 03:18:46 INFO - ##### 03:18:46 INFO - ##### Running populate-webroot step. 03:18:46 INFO - ##### 03:18:46 INFO - Running pre-action listener: _resource_record_pre_action 03:18:46 INFO - Running main action method: populate_webroot 03:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:46 INFO - '--tppagecycles', 03:18:46 INFO - '7'], 03:18:46 INFO - 'tests': ['tsvgm']}}, 03:18:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:18:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:18:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'tests': ['damp', 'tps']}, 03:18:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['damp', 'tps']}, 03:18:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:46 INFO - 'other': {'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'other_l64': {'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'other_nol64': {'tests': ['a11yr', 03:18:46 INFO - 'ts_paint', 03:18:46 INFO - 'tpaint', 03:18:46 INFO - 'sessionrestore', 03:18:46 INFO - 'sessionrestore_no_auto_restore', 03:18:46 INFO - 'tabpaint']}, 03:18:46 INFO - 'svgr': {'tests': ['tsvgx', 03:18:46 INFO - 'tsvgr_opacity', 03:18:46 INFO - 'tart', 03:18:46 INFO - 'tscrollx', 03:18:46 INFO - 'cart']}, 03:18:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['tsvgx', 03:18:46 INFO - 'tsvgr_opacity', 03:18:46 INFO - 'tart', 03:18:46 INFO - 'tscrollx', 03:18:46 INFO - 'cart']}, 03:18:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'tests': ['tp5o']}, 03:18:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'talos_options': ['--e10s'], 03:18:46 INFO - 'tests': ['tp5o']}, 03:18:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'talos_options': ['--xperf_path', 03:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:46 INFO - 'tests': ['tp5n']}, 03:18:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:46 INFO - 'talos_options': ['--e10s', 03:18:46 INFO - '--xperf_path', 03:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:46 INFO - 'tests': ['tp5n']}}, 03:18:46 INFO - 'talos.zip': {'path': '', 03:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:46 INFO - Running post-action listener: _resource_record_post_action 03:18:46 INFO - ##### 03:18:46 INFO - ##### Running create-virtualenv step. 03:18:46 INFO - ##### 03:18:46 INFO - Running pre-action listener: _resource_record_pre_action 03:18:46 INFO - Running main action method: create_virtualenv 03:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:46 INFO - Using real prefix '/usr' 03:18:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:49 INFO - Installing pip.................done. 03:18:49 INFO - Return code: 0 03:18:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:49 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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:49 INFO - Using env: {'DISPLAY': ':0', 03:18:49 INFO - 'HOME': '/home/cltbld', 03:18:49 INFO - 'LANG': 'en_US.UTF-8', 03:18:49 INFO - 'LANGUAGE': 'en_US:en', 03:18:49 INFO - 'LOGNAME': 'cltbld', 03:18:49 INFO - 'MAIL': '/var/mail/cltbld', 03:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:49 INFO - 'MOZ_NO_REMOTE': '1', 03:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:49 INFO - 'NO_EM_RESTART': '1', 03:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:49 INFO - 'PWD': '/builds/slave/test', 03:18:49 INFO - 'SHELL': '/bin/bash', 03:18:49 INFO - 'SHLVL': '1', 03:18:49 INFO - 'TERM': 'linux', 03:18:49 INFO - 'TMOUT': '86400', 03:18:49 INFO - 'USER': 'cltbld', 03:18:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:49 INFO - '_': '/tools/buildbot/bin/python'} 03:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:18:49 INFO - Cleaning up... 03:18:49 INFO - Return code: 0 03:18:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:49 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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:18:49 INFO - Using env: {'DISPLAY': ':0', 03:18:49 INFO - 'HOME': '/home/cltbld', 03:18:49 INFO - 'LANG': 'en_US.UTF-8', 03:18:49 INFO - 'LANGUAGE': 'en_US:en', 03:18:49 INFO - 'LOGNAME': 'cltbld', 03:18:49 INFO - 'MAIL': '/var/mail/cltbld', 03:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:49 INFO - 'MOZ_NO_REMOTE': '1', 03:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:49 INFO - 'NO_EM_RESTART': '1', 03:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:49 INFO - 'PWD': '/builds/slave/test', 03:18:49 INFO - 'SHELL': '/bin/bash', 03:18:49 INFO - 'SHLVL': '1', 03:18:49 INFO - 'TERM': 'linux', 03:18:49 INFO - 'TMOUT': '86400', 03:18:49 INFO - 'USER': 'cltbld', 03:18:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:49 INFO - '_': '/tools/buildbot/bin/python'} 03:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:49 INFO - Downloading/unpacking psutil>=0.7.1 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:51 INFO - Installing collected packages: psutil 03:18:51 INFO - Running setup.py install for psutil 03:18:51 INFO - building 'psutil._psutil_linux' extension 03:18:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:52 INFO - building 'psutil._psutil_posix' extension 03:18:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:52 INFO - Successfully installed psutil 03:18:52 INFO - Cleaning up... 03:18:52 INFO - Return code: 0 03:18:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:18:52 INFO - Using env: {'DISPLAY': ':0', 03:18:52 INFO - 'HOME': '/home/cltbld', 03:18:52 INFO - 'LANG': 'en_US.UTF-8', 03:18:52 INFO - 'LANGUAGE': 'en_US:en', 03:18:52 INFO - 'LOGNAME': 'cltbld', 03:18:52 INFO - 'MAIL': '/var/mail/cltbld', 03:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:52 INFO - 'MOZ_NO_REMOTE': '1', 03:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:52 INFO - 'NO_EM_RESTART': '1', 03:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:52 INFO - 'PWD': '/builds/slave/test', 03:18:52 INFO - 'SHELL': '/bin/bash', 03:18:52 INFO - 'SHLVL': '1', 03:18:52 INFO - 'TERM': 'linux', 03:18:52 INFO - 'TMOUT': '86400', 03:18:52 INFO - 'USER': 'cltbld', 03:18:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:52 INFO - '_': '/tools/buildbot/bin/python'} 03:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:18:54 INFO - Installing collected packages: mozsystemmonitor 03:18:54 INFO - Running setup.py install for mozsystemmonitor 03:18:54 INFO - Successfully installed mozsystemmonitor 03:18:54 INFO - Cleaning up... 03:18:54 INFO - Return code: 0 03:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:54 INFO - Using env: {'DISPLAY': ':0', 03:18:54 INFO - 'HOME': '/home/cltbld', 03:18:54 INFO - 'LANG': 'en_US.UTF-8', 03:18:54 INFO - 'LANGUAGE': 'en_US:en', 03:18:54 INFO - 'LOGNAME': 'cltbld', 03:18:54 INFO - 'MAIL': '/var/mail/cltbld', 03:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:54 INFO - 'MOZ_NO_REMOTE': '1', 03:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:54 INFO - 'NO_EM_RESTART': '1', 03:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:54 INFO - 'PWD': '/builds/slave/test', 03:18:54 INFO - 'SHELL': '/bin/bash', 03:18:54 INFO - 'SHLVL': '1', 03:18:54 INFO - 'TERM': 'linux', 03:18:54 INFO - 'TMOUT': '86400', 03:18:54 INFO - 'USER': 'cltbld', 03:18:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:54 INFO - '_': '/tools/buildbot/bin/python'} 03:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - Downloading docopt-0.6.1.tar.gz 03:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:57 INFO - Running setup.py install for blobuploader 03:18:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:57 INFO - Running setup.py install for requests 03:18:58 INFO - Running setup.py install for docopt 03:18:58 INFO - Successfully installed blobuploader requests docopt 03:18:58 INFO - Cleaning up... 03:18:58 INFO - Return code: 0 03:18:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:58 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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:18:58 INFO - Using env: {'DISPLAY': ':0', 03:18:58 INFO - 'HOME': '/home/cltbld', 03:18:58 INFO - 'LANG': 'en_US.UTF-8', 03:18:58 INFO - 'LANGUAGE': 'en_US:en', 03:18:58 INFO - 'LOGNAME': 'cltbld', 03:18:58 INFO - 'MAIL': '/var/mail/cltbld', 03:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:58 INFO - 'MOZ_NO_REMOTE': '1', 03:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:58 INFO - 'NO_EM_RESTART': '1', 03:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:58 INFO - 'PWD': '/builds/slave/test', 03:18:58 INFO - 'SHELL': '/bin/bash', 03:18:58 INFO - 'SHLVL': '1', 03:18:58 INFO - 'TERM': 'linux', 03:18:58 INFO - 'TMOUT': '86400', 03:18:58 INFO - 'USER': 'cltbld', 03:18:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:58 INFO - '_': '/tools/buildbot/bin/python'} 03:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:58 INFO - Running setup.py (path:/tmp/pip-FrPYie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:58 INFO - Running setup.py (path:/tmp/pip-6Z5ohU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:58 INFO - Running setup.py (path:/tmp/pip-CtALs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:58 INFO - Running setup.py (path:/tmp/pip-1AdnVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:58 INFO - Running setup.py (path:/tmp/pip-ShG9bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:58 INFO - Running setup.py (path:/tmp/pip-cqxjvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:58 INFO - Running setup.py (path:/tmp/pip-i1LpSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:58 INFO - Running setup.py (path:/tmp/pip-79yRz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:58 INFO - Running setup.py (path:/tmp/pip-3GeeP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:59 INFO - Running setup.py (path:/tmp/pip-PycREM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:59 INFO - Running setup.py (path:/tmp/pip-X44mKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:59 INFO - Running setup.py (path:/tmp/pip-nqfFkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:59 INFO - Running setup.py (path:/tmp/pip-_5xxzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:59 INFO - Running setup.py (path:/tmp/pip-50aN4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:59 INFO - Running setup.py (path:/tmp/pip-ekBfTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:59 INFO - Running setup.py (path:/tmp/pip-rG_uQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:59 INFO - Running setup.py (path:/tmp/pip-VuglWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:59 INFO - Running setup.py install for manifestparser 03:18:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:59 INFO - Running setup.py install for mozcrash 03:18:59 INFO - Running setup.py install for mozdebug 03:18:59 INFO - Running setup.py install for mozdevice 03:19:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozfile 03:19:00 INFO - Running setup.py install for mozhttpd 03:19:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozinfo 03:19:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozInstall 03:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozleak 03:19:00 INFO - Running setup.py install for mozlog 03:19:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for moznetwork 03:19:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozprocess 03:19:00 INFO - Running setup.py install for mozprofile 03:19:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:00 INFO - Running setup.py install for mozrunner 03:19:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:01 INFO - Running setup.py install for mozscreenshot 03:19:01 INFO - Running setup.py install for moztest 03:19:01 INFO - Running setup.py install for mozversion 03:19:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:01 INFO - Cleaning up... 03:19:01 INFO - Return code: 0 03:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:01 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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:01 INFO - Using env: {'DISPLAY': ':0', 03:19:01 INFO - 'HOME': '/home/cltbld', 03:19:01 INFO - 'LANG': 'en_US.UTF-8', 03:19:01 INFO - 'LANGUAGE': 'en_US:en', 03:19:01 INFO - 'LOGNAME': 'cltbld', 03:19:01 INFO - 'MAIL': '/var/mail/cltbld', 03:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:01 INFO - 'MOZ_NO_REMOTE': '1', 03:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:01 INFO - 'NO_EM_RESTART': '1', 03:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:01 INFO - 'PWD': '/builds/slave/test', 03:19:01 INFO - 'SHELL': '/bin/bash', 03:19:01 INFO - 'SHLVL': '1', 03:19:01 INFO - 'TERM': 'linux', 03:19:01 INFO - 'TMOUT': '86400', 03:19:01 INFO - 'USER': 'cltbld', 03:19:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:01 INFO - '_': '/tools/buildbot/bin/python'} 03:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:01 INFO - Running setup.py (path:/tmp/pip-4dUZ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:01 INFO - Running setup.py (path:/tmp/pip-GjFFcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:01 INFO - Running setup.py (path:/tmp/pip-KYwwcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:01 INFO - Running setup.py (path:/tmp/pip-69tMKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:01 INFO - Running setup.py (path:/tmp/pip-eYkQoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:01 INFO - Running setup.py (path:/tmp/pip-P3ammW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:02 INFO - Running setup.py (path:/tmp/pip-rq8HF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:02 INFO - Running setup.py (path:/tmp/pip-LmaUSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:02 INFO - Running setup.py (path:/tmp/pip-WcBSVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:02 INFO - Running setup.py (path:/tmp/pip-9DcgSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:02 INFO - Running setup.py (path:/tmp/pip-P9aOXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:02 INFO - Running setup.py (path:/tmp/pip-kGXmbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:02 INFO - Running setup.py (path:/tmp/pip-veZepq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:02 INFO - Running setup.py (path:/tmp/pip-DFxP7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:02 INFO - Running setup.py (path:/tmp/pip-0SLiQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:02 INFO - Running setup.py (path:/tmp/pip-clpm81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:02 INFO - Running setup.py (path:/tmp/pip-hbqXHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:04 INFO - Downloading blessings-1.6.tar.gz 03:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:04 INFO - Installing collected packages: blessings 03:19:04 INFO - Running setup.py install for blessings 03:19:04 INFO - Successfully installed blessings 03:19:04 INFO - Cleaning up... 03:19:04 INFO - Return code: 0 03:19:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:05 INFO - Reading from file tmpfile_stdout 03:19:05 INFO - Current package versions: 03:19:05 INFO - argparse == 1.2.1 03:19:05 INFO - blessings == 1.6 03:19:05 INFO - blobuploader == 1.2.4 03:19:05 INFO - docopt == 0.6.1 03:19:05 INFO - manifestparser == 1.1 03:19:05 INFO - mozInstall == 1.12 03:19:05 INFO - mozcrash == 0.17 03:19:05 INFO - mozdebug == 0.1 03:19:05 INFO - mozdevice == 0.48 03:19:05 INFO - mozfile == 1.2 03:19:05 INFO - mozhttpd == 0.7 03:19:05 INFO - mozinfo == 0.9 03:19:05 INFO - mozleak == 0.1 03:19:05 INFO - mozlog == 3.1 03:19:05 INFO - moznetwork == 0.27 03:19:05 INFO - mozprocess == 0.22 03:19:05 INFO - mozprofile == 0.28 03:19:05 INFO - mozrunner == 6.11 03:19:05 INFO - mozscreenshot == 0.1 03:19:05 INFO - mozsystemmonitor == 0.0 03:19:05 INFO - moztest == 0.7 03:19:05 INFO - mozversion == 1.4 03:19:05 INFO - psutil == 3.1.1 03:19:05 INFO - requests == 1.2.3 03:19:05 INFO - wsgiref == 0.1.2 03:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:05 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 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:05 INFO - Using env: {'DISPLAY': ':0', 03:19:05 INFO - 'HOME': '/home/cltbld', 03:19:05 INFO - 'LANG': 'en_US.UTF-8', 03:19:05 INFO - 'LANGUAGE': 'en_US:en', 03:19:05 INFO - 'LOGNAME': 'cltbld', 03:19:05 INFO - 'MAIL': '/var/mail/cltbld', 03:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:05 INFO - 'MOZ_NO_REMOTE': '1', 03:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:05 INFO - 'NO_EM_RESTART': '1', 03:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:05 INFO - 'PWD': '/builds/slave/test', 03:19:05 INFO - 'SHELL': '/bin/bash', 03:19:05 INFO - 'SHLVL': '1', 03:19:05 INFO - 'TERM': 'linux', 03:19:05 INFO - 'TMOUT': '86400', 03:19:05 INFO - 'USER': 'cltbld', 03:19:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:05 INFO - '_': '/tools/buildbot/bin/python'} 03:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:05 INFO - Cleaning up... 03:19:05 INFO - Return code: 0 03:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:19:05 INFO - Using env: {'DISPLAY': ':0', 03:19:05 INFO - 'HOME': '/home/cltbld', 03:19:05 INFO - 'LANG': 'en_US.UTF-8', 03:19:05 INFO - 'LANGUAGE': 'en_US:en', 03:19:05 INFO - 'LOGNAME': 'cltbld', 03:19:05 INFO - 'MAIL': '/var/mail/cltbld', 03:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:05 INFO - 'MOZ_NO_REMOTE': '1', 03:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:05 INFO - 'NO_EM_RESTART': '1', 03:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:05 INFO - 'PWD': '/builds/slave/test', 03:19:05 INFO - 'SHELL': '/bin/bash', 03:19:05 INFO - 'SHLVL': '1', 03:19:05 INFO - 'TERM': 'linux', 03:19:05 INFO - 'TMOUT': '86400', 03:19:05 INFO - 'USER': 'cltbld', 03:19:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:05 INFO - '_': '/tools/buildbot/bin/python'} 03:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:05 INFO - Downloading/unpacking jsonschema 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:07 INFO - Downloading/unpacking functools32 (from jsonschema) 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:07 INFO - warning: no files found matching '*.txt' 03:19:07 INFO - no previously-included directories found matching 'build' 03:19:07 INFO - no previously-included directories found matching 'dist' 03:19:07 INFO - no previously-included directories found matching '.git*' 03:19:07 INFO - Installing collected packages: jsonschema, functools32 03:19:07 INFO - Running setup.py install for functools32 03:19:07 INFO - warning: no files found matching '*.txt' 03:19:07 INFO - no previously-included directories found matching 'build' 03:19:07 INFO - no previously-included directories found matching 'dist' 03:19:07 INFO - no previously-included directories found matching '.git*' 03:19:07 INFO - Successfully installed jsonschema functools32 03:19:07 INFO - Cleaning up... 03:19:07 INFO - Return code: 0 03:19:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a96c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:19:07 INFO - Using env: {'DISPLAY': ':0', 03:19:07 INFO - 'HOME': '/home/cltbld', 03:19:07 INFO - 'LANG': 'en_US.UTF-8', 03:19:07 INFO - 'LANGUAGE': 'en_US:en', 03:19:07 INFO - 'LOGNAME': 'cltbld', 03:19:07 INFO - 'MAIL': '/var/mail/cltbld', 03:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:07 INFO - 'MOZ_NO_REMOTE': '1', 03:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:07 INFO - 'NO_EM_RESTART': '1', 03:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:07 INFO - 'PWD': '/builds/slave/test', 03:19:07 INFO - 'SHELL': '/bin/bash', 03:19:07 INFO - 'SHLVL': '1', 03:19:07 INFO - 'TERM': 'linux', 03:19:07 INFO - 'TMOUT': '86400', 03:19:07 INFO - 'USER': 'cltbld', 03:19:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:07 INFO - '_': '/tools/buildbot/bin/python'} 03:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:08 INFO - Downloading/unpacking flake8 03:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:19:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:19:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:10 INFO - no previously-included directories found matching 'docs/_build' 03:19:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:19:10 INFO - Running setup.py install for pep8 03:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:10 INFO - no previously-included directories found matching 'docs/_build' 03:19:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:19:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:19:11 INFO - Cleaning up... 03:19:11 INFO - Return code: 0 03:19:11 INFO - Running post-action listener: _resource_record_post_action 03:19:11 INFO - Running post-action listener: _start_resource_monitoring 03:19:11 INFO - Starting resource monitoring. 03:19:11 INFO - ##### 03:19:11 INFO - ##### Running install step. 03:19:11 INFO - ##### 03:19:11 INFO - Running pre-action listener: _resource_record_pre_action 03:19:11 INFO - Running main action method: install 03:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:11 INFO - Reading from file tmpfile_stdout 03:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:11 INFO - Reading from file tmpfile_stdout 03:19:11 INFO - Output received: 03:19:11 INFO - Usage: mozinstall [options] installer 03:19:11 INFO - Options: 03:19:11 INFO - -h, --help show this help message and exit 03:19:11 INFO - -d DEST, --destination=DEST 03:19:11 INFO - Directory to install application into. [default: 03:19:11 INFO - "/builds/slave/test"] 03:19:11 INFO - --app=APP Application being installed. [default: firefox] 03:19:11 INFO - mkdir: /builds/slave/test/build/application 03:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:19:26 INFO - Reading from file tmpfile_stdout 03:19:26 INFO - Output received: 03:19:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:26 INFO - Running post-action listener: _resource_record_post_action 03:19:26 INFO - ##### 03:19:26 INFO - ##### Running run-tests step. 03:19:26 INFO - ##### 03:19:26 INFO - Running pre-action listener: _resource_record_pre_action 03:19:26 INFO - Running main action method: run_tests 03:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:26 INFO - Python 2.7.3 03:19:26 INFO - Return code: 0 03:19:26 INFO - grabbing minidump binary from tooltool 03:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:26 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 0x1c83160>, '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 0x1c84060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c844f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:19:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:19:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:26 INFO - Return code: 0 03:19:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:19:27 INFO - Return code: 0 03:19:27 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/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 03:19:27 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/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 03:19:27 INFO - Using env: {'DISPLAY': ':0', 03:19:27 INFO - 'HOME': '/home/cltbld', 03:19:27 INFO - 'LANG': 'en_US.UTF-8', 03:19:27 INFO - 'LANGUAGE': 'en_US:en', 03:19:27 INFO - 'LOGNAME': 'cltbld', 03:19:27 INFO - 'MAIL': '/var/mail/cltbld', 03:19:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:27 INFO - 'MOZ_NO_REMOTE': '1', 03:19:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:27 INFO - 'NO_EM_RESTART': '1', 03:19:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:27 INFO - 'PWD': '/builds/slave/test', 03:19:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:27 INFO - 'SHELL': '/bin/bash', 03:19:27 INFO - 'SHLVL': '1', 03:19:27 INFO - 'TERM': 'linux', 03:19:27 INFO - 'TMOUT': '86400', 03:19:27 INFO - 'USER': 'cltbld', 03:19:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099', 03:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:27 INFO - '_': '/tools/buildbot/bin/python'} 03:19:27 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/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 03:19:27 INFO - mozversion application_buildid: 20160415004038 03:19:27 INFO - mozversion application_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 03:19:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:19:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:27 INFO - mozversion application_name: Firefox 03:19:27 INFO - mozversion application_remotingname: firefox-dev 03:19:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:19:27 INFO - mozversion application_vendor: Mozilla 03:19:27 INFO - mozversion application_version: 47.0a2 03:19:27 INFO - mozversion platform_buildid: 20160415004038 03:19:27 INFO - mozversion platform_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 03:19:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:19:27 INFO - mozversion platform_version: 47.0a2 03:19:27 INFO - using testdate: 1460715567 03:19:27 INFO - actual date: 1460715567 03:19:27 INFO - starting webserver on 'localhost:60609' 03:19:27 INFO - SUITE-START | Running 2 tests 03:19:27 INFO - TEST-START | dromaeo_css 03:19:27 INFO - operating with platform_type : linux_ 03:19:27 INFO - Initialising browser for dromaeo_css test... 03:19:27 INFO - TEST-INFO | started process 1821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2wFN0/profile http://localhost:60609/getInfo.html) 03:19:32 INFO - PROCESS | 1821 | 03:19:32 INFO - PROCESS | 1821 | (process:1895): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:32 INFO - PROCESS | 1821 | __metrics Screen width/height:1600/1200 03:19:32 INFO - PROCESS | 1821 | colorDepth:24 03:19:32 INFO - PROCESS | 1821 | Browser inner width/height: 1024/697 03:19:32 INFO - PROCESS | 1821 | __metrics 03:19:33 ERROR - PROCESS | 1821 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:19:34 INFO - TEST-INFO | 1821: exit 0 03:19:34 INFO - Browser initialized. 03:19:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:34 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2wFN0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:36 INFO - PROCESS | 1946 | 03:19:36 INFO - PROCESS | 1946 | (process:2016): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:19:46 INFO - PROCESS | 1946 | RSS: Main: 151150592 03:19:46 INFO - PROCESS | 1946 | 03:20:35 INFO - PROCESS | 1946 | 1460715635953 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:22:43 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60609/tests/dromaeo/cssquery-ext.html) 03:22:44 INFO - PROCESS | 1946 | RSS: Main: 154062848 03:22:44 INFO - PROCESS | 1946 | 03:25:46 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-ext.html (next: http://localhost:60609/tests/dromaeo/cssquery-jquery.html) 03:25:47 INFO - PROCESS | 1946 | RSS: Main: 153309184 03:25:47 INFO - PROCESS | 1946 | 03:28:49 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60609/tests/dromaeo/cssquery-mootools.html) 03:28:49 INFO - PROCESS | 1946 | RSS: Main: 152686592 03:28:49 INFO - PROCESS | 1946 | 03:31:51 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60609/tests/dromaeo/cssquery-prototype.html) 03:31:51 INFO - PROCESS | 1946 | RSS: Main: 152465408 03:31:51 INFO - PROCESS | 1946 | 03:34:54 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60609/tests/dromaeo/cssquery-yui.html) 03:34:54 INFO - PROCESS | 1946 | RSS: Main: 153620480 03:34:54 INFO - PROCESS | 1946 | 03:37:56 INFO - PROCESS | 1946 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-yui.html (next: http://localhost:60609/tests/dromaeo/cssquery-dojo.html) 03:37:57 INFO - PROCESS | 1946 | RSS: Main: 154894336 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | __start_tp_report 03:37:57 INFO - PROCESS | 1946 | _x_x_mozilla_page_load 03:37:57 INFO - PROCESS | 1946 | _x_x_mozilla_page_load_details 03:37:57 INFO - PROCESS | 1946 | |i|pagename|runs| 03:37:57 INFO - PROCESS | 1946 | |0;dojo.html;3331.9833400833;3402.2515046689728;3407.7955322680655;3444.328355970587;3446.0351101691517;5492.615516913817;5523.806666766664;5535.446455354472;5547;5565.471280228377;5524.06090964536;5554.9722251388785;5556.027695153352;5563.749631266593;5567.721613919308;5085.135526960407;5087.79648814047;5089.669171503859;5119.0529751996;5163.870903227412;5058.898822023557;5129.051125541768;5166.870828229286;5167.3282473278605;5174.611904107188;5105.821296254632;5167.457416971201;5231.581473482112;5257.36911570612;5323.627346085776;5154.484551544853;5191.922121168185;5193.221016847466;5208.947910520922;5215.087359712035;4996.150654388763;5040.445550989388;5045.445001049881;5102.413222479426;5183.196604526304;5421.430749771257;5448.83653490396;5467.808626698086;5481.725913704338;5482.588805839578;5953.8809223815715;6076.240469941257;6095.786647467362;6124.908126378108;6133.895898738226;6034.366391528914;6039.365866583989;6048.213732214828;6061.515078793686;6082.847928801815;5683.3464151622675;5685.431456854323;5690.886182276414;5695.03184458643;5695.45893140151;6060.363661815446;6089.969550152221;6128.808691620048;6174.25908890936;6195.380461953769;5905.4685078343155;5908.438698323653;5911.142884281841;5921.585489015728;5932.970335148297;5996.370381110008;5997.940020599825;6004.309504407049;6007.068904319837;6011.579189456696;5860.648361098348;5994.340622531518;6090.786822461193;6114.724837382329;6121.300552271563;6082.057281121433;6098.54260930432;6102.7558897644485;6104.359042300494;6105.023196288573;4576.656750743641;4613.746243956614;4630.21286381316;4631;4668.906621867543;4089.754614723126;4121.175764846983;4149.647279981235;4169.56219596944;4214.262504061777;5628.240187574707;5688.374278829326;5716.142578613241;5726.656400615976;5841.649501029951;6166.105914642441;6175.228096487939;6179.969100154561;6181.289151747516;6187;5700.116481945305;5702.287214098238;5723.6851973141875;5725.627834190765;5774.191613174159;5019.47295533971;5024.824131155392;5035.496450354935;5051.974740126276;5067.391912970394;6284.465820405226;6308.337624549448;6324.494040476751;6327.841803954938;6337.588056776295;6029.487493563096;6110.511159107261;6118.204633397808;6121.418465245794;6160.845978850564;6251.312355640966;6311.431971122621;6329.651869147241;6337.366263373626;6353.5870168438905;6000.51995840323;6040.244969378828;6048.032314829607;6085.9695701521205;6090.482309003784;6016;6129.295131059986;6139.017757158833;6148.78479253224;6189.81430557084;5972.641641501524;5976.7908123215475;5991.850203744942;6005.099235114593;6037.426444487766;6020.8795824084145;6024.66864322449;6028.849278767891;6032.33644299118;6033.607815491979;5744.167095771007;5811.186433899342;5888.646681199141;5888.911666325094;5928.170056192051;5933.258342707161;5938.198343223609;5989.3112292085225;5997.520198384032;6012.098185272244;5729.312482502127;5893.5874488785375;5914.172015917689;5919.31927828288;5921.6743079131065 03:37:57 INFO - PROCESS | 1946 | |1;ext.html;507.0669967260243;549.9990018166935;550.7383992603511;568.6872220278847;589.3605438099662;30963;38989.22021559567;39818.2036359273;40336;40447;42350.94122646935;43553.34669979953;43818.342724859154;43911;43963.34054989178;9128.041555636679;9321.114494123047;9334.06659334068;9335.206507446841;9360.719178424624;8057.758267251992;9424.481653509054;9435.103665151799;9466.66866659667;9469;9290.210332121744;9433.81132377352;9484.099010593982;9492.477913714743;9495.620175192984;9286.349955503118;9354.158125768714;9426.95286523563;9440.05599440054;9453.101955314269;9206.355555111146;9328.48693321867;9333.439993600407;9338.906610933871;9342.532873356373;43388.56611433877;43633.781831090644;43766;43772.12455750899;44013.779931100136;3500.422430298998;3567.7859328440118;3671.9816400918094;3683.631636836322;3802.6957843372466;31900.840495797605;32157.356852862813;32726;32774;33194.83402582996;4051.8581849635416;4060.614241647039;4072.75563466193;4083.591640835922;4100.65144462721;287891.9999999979;288160;288552;288870;289067;45278.32082518765;59656;59847.40152598506;60276.698616507514;60326;45073.77463112663;45394.31908521309;45403.09193816105;45511.317330240076;45539.772301138284;14797.556073317817;14958.551243462714;14967.775483367759;15019;15056.247187640574;11525.711857203636;11574.421278936019;11626.128040397005;11659.24214926044;11672.241304315192;15191.924040379727;15219.162946037854;15758.527244182693;15783.210839457981;15809.446669366516;5696.458836410535;5959.135925290809;6054.303755068224;6092.939070609325;6147.231596050494;1096.9341839489657;1107.3687997841314;1133.4389477208833;1146.5012719467059;1186.7329850783506;29643.110706678835;29724.40551188964;30036.34152056111;30709.385812284076;30747.23131921675;1133.1274918312854;1158.449736375215;1204.3195594489086;1223.7762237762238;1265.9998601105024;15316.463923762838;15370.164034355752;15512.92243538775;15823.287952042187;15971.760423593656;333760;567444;567867;568534;576417;54362.184567231525;54871;55415;55541.72229138829;55631;1465.8167729033871;1478.7560052591202;1505.533284681752;1510.9773353399487;1514.3639671338065;28430;30882.382352353277;31100.523774163732;31276.530852036783;31571.36857262796;50280.245796313815;51518.22722659088;51654;51709.482905170466;51899.48100518947;315978;316597;318782;319953;320420;34098;34600.30799383948;47703.76148119376;48470.5152948466;48773.75613121912;42438.5756142447;43685.56314436815;43785.34321985109;43886.34170487381;44778.55221447874;36599.63400365962;37131.814340928126;39734.40398393969;40126.473697860034;40793.59206408016;39294;40479.988000300225;40694.59305407026;40801.1839763209;40948.79525602472;39208;39649.80175099106;40163.19673606453;40505.39241911432;40548.594514055665;34345.484817728255;34910.65089349074;35226.47160292546;35480.46779298261;35815.82092089523;27258.45483090367;27407.725922740516;27606.861965690045;27683.861580691966;28010.579841302806 03:37:57 INFO - PROCESS | 1946 | |2;jquery.html;384.4022544942614;385.85786073223255;390.5489160020178;390.5645205595758;397.05698964958225;17139.087674409315;19248.23007079715;19611;19658.311959081435;19748.70376944347;18237.36169234077;18381.172847221875;18518.351857684982;18532;18635.62728745424;5466.316710411199;5653.349864765543;5679.261695979517;5681.9431805681825;5688;4286.485621725382;6019.699015049252;6243.625382477043;6275.592086514384;6297.275813281485;6006.489448396892;6248.625082495065;6252;6256.124142620037;6265.812025639215;6133.631982081067;6187.783427580013;6192.442680158807;6203.503719702413;6217.658028808413;5444.3194600674915;5451.209574611659;5466;5488.780448782044;5521.613487055908;21129.577408451743;21635.67546486804;21769.346919592437;21781.128754849786;22133.114675412966;2349.7180338359335;2430.298790846397;2510.962335564968;2520.4455019895777;2532.159113397967;13612.455501779918;14095.506657266946;14099.083559568595;14102.224377659224;14105.506307279196;1920.3470819921154;1924.0379810094953;1951.590166065128;1986.9006549672458;1996.5208349995896;65228.67385663041;67218.66390668064;67305.66347168233;67443;67545.98681019837;9878.357906736182;10024.649137280161;10146.188304935587;10171.491425428847;10332.896671033344;13972.930135349257;14058.929705351407;14145.151290922578;14155.221462819438;14232.359543820552;7752.7286544971785;7827.9608601956625;7876.330511906552;7910.920890791133;7937.960310198412;7624.161342252348;7709.151993280735;7710.151883292833;7727.961360193275;7728.304452599181;5852.151438041546;5911.083782013795;5968;6036.094585812076;6047.12316714074;1838.9908050459662;1944.8735832171146;1952.7461430014007;1983.9900800495905;1989.6418644643813;933.6918816790443;937.7093101138669;946.6260826973445;1068.7595291059604;1107.1585594947899;16027.439039633557;16133.435329763402;17196;17474.213660385314;17919.552011199565;974.8099120671543;984.2814745236018;993.7863359377624;1067.813132701774;1081.2647399768075;9996.150327222122;10160.796784064425;10185.185185185168;10348.586056557804;10382.221333399873;401412;405668;420083;430590;435625;70373.64813175901;73957;76154.23845761472;77205.22794772092;83484;1018.3126389686931;1019.9439030853523;1024.5799222318813;1042.4683411460057;1043.8121138195047;15646.764688374273;15761.211939403212;15853.286602102702;15916.920415397848;15950.122743249232;35148.82425587856;35385;35818.82090589531;36124.638753612126;36288.27423451569;47036.52963470458;51016;51984.22023669572;52048.73975630249;52659.73670131625;8477.067522572635;8556.401051926554;8570.357223208159;8638.956805215934;8701.912980870364;9946.303758736818;13090.345482726016;13359.332033398485;13376.130551514121;13396.866031339561;10849.945750271198;10984.121270298518;11039;11134.33194008362;11707.414629268673;7881.842363152819;10698.946505267735;11076.723081922693;11449.427528623703;11668.533258669559;10994.890051099706;11323.547058117912;11456.312621242752;11721.589744358907;12012.459439325427;8556.058833528432;8561.48631082137;8565.48607083577;8685.522296273513;8733.781655458664;9202.263818894338;11368.658940231806;11598.71003224926;11611.303321800719;11672.70818229551 03:37:57 INFO - PROCESS | 1946 | |3;mootools.html;1553.6115971007248;1576.818665853427;1810.8551315894729;1854.0173707934782;1904.857135714821;7726.227377262285;8307.626156822942;8501.829963400736;8673;8712.73861784146;8389.538575378352;8472.788180295496;8475.237228649421;8579.613917373717;8585.656573737044;2419.213755529451;2452.9877350613224;2462.4336402627405;2467.4078221226955;2468.0991438125043;2386.546556154325;2417.226487523993;2444.5966415541416;2449.8162637802147;2463.2117722328862;2447.0945750072497;2465.716442609105;2487.3905893056135;2502.2618327593314;2502.862342571158;2412.384841865322;2456.4104614892476;2456.8157388195955;2504.724480307183;2516.5973444248834;2460.5078984203233;2462.581361168606;2476.73994230605;2492.314613481289;2513.8491690498445;8606.440581362254;8618.913810861874;8664.8700269496;8681.826363472695;8684.60919258635;5299.894002119974;5347.1177255752755;5412.891742165135;5415.458454154553;5417.052015897202;3315.287213249163;3326.501024846268;3376.4091284025444;3384.8984530464127;3426.9143271418166;1038.6987773545663;1050.5430137890041;1052.5631862776938;1055.6780182044474;1059.3008614314515;12091.395430228542;12251.877481225163;12259.448324825404;12275.877241227652;12332.260064396076;4608.216603177468;4734.28985652148;4739.786709598076;4758.310045043519;4787.114383839001;10296.22778291631;10363.06732394088;10368.326058806153;10371.325863818827;10397.428141452141;5255.605829562798;5342.9732851336275;5369.24830523727;5400.027994960945;5412.134058550613;4839.346688197048;4854.17479028566;4987.975060124676;5006.148954677714;5026.949730502648;3812.6759225466144;3871.728978971445;3884.8834534964;3894.883153505399;3960.089179488734;1207.8007128823822;1218.4456072486996;1219.603628820637;1233.802591585342;1234.9814752778716;1337.8729020743015;1342.328835582209;1365.1945352242224;1406.9226192559508;1416.0583212163797;7899.170587088388;8095.02859656845;8096.271335579826;8103.756887293391;8120.309773669186;511.4399732293133;520.0612893726859;520.7422325948604;523.4869827569004;527.8416475057544;5910.320313163955;5944.881102377928;5953.821385358447;5970.552208584373;5986.551008674367;9898.703038908845;10155.136813370798;10187.847182292271;10196.949015255024;10238.129758970423;9977.201823854219;10083.899161008296;10104.797904041878;10209.642662506776;10238.641647542301;8100.270975612223;8196.30331421824;8228.30059444942;8229.753107406787;8301.418900677016;7830.80422989407;7834.843303134019;7890.171531989288;7955.164707705608;7968.601569921365;9261;9350.485723285285;9443.338966272295;9452.353341064512;9465;9433.103855133751;9620.71137865865;9655.565499552678;9703.369280996712;9793.902060979584;6921.377076063179;7311.341979221896;7404.851902962018;7525.774226773206;7584.393248540214;8144.918550814416;8172.101068882299;8229.300509456763;8236.958815205886;8287.254147126787;6892.345227203407;7265.12818461788;7288.526245794006;7360.1903790584065;7406.111266648037;7246.202917679157;7272.854542909006;7274.781756547312;7276;7292.890606641011;7662.080550333995;7723.227677232232;7759.146493885781;7768.689252429839;7808.141104478616;6843.897341539781;6950.131233595801;6971.65141742921;7004.509684322048;7020.087388639444;7101.928980710127;7102;7105.857882842418;7106.502544821813;7107.857842843011 03:37:57 INFO - PROCESS | 1946 | |4;prototype.html;349.1724612667977;351.95072689823445;353.7329316366143;359.01987573923196;368.34250862210945;6451.838704032401;6498.025296205572;6509.934900650992;6518.120053792736;6561.114249576306;6360.968195159017;6432.678366081689;6439.935600643992;6492.642904640243;6501.707423165957;4783.760811959405;4882.365292511969;4895.632827537949;4928.876778080558;4932.309476673268;4916.090523253191;4930.506949305077;4938.456769755324;4946.406431228258;4947.50524947506;4887.755612219393;4895.730734809584;4898.118338699032;4901.754912254373;4908.361912951329;4887.877803054952;4888.413390393158;4895.192293271606;4896.412430508326;4896.412430508326;4290.828366865321;4300.182965236595;4300.74195548265;4309.84915527955;4326.783660816978;5939.435753603444;6103.725332360054;6125.601835880698;6125.693715314261;6139.2632884053755;5693.686847223401;5741.712914354307;5750.856228594277;5753;5755.84883023397;6852.862942741117;6859.039734437183;6868.896966545506;6875.449964002868;6898.965505172442;4724.7401392923375;4727.409073865767;4733.810647574127;4739.454962679301;4774.212254977924;7063.752768653072;7144.607046612434;7144.785656430316;7146.785596432115;7165.6775445105095;4704.341392205094;4782.976085119552;4797.472278049412;4858.295547145644;4871.318015477836;4904.7492889313;4927.408710954708;4932.852014439501;4944.53026962438;4958.776855041532;5674.858128546737;5680.147977803363;5681.971590142023;5692.971535142297;5719.056355701263;6819.079424277659;6876.553024053421;6878.621675807779;6878.65606719662;6879.5184337096925;1707.6243226490153;1743.2852530462703;1743.686136495443;1743.7907451105948;1746.3451205797826;1093.8359246113146;1100.7908497385472;1137.436968700482;1138.698244965085;1145.9885401146048;6524.641144737085;6572.507061970276;6593.505487088488;6605.141331626858;6613.239477460057;7013.509054366145;7058.2941705830035;7071.61106139157;7095.574265544084;7098.574085554883;6453.45145662624;6538.215414150332;6543.083968244449;6619.933800661932;6626.370494802986;3843.461915331856;3853.9229215415535;3864;3868.2650296443585;3885.592012838668;7384.667689953965;7395.778126656209;7444.925550744423;7453.627318634047;7464.514806537558;7357.117145942521;7384.372328352043;7402.222766609536;7403.18564957865;7440.7767766966;7190.352868241884;7414;7457.925420745832;7463.70145194197;7464.589447580435;7143.1428228612895;7173.641317934187;7175.784726458214;7180.856382872209;7207.495475316888;7033.120859892513;7050.365467107985;7060.435165186876;7068.787936361918;7075.5047146699235;7289.963550182215;7426.8143296415865;7436.888446673413;7440.181580026301;7443.106827180556;4791.401074865642;4834.685745426536;4839.661223714306;4841.830535931366;4848.030393921159;7137.500374973702;7160;7172.0676312079095;7178.138623365229;7181.138263408425;6923.792286231421;6928.341807528277;6937.549059311129;6939.167299924042;6952.965235173791;6722.327767223239;6892.586444813327;6912.170539535288;6926.826829329307;6933.306669333027;6716.597004179765;6743.224529179207;6784.966075169593;6815.69329380189;6821.693023814039;6938.618375989167;6972.825679358057;6977.895331570132;6979.197392299748;6980.930190698231;6774.491913106635;6798.694058767268;6803.149606299213;6803.42170915458;6817.284185160685 03:37:57 INFO - PROCESS | 1946 | |5;yui.html;830.1283652165226;833.0960907415454;883.6818745251708;886.4592598514909;887.2236792806294;13609.38757755901;13654;13677.452901883926;13702.109362891406;14251.50119745809;13381.464741410357;13391.866081339183;13525.797113043312;13530.25583592902;13565.864341356584;720.5208536323339;831.4346244553701;832.4963397144732;839.8278352937633;844.2233145506149;844.2064459408167;844.6410275632832;847.7414388611471;848.2196379331;849.3502470609989;880.6169316347409;880.9867851982225;885.4642941020686;886.5257087458211;896.5338024227431;881.0660699658382;883.9425437346616;886.0120965123905;886.835935351962;896.6771962093641;646.4698946863574;656.5535435903583;656.7176114270861;660.5013215022675;663.1279866974912;14012.579622611338;14046.43814247429;14054.43782248719;14097.85902140986;14119;13570;13815;13846.723065538632;13934.30328483582;14003.64990875226;11059.170562207786;11212.159088068427;11213.66359009231;11218.326900386002;11285.605003824827;3846.8845934622004;3880.4373365862075;3899.395593682984;3908.609139086097;3930.862419815321;50691.23963140556;51414;52012;52107;52143.21785173225;11171.16216283782;11189.328640281608;11198.16013798952;11251.774964500828;11312.434378281054;20218.393448196577;20324.69512957307;20360;20387.8980605099;20400.18399264013;7892.289693927574;7892.802679932933;7953.284204421514;8011.278984891271;8223.835523289501;4550.362949187116;4550.977245113753;4584.770761461914;4607.0785842831565;4672;3477.200243943907;3497.965020349815;3510.613832478425;3528.8412021459094;3544.91137721559;618.0975775367923;639.2073828452778;639.3734140542294;641.2561428742636;643.3566433566433;620.1534904854841;694.3160986428364;701.8771714949863;703.2756261051126;711.7971378157304;9653.324267301221;9746.171575416027;9871.555779989918;9903.950480247697;9949.403035817873;684.3737979748574;693.1751216052982;736.2453485177736;743;768.6925229908081;4138.337865941435;4220.936685949713;4410.272305069628;4418.911621767546;4509.616682582017;55002.17496737552;59291.11063334053;60673.39326606766;61053;61442.69278653578;52074;52233;52806.471935280926;53398.46601534013;55067.72466137644;47980;48068.03863922702;48416.27375589299;48487.757561212675;49257;9287.257019438564;9480.383775054599;9683.709488715349;9733.415995040321;9871.753206169617;34818.82590587132;35242.64757352394;36114.27771444504;36571.63428365682;36887.26225475529;42314.15371692611;42317.15365692607;45234;45842;47358;11740.119491038036;12017.81973270419;12080.39598020078;12189.75620487603;12338.444769985193;12522.436490358137;12637;12834.358282085672;13130.868691312964;13269.60191194227;11840.822387664364;12052.397380130784;12275.508979641072;12323;12326.260424374566;12154;12495.500179992698;12579.748405031665;12613.243205407338;12727.745445091232;11361;11458;11643.825342619699;12252;12499.437570303711;9997.75005624836;10578.153747700011;10673.57305707763;10989.505472253608;11290.43547822622;10263.281570290306;10446.791064178826;10742.140628749838;10888.51001704941;11056.447177641247 03:37:57 INFO - PROCESS | 1946 | __end_tp_report 03:37:57 INFO - PROCESS | 1946 | __start_cc_report 03:37:57 INFO - PROCESS | 1946 | _x_x_mozilla_cycle_collect,328 03:37:57 INFO - PROCESS | 1946 | __end_cc_report 03:37:57 INFO - PROCESS | 1946 | __startTimestamp1460716677124__endTimestamp 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | ------- Summary: start ------- 03:37:57 INFO - PROCESS | 1946 | Number of tests: 6 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#0] dojo.html Cycles:165 Average:5629.43 Median:5905.47 stddev:640.55 (10.8%) stddev-sans-first:616.64 03:37:57 INFO - PROCESS | 1946 | Values: 3332.0 3402.3 3407.8 3444.3 3446.0 5492.6 5523.8 5535.4 5547.0 5565.5 5524.1 5555.0 5556.0 5563.7 5567.7 5085.1 5087.8 5089.7 5119.1 5163.9 5058.9 5129.1 5166.9 5167.3 5174.6 5105.8 5167.5 5231.6 5257.4 5323.6 5154.5 5191.9 5193.2 5208.9 5215.1 4996.2 5040.4 5045.4 5102.4 5183.2 5421.4 5448.8 5467.8 5481.7 5482.6 5953.9 6076.2 6095.8 6124.9 6133.9 6034.4 6039.4 6048.2 6061.5 6082.8 5683.3 5685.4 5690.9 5695.0 5695.5 6060.4 6090.0 6128.8 6174.3 6195.4 5905.5 5908.4 5911.1 5921.6 5933.0 5996.4 5997.9 6004.3 6007.1 6011.6 5860.6 5994.3 6090.8 6114.7 6121.3 6082.1 6098.5 6102.8 6104.4 6105.0 4576.7 4613.7 4630.2 4631.0 4668.9 4089.8 4121.2 4149.6 4169.6 4214.3 5628.2 5688.4 5716.1 5726.7 5841.6 6166.1 6175.2 6180.0 6181.3 6187.0 5700.1 5702.3 5723.7 5725.6 5774.2 5019.5 5024.8 5035.5 5052.0 5067.4 6284.5 6308.3 6324.5 6327.8 6337.6 6029.5 6110.5 6118.2 6121.4 6160.8 6251.3 6311.4 6329.7 6337.4 6353.6 6000.5 6040.2 6048.0 6086.0 6090.5 6016.0 6129.3 6139.0 6148.8 6189.8 5972.6 5976.8 5991.9 6005.1 6037.4 6020.9 6024.7 6028.8 6032.3 6033.6 5744.2 5811.2 5888.6 5888.9 5928.2 5933.3 5938.2 5989.3 5997.5 6012.1 5729.3 5893.6 5914.2 5919.3 5921.7 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#1] ext.html Cycles:180 Average:54121.24 Median:40463.49 stddev:104709.12 (258.8%) stddev-sans-first:104925.48 03:37:57 INFO - PROCESS | 1946 | Values: 507.1 550.0 550.7 568.7 589.4 30963.0 38989.2 39818.2 40336.0 40447.0 42350.9 43553.3 43818.3 43911.0 43963.3 9128.0 9321.1 9334.1 9335.2 9360.7 8057.8 9424.5 9435.1 9466.7 9469.0 9290.2 9433.8 9484.1 9492.5 9495.6 9286.3 9354.2 9427.0 9440.1 9453.1 9206.4 9328.5 9333.4 9338.9 9342.5 43388.6 43633.8 43766.0 43772.1 44013.8 3500.4 3567.8 3672.0 3683.6 3802.7 31900.8 32157.4 32726.0 32774.0 33194.8 4051.9 4060.6 4072.8 4083.6 4100.7 287892.0 288160.0 288552.0 288870.0 289067.0 45278.3 59656.0 59847.4 60276.7 60326.0 45073.8 45394.3 45403.1 45511.3 45539.8 14797.6 14958.6 14967.8 15019.0 15056.2 11525.7 11574.4 11626.1 11659.2 11672.2 15191.9 15219.2 15758.5 15783.2 15809.4 5696.5 5959.1 6054.3 6092.9 6147.2 1096.9 1107.4 1133.4 1146.5 1186.7 29643.1 29724.4 30036.3 30709.4 30747.2 1133.1 1158.4 1204.3 1223.8 1266.0 15316.5 15370.2 15512.9 15823.3 15971.8 333760.0 567444.0 567867.0 568534.0 576417.0 54362.2 54871.0 55415.0 55541.7 55631.0 1465.8 1478.8 1505.5 1511.0 1514.4 28430.0 30882.4 31100.5 31276.5 31571.4 50280.2 51518.2 51654.0 51709.5 51899.5 315978.0 316597.0 318782.0 319953.0 320420.0 34098.0 34600.3 47703.8 48470.5 48773.8 42438.6 43685.6 43785.3 43886.3 44778.6 36599.6 37131.8 39734.4 40126.5 40793.6 39294.0 40480.0 40694.6 40801.2 40948.8 39208.0 39649.8 40163.2 40505.4 40548.6 34345.5 34910.7 35226.5 35480.5 35815.8 27258.5 27407.7 27606.9 27683.9 28010.6 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#2] jquery.html Cycles:180 Average:25661.06 Median:35601.91 stddev:68792.78 (193.2%) stddev-sans-first:68959.59 03:37:57 INFO - PROCESS | 1946 | Values: 384.4 385.9 390.5 390.6 397.1 17139.1 19248.2 19611.0 19658.3 19748.7 18237.4 18381.2 18518.4 18532.0 18635.6 5466.3 5653.3 5679.3 5681.9 5688.0 4286.5 6019.7 6243.6 6275.6 6297.3 6006.5 6248.6 6252.0 6256.1 6265.8 6133.6 6187.8 6192.4 6203.5 6217.7 5444.3 5451.2 5466.0 5488.8 5521.6 21129.6 21635.7 21769.3 21781.1 22133.1 2349.7 2430.3 2511.0 2520.4 2532.2 13612.5 14095.5 14099.1 14102.2 14105.5 1920.3 1924.0 1951.6 1986.9 1996.5 65228.7 67218.7 67305.7 67443.0 67546.0 9878.4 10024.6 10146.2 10171.5 10332.9 13972.9 14058.9 14145.2 14155.2 14232.4 7752.7 7828.0 7876.3 7910.9 7938.0 7624.2 7709.2 7710.2 7728.0 7728.3 5852.2 5911.1 5968.0 6036.1 6047.1 1839.0 1944.9 1952.7 1984.0 1989.6 933.7 937.7 946.6 1068.8 1107.2 16027.4 16133.4 17196.0 17474.2 17919.6 974.8 984.3 993.8 1067.8 1081.3 9996.2 10160.8 10185.2 10348.6 10382.2 401412.0 405668.0 420083.0 430590.0 435625.0 70373.6 73957.0 76154.2 77205.2 83484.0 1018.3 1019.9 1024.6 1042.5 1043.8 15646.8 15761.2 15853.3 15916.9 15950.1 35148.8 35385.0 35818.8 36124.6 36288.3 47036.5 51016.0 51984.2 52048.7 52659.7 8477.1 8556.4 8570.4 8639.0 8701.9 9946.3 13090.3 13359.3 13376.1 13396.9 10849.9 10984.1 11039.0 11134.3 11707.4 7881.8 10698.9 11076.7 11449.4 11668.5 10994.9 11323.5 11456.3 11721.6 12012.5 8556.1 8561.5 8565.5 8685.5 8733.8 9202.3 11368.7 11598.7 11611.3 11672.7 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#3] mootools.html Cycles:180 Average:5981.14 Median:5345.05 stddev:3163.72 (59.2%) stddev-sans-first:3155.09 03:37:57 INFO - PROCESS | 1946 | Values: 1553.6 1576.8 1810.9 1854.0 1904.9 7726.2 8307.6 8501.8 8673.0 8712.7 8389.5 8472.8 8475.2 8579.6 8585.7 2419.2 2453.0 2462.4 2467.4 2468.1 2386.5 2417.2 2444.6 2449.8 2463.2 2447.1 2465.7 2487.4 2502.3 2502.9 2412.4 2456.4 2456.8 2504.7 2516.6 2460.5 2462.6 2476.7 2492.3 2513.8 8606.4 8618.9 8664.9 8681.8 8684.6 5299.9 5347.1 5412.9 5415.5 5417.1 3315.3 3326.5 3376.4 3384.9 3426.9 1038.7 1050.5 1052.6 1055.7 1059.3 12091.4 12251.9 12259.4 12275.9 12332.3 4608.2 4734.3 4739.8 4758.3 4787.1 10296.2 10363.1 10368.3 10371.3 10397.4 5255.6 5343.0 5369.2 5400.0 5412.1 4839.3 4854.2 4988.0 5006.1 5026.9 3812.7 3871.7 3884.9 3894.9 3960.1 1207.8 1218.4 1219.6 1233.8 1235.0 1337.9 1342.3 1365.2 1406.9 1416.1 7899.2 8095.0 8096.3 8103.8 8120.3 511.4 520.1 520.7 523.5 527.8 5910.3 5944.9 5953.8 5970.6 5986.6 9898.7 10155.1 10187.8 10196.9 10238.1 9977.2 10083.9 10104.8 10209.6 10238.6 8100.3 8196.3 8228.3 8229.8 8301.4 7830.8 7834.8 7890.2 7955.2 7968.6 9261.0 9350.5 9443.3 9452.4 9465.0 9433.1 9620.7 9655.6 9703.4 9793.9 6921.4 7311.3 7404.9 7525.8 7584.4 8144.9 8172.1 8229.3 8237.0 8287.3 6892.3 7265.1 7288.5 7360.2 7406.1 7246.2 7272.9 7274.8 7276.0 7292.9 7662.1 7723.2 7759.1 7768.7 7808.1 6843.9 6950.1 6971.7 7004.5 7020.1 7101.9 7102.0 7105.9 7106.5 7107.9 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#4] prototype.html Cycles:180 Average:5756.69 Median:6531.43 stddev:1755.55 (26.9%) stddev-sans-first:1712.91 03:37:57 INFO - PROCESS | 1946 | Values: 349.2 352.0 353.7 359.0 368.3 6451.8 6498.0 6509.9 6518.1 6561.1 6361.0 6432.7 6439.9 6492.6 6501.7 4783.8 4882.4 4895.6 4928.9 4932.3 4916.1 4930.5 4938.5 4946.4 4947.5 4887.8 4895.7 4898.1 4901.8 4908.4 4887.9 4888.4 4895.2 4896.4 4896.4 4290.8 4300.2 4300.7 4309.8 4326.8 5939.4 6103.7 6125.6 6125.7 6139.3 5693.7 5741.7 5750.9 5753.0 5755.8 6852.9 6859.0 6868.9 6875.4 6899.0 4724.7 4727.4 4733.8 4739.5 4774.2 7063.8 7144.6 7144.8 7146.8 7165.7 4704.3 4783.0 4797.5 4858.3 4871.3 4904.7 4927.4 4932.9 4944.5 4958.8 5674.9 5680.1 5682.0 5693.0 5719.1 6819.1 6876.6 6878.6 6878.7 6879.5 1707.6 1743.3 1743.7 1743.8 1746.3 1093.8 1100.8 1137.4 1138.7 1146.0 6524.6 6572.5 6593.5 6605.1 6613.2 7013.5 7058.3 7071.6 7095.6 7098.6 6453.5 6538.2 6543.1 6619.9 6626.4 3843.5 3853.9 3864.0 3868.3 3885.6 7384.7 7395.8 7444.9 7453.6 7464.5 7357.1 7384.4 7402.2 7403.2 7440.8 7190.4 7414.0 7457.9 7463.7 7464.6 7143.1 7173.6 7175.8 7180.9 7207.5 7033.1 7050.4 7060.4 7068.8 7075.5 7290.0 7426.8 7436.9 7440.2 7443.1 4791.4 4834.7 4839.7 4841.8 4848.0 7137.5 7160.0 7172.1 7178.1 7181.1 6923.8 6928.3 6937.5 6939.2 6953.0 6722.3 6892.6 6912.2 6926.8 6933.3 6716.6 6743.2 6785.0 6815.7 6821.7 6938.6 6972.8 6977.9 6979.2 6980.9 6774.5 6798.7 6803.1 6803.4 6817.3 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - PROCESS | 1946 | [#5] yui.html Cycles:180 Average:14578.08 Median:24871.81 stddev:16508.97 (66.4%) stddev-sans-first:16523.00 03:37:57 INFO - PROCESS | 1946 | Values: 830.1 833.1 883.7 886.5 887.2 13609.4 13654.0 13677.5 13702.1 14251.5 13381.5 13391.9 13525.8 13530.3 13565.9 720.5 831.4 832.5 839.8 844.2 844.2 844.6 847.7 848.2 849.4 880.6 881.0 885.5 886.5 896.5 881.1 883.9 886.0 886.8 896.7 646.5 656.6 656.7 660.5 663.1 14012.6 14046.4 14054.4 14097.9 14119.0 13570.0 13815.0 13846.7 13934.3 14003.6 11059.2 11212.2 11213.7 11218.3 11285.6 3846.9 3880.4 3899.4 3908.6 3930.9 50691.2 51414.0 52012.0 52107.0 52143.2 11171.2 11189.3 11198.2 11251.8 11312.4 20218.4 20324.7 20360.0 20387.9 20400.2 7892.3 7892.8 7953.3 8011.3 8223.8 4550.4 4551.0 4584.8 4607.1 4672.0 3477.2 3498.0 3510.6 3528.8 3544.9 618.1 639.2 639.4 641.3 643.4 620.2 694.3 701.9 703.3 711.8 9653.3 9746.2 9871.6 9904.0 9949.4 684.4 693.2 736.2 743.0 768.7 4138.3 4220.9 4410.3 4418.9 4509.6 55002.2 59291.1 60673.4 61053.0 61442.7 52074.0 52233.0 52806.5 53398.5 55067.7 47980.0 48068.0 48416.3 48487.8 49257.0 9287.3 9480.4 9683.7 9733.4 9871.8 34818.8 35242.6 36114.3 36571.6 36887.3 42314.2 42317.2 45234.0 45842.0 47358.0 11740.1 12017.8 12080.4 12189.8 12338.4 12522.4 12637.0 12834.4 13130.9 13269.6 11840.8 12052.4 12275.5 12323.0 12326.3 12154.0 12495.5 12579.7 12613.2 12727.7 11361.0 11458.0 11643.8 12252.0 12499.4 9997.8 10578.2 10673.6 10989.5 11290.4 10263.3 10446.8 10742.1 10888.5 11056.4 03:37:57 INFO - PROCESS | 1946 | -------- Summary: end -------- 03:37:57 INFO - PROCESS | 1946 | 03:37:57 INFO - TEST-INFO | 1946: exit 0 03:37:57 INFO - TEST-OK | dromaeo_css | took 1110005ms 03:37:57 INFO - TEST-START | kraken 03:37:57 INFO - operating with platform_type : linux_ 03:37:57 INFO - Initialising browser for kraken test... 03:37:57 INFO - TEST-INFO | started process 2195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFpFrO/profile http://localhost:60609/getInfo.html) 03:38:01 INFO - PROCESS | 2195 | 03:38:01 INFO - PROCESS | 2195 | (process:2272): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:02 INFO - PROCESS | 2195 | __metrics Screen width/height:1600/1200 03:38:02 INFO - PROCESS | 2195 | colorDepth:24 03:38:02 INFO - PROCESS | 2195 | Browser inner width/height: 1024/697 03:38:02 INFO - PROCESS | 2195 | __metrics 03:38:03 ERROR - PROCESS | 2195 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:38:03 INFO - TEST-INFO | 2195: exit 0 03:38:03 INFO - Browser initialized. 03:38:03 INFO - Running cycle 1/1 for kraken test... 03:38:03 INFO - TEST-INFO | started process 2323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplFpFrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:05 INFO - PROCESS | 2323 | 03:38:05 INFO - PROCESS | 2323 | (process:2470): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:15 INFO - PROCESS | 2323 | RSS: Main: 151375872 03:38:15 INFO - PROCESS | 2323 | 03:38:18 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:18 INFO - PROCESS | 2323 | RSS: Main: 156033024 03:38:18 INFO - PROCESS | 2323 | 03:38:21 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-dft) 03:38:22 INFO - PROCESS | 2323 | RSS: Main: 156286976 03:38:22 INFO - PROCESS | 2323 | 03:38:25 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-fft) 03:38:25 INFO - PROCESS | 2323 | RSS: Main: 156606464 03:38:25 INFO - PROCESS | 2323 | 03:38:27 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-oscillator) 03:38:28 INFO - PROCESS | 2323 | RSS: Main: 156553216 03:38:28 INFO - PROCESS | 2323 | 03:38:30 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:31 INFO - PROCESS | 2323 | RSS: Main: 156622848 03:38:31 INFO - PROCESS | 2323 | 03:38:34 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:34 INFO - PROCESS | 2323 | RSS: Main: 156418048 03:38:34 INFO - PROCESS | 2323 | 03:38:38 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:38 INFO - PROCESS | 2323 | RSS: Main: 156471296 03:38:38 INFO - PROCESS | 2323 | 03:38:41 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60609/tests/kraken/driver.html?testName=json-parse-financial) 03:38:42 INFO - PROCESS | 2323 | RSS: Main: 156934144 03:38:42 INFO - PROCESS | 2323 | 03:38:43 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:44 INFO - PROCESS | 2323 | RSS: Main: 156626944 03:38:44 INFO - PROCESS | 2323 | 03:38:46 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:46 INFO - PROCESS | 2323 | RSS: Main: 156704768 03:38:46 INFO - PROCESS | 2323 | 03:38:48 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:49 INFO - PROCESS | 2323 | RSS: Main: 156835840 03:38:49 INFO - PROCESS | 2323 | 03:38:51 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:52 INFO - PROCESS | 2323 | RSS: Main: 157810688 03:38:52 INFO - PROCESS | 2323 | 03:38:54 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:55 INFO - PROCESS | 2323 | RSS: Main: 157036544 03:38:55 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60609/tests/kraken/driver.html?testName=ai-astar) 03:38:57 INFO - PROCESS | 2323 | RSS: Main: 158871552 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | __start_tp_report 03:38:57 INFO - PROCESS | 2323 | _x_x_mozilla_page_load 03:38:57 INFO - PROCESS | 2323 | _x_x_mozilla_page_load_details 03:38:57 INFO - PROCESS | 2323 | |i|pagename|runs| 03:38:57 INFO - PROCESS | 2323 | |0;ai-astar;110;106;112;109;110;123;109;110;110;109 03:38:57 INFO - PROCESS | 2323 | |1;audio-beat-detection;154;136;151;167;127;162;164;128;166;128 03:38:57 INFO - PROCESS | 2323 | |2;audio-dft;162;163;163;161;161;162;162;162;164;163 03:38:57 INFO - PROCESS | 2323 | |3;audio-fft;76;76;77;160;77;76;72;79;165;77 03:38:57 INFO - PROCESS | 2323 | |4;audio-oscillator;92;93;145;94;94;95;145;94;92;146 03:38:57 INFO - PROCESS | 2323 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:38:57 INFO - PROCESS | 2323 | |6;imaging-darkroom;147;147;147;146;148;147;146;147;147;147 03:38:57 INFO - PROCESS | 2323 | |7;imaging-desaturate;96;96;96;97;98;96;96;96;97;95 03:38:57 INFO - PROCESS | 2323 | |8;json-parse-financial;54;57;58;57;56;57;60;62;55;57 03:38:57 INFO - PROCESS | 2323 | |9;json-stringify-tinderbox;64;64;64;64;63;64;64;65;64;64 03:38:57 INFO - PROCESS | 2323 | |10;stanford-crypto-aes;78;77;80;87;79;78;80;79;79;80 03:38:57 INFO - PROCESS | 2323 | |11;stanford-crypto-ccm;111;116;111;116;114;114;112;128;113;112 03:38:57 INFO - PROCESS | 2323 | |12;stanford-crypto-pbkdf2;132;143;155;136;143;140;142;152;135;142 03:38:57 INFO - PROCESS | 2323 | |13;stanford-crypto-sha256-iterative;67;67;68;66;70;67;70;65;67;67 03:38:57 INFO - PROCESS | 2323 | __end_tp_report 03:38:57 INFO - PROCESS | 2323 | __start_cc_report 03:38:57 INFO - PROCESS | 2323 | _x_x_mozilla_cycle_collect,842 03:38:57 INFO - PROCESS | 2323 | __end_cc_report 03:38:57 INFO - PROCESS | 2323 | __startTimestamp1460716737356__endTimestamp 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | ------- Summary: start ------- 03:38:57 INFO - PROCESS | 2323 | Number of tests: 14 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:4.54 (4.1%) stddev-sans-first:4.81 03:38:57 INFO - PROCESS | 2323 | Values: 110.0 106.0 112.0 109.0 110.0 123.0 109.0 110.0 110.0 109.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:158.00 stddev:16.89 (10.7%) stddev-sans-first:17.78 03:38:57 INFO - PROCESS | 2323 | Values: 154.0 136.0 151.0 167.0 127.0 162.0 164.0 128.0 166.0 128.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:38:57 INFO - PROCESS | 2323 | Values: 162.0 163.0 163.0 161.0 161.0 162.0 162.0 162.0 164.0 163.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:36.43 (47.6%) stddev-sans-first:38.08 03:38:57 INFO - PROCESS | 2323 | Values: 76.0 76.0 77.0 160.0 77.0 76.0 72.0 79.0 165.0 77.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.50 stddev:25.09 (26.8%) stddev-sans-first:25.85 03:38:57 INFO - PROCESS | 2323 | Values: 92.0 93.0 145.0 94.0 94.0 95.0 145.0 94.0 92.0 146.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:38:57 INFO - PROCESS | 2323 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:38:57 INFO - PROCESS | 2323 | Values: 147.0 147.0 147.0 146.0 148.0 147.0 146.0 147.0 147.0 147.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:38:57 INFO - PROCESS | 2323 | Values: 96.0 96.0 96.0 97.0 98.0 96.0 96.0 96.0 97.0 95.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.31 (4.1%) stddev-sans-first:2.12 03:38:57 INFO - PROCESS | 2323 | Values: 54.0 57.0 58.0 57.0 56.0 57.0 60.0 62.0 55.0 57.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 03:38:57 INFO - PROCESS | 2323 | Values: 64.0 64.0 64.0 64.0 63.0 64.0 64.0 65.0 64.0 64.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.75 (3.5%) stddev-sans-first:2.85 03:38:57 INFO - PROCESS | 2323 | Values: 78.0 77.0 80.0 87.0 79.0 78.0 80.0 79.0 79.0 80.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:114.00 stddev:5.01 (4.4%) stddev-sans-first:5.13 03:38:57 INFO - PROCESS | 2323 | Values: 111.0 116.0 111.0 116.0 114.0 114.0 112.0 128.0 113.0 112.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:142.50 stddev:7.15 (5.0%) stddev-sans-first:6.60 03:38:57 INFO - PROCESS | 2323 | Values: 132.0 143.0 155.0 136.0 143.0 140.0 142.0 152.0 135.0 142.0 03:38:57 INFO - PROCESS | 2323 | 03:38:57 INFO - PROCESS | 2323 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 03:38:57 INFO - PROCESS | 2323 | Values: 67.0 67.0 68.0 66.0 70.0 67.0 70.0 65.0 67.0 67.0 03:38:57 INFO - PROCESS | 2323 | -------- Summary: end -------- 03:38:57 INFO - PROCESS | 2323 | 03:38:58 INFO - TEST-INFO | 2323: exit 0 03:38:58 INFO - TEST-OK | kraken | took 60479ms 03:38:58 INFO - SUITE-END | took 1170s 03:38:58 INFO - Completed test suite (00:19:30) 03:38:58 INFO - javascript benchmark 03:38:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3331.9833400833, 3402.2515046689728, 3407.7955322680655, 3444.328355970587, 3446.0351101691517, 5492.615516913817, 5523.806666766664, 5535.446455354472, 5547.0, 5565.471280228377, 5524.06090964536, 5554.9722251388785, 5556.027695153352, 5563.749631266593, 5567.721613919308, 5085.135526960407, 5087.79648814047, 5089.669171503859, 5119.0529751996, 5163.870903227412, 5058.898822023557, 5129.051125541768, 5166.870828229286, 5167.3282473278605, 5174.611904107188, 5105.821296254632, 5167.457416971201, 5231.581473482112, 5257.36911570612, 5323.627346085776, 5154.484551544853, 5191.922121168185, 5193.221016847466, 5208.947910520922, 5215.087359712035, 4996.150654388763, 5040.445550989388, 5045.445001049881, 5102.413222479426, 5183.196604526304, 5421.430749771257, 5448.83653490396, 5467.808626698086, 5481.725913704338, 5482.588805839578, 5953.8809223815715, 6076.240469941257, 6095.786647467362, 6124.908126378108, 6133.895898738226, 6034.366391528914, 6039.365866583989, 6048.213732214828, 6061.515078793686, 6082.847928801815, 5683.3464151622675, 5685.431456854323, 5690.886182276414, 5695.03184458643, 5695.45893140151, 6060.363661815446, 6089.969550152221, 6128.808691620048, 6174.25908890936, 6195.380461953769, 5905.4685078343155, 5908.438698323653, 5911.142884281841, 5921.585489015728, 5932.970335148297, 5996.370381110008, 5997.940020599825, 6004.309504407049, 6007.068904319837, 6011.579189456696, 5860.648361098348, 5994.340622531518, 6090.786822461193, 6114.724837382329, 6121.300552271563, 6082.057281121433, 6098.54260930432, 6102.7558897644485, 6104.359042300494, 6105.023196288573, 4576.656750743641, 4613.746243956614, 4630.21286381316, 4631.0, 4668.906621867543, 4089.754614723126, 4121.175764846983, 4149.647279981235, 4169.56219596944, 4214.262504061777, 5628.240187574707, 5688.374278829326, 5716.142578613241, 5726.656400615976, 5841.649501029951, 6166.105914642441, 6175.228096487939, 6179.969100154561, 6181.289151747516, 6187.0, 5700.116481945305, 5702.287214098238, 5723.6851973141875, 5725.627834190765, 5774.191613174159, 5019.47295533971, 5024.824131155392, 5035.496450354935, 5051.974740126276, 5067.391912970394, 6284.465820405226, 6308.337624549448, 6324.494040476751, 6327.841803954938, 6337.588056776295, 6029.487493563096, 6110.511159107261, 6118.204633397808, 6121.418465245794, 6160.845978850564, 6251.312355640966, 6311.431971122621, 6329.651869147241, 6337.366263373626, 6353.5870168438905, 6000.51995840323, 6040.244969378828, 6048.032314829607, 6085.9695701521205, 6090.482309003784, 6016.0, 6129.295131059986, 6139.017757158833, 6148.78479253224, 6189.81430557084, 5972.641641501524, 5976.7908123215475, 5991.850203744942, 6005.099235114593, 6037.426444487766, 6020.8795824084145, 6024.66864322449, 6028.849278767891, 6032.33644299118, 6033.607815491979, 5744.167095771007, 5811.186433899342, 5888.646681199141, 5888.911666325094, 5928.170056192051, 5933.258342707161, 5938.198343223609, 5989.3112292085225, 5997.520198384032, 6012.098185272244, 5729.312482502127, 5893.5874488785375, 5914.172015917689, 5919.31927828288, 5921.6743079131065], "unit": "score", "name": "dojo.html", "value": 5587.116666373194}, {"lowerIsBetter": false, "replicates": [507.0669967260243, 549.9990018166935, 550.7383992603511, 568.6872220278847, 589.3605438099662, 30963.0, 38989.22021559567, 39818.2036359273, 40336.0, 40447.0, 42350.94122646935, 43553.34669979953, 43818.342724859154, 43911.0, 43963.34054989178, 9128.041555636679, 9321.114494123047, 9334.06659334068, 9335.206507446841, 9360.719178424624, 8057.758267251992, 9424.481653509054, 9435.103665151799, 9466.66866659667, 9469.0, 9290.210332121744, 9433.81132377352, 9484.099010593982, 9492.477913714743, 9495.620175192984, 9286.349955503118, 9354.158125768714, 9426.95286523563, 9440.05599440054, 9453.101955314269, 9206.355555111146, 9328.48693321867, 9333.439993600407, 9338.906610933871, 9342.532873356373, 43388.56611433877, 43633.781831090644, 43766.0, 43772.12455750899, 44013.779931100136, 3500.422430298998, 3567.7859328440118, 3671.9816400918094, 3683.631636836322, 3802.6957843372466, 31900.840495797605, 32157.356852862813, 32726.0, 32774.0, 33194.83402582996, 4051.8581849635416, 4060.614241647039, 4072.75563466193, 4083.591640835922, 4100.65144462721, 287891.9999999979, 288160.0, 288552.0, 288870.0, 289067.0, 45278.32082518765, 59656.0, 59847.40152598506, 60276.698616507514, 60326.0, 45073.77463112663, 45394.31908521309, 45403.09193816105, 45511.317330240076, 45539.772301138284, 14797.556073317817, 14958.551243462714, 14967.775483367759, 15019.0, 15056.247187640574, 11525.711857203636, 11574.421278936019, 11626.128040397005, 11659.24214926044, 11672.241304315192, 15191.924040379727, 15219.162946037854, 15758.527244182693, 15783.210839457981, 15809.446669366516, 5696.458836410535, 5959.135925290809, 6054.303755068224, 6092.939070609325, 6147.231596050494, 1096.9341839489657, 1107.3687997841314, 1133.4389477208833, 1146.5012719467059, 1186.7329850783506, 29643.110706678835, 29724.40551188964, 30036.34152056111, 30709.385812284076, 30747.23131921675, 1133.1274918312854, 1158.449736375215, 1204.3195594489086, 1223.7762237762238, 1265.9998601105024, 15316.463923762838, 15370.164034355752, 15512.92243538775, 15823.287952042187, 15971.760423593656, 333760.0, 567444.0, 567867.0, 568534.0, 576417.0, 54362.184567231525, 54871.0, 55415.0, 55541.72229138829, 55631.0, 1465.8167729033871, 1478.7560052591202, 1505.533284681752, 1510.9773353399487, 1514.3639671338065, 28430.0, 30882.382352353277, 31100.523774163732, 31276.530852036783, 31571.36857262796, 50280.245796313815, 51518.22722659088, 51654.0, 51709.482905170466, 51899.48100518947, 315978.0, 316597.0, 318782.0, 319953.0, 320420.0, 34098.0, 34600.30799383948, 47703.76148119376, 48470.5152948466, 48773.75613121912, 42438.5756142447, 43685.56314436815, 43785.34321985109, 43886.34170487381, 44778.55221447874, 36599.63400365962, 37131.814340928126, 39734.40398393969, 40126.473697860034, 40793.59206408016, 39294.0, 40479.988000300225, 40694.59305407026, 40801.1839763209, 40948.79525602472, 39208.0, 39649.80175099106, 40163.19673606453, 40505.39241911432, 40548.594514055665, 34345.484817728255, 34910.65089349074, 35226.47160292546, 35480.46779298261, 35815.82092089523, 27258.45483090367, 27407.725922740516, 27606.861965690045, 27683.861580691966, 28010.579841302806], "unit": "score", "name": "ext.html", "value": 19469.575812953823}, {"lowerIsBetter": false, "replicates": [384.4022544942614, 385.85786073223255, 390.5489160020178, 390.5645205595758, 397.05698964958225, 17139.087674409315, 19248.23007079715, 19611.0, 19658.311959081435, 19748.70376944347, 18237.36169234077, 18381.172847221875, 18518.351857684982, 18532.0, 18635.62728745424, 5466.316710411199, 5653.349864765543, 5679.261695979517, 5681.9431805681825, 5688.0, 4286.485621725382, 6019.699015049252, 6243.625382477043, 6275.592086514384, 6297.275813281485, 6006.489448396892, 6248.625082495065, 6252.0, 6256.124142620037, 6265.812025639215, 6133.631982081067, 6187.783427580013, 6192.442680158807, 6203.503719702413, 6217.658028808413, 5444.3194600674915, 5451.209574611659, 5466.0, 5488.780448782044, 5521.613487055908, 21129.577408451743, 21635.67546486804, 21769.346919592437, 21781.128754849786, 22133.114675412966, 2349.7180338359335, 2430.298790846397, 2510.962335564968, 2520.4455019895777, 2532.159113397967, 13612.455501779918, 14095.506657266946, 14099.083559568595, 14102.224377659224, 14105.506307279196, 1920.3470819921154, 1924.0379810094953, 1951.590166065128, 1986.9006549672458, 1996.5208349995896, 65228.67385663041, 67218.66390668064, 67305.66347168233, 67443.0, 67545.98681019837, 9878.357906736182, 10024.649137280161, 10146.188304935587, 10171.491425428847, 10332.896671033344, 13972.930135349257, 14058.929705351407, 14145.151290922578, 14155.221462819438, 14232.359543820552, 7752.7286544971785, 7827.9608601956625, 7876.330511906552, 7910.920890791133, 7937.960310198412, 7624.161342252348, 7709.151993280735, 7710.151883292833, 7727.961360193275, 7728.304452599181, 5852.151438041546, 5911.083782013795, 5968.0, 6036.094585812076, 6047.12316714074, 1838.9908050459662, 1944.8735832171146, 1952.7461430014007, 1983.9900800495905, 1989.6418644643813, 933.6918816790443, 937.7093101138669, 946.6260826973445, 1068.7595291059604, 1107.1585594947899, 16027.439039633557, 16133.435329763402, 17196.0, 17474.213660385314, 17919.552011199565, 974.8099120671543, 984.2814745236018, 993.7863359377624, 1067.813132701774, 1081.2647399768075, 9996.150327222122, 10160.796784064425, 10185.185185185168, 10348.586056557804, 10382.221333399873, 401412.0, 405668.0, 420083.0, 430590.0, 435625.0, 70373.64813175901, 73957.0, 76154.23845761472, 77205.22794772092, 83484.0, 1018.3126389686931, 1019.9439030853523, 1024.5799222318813, 1042.4683411460057, 1043.8121138195047, 15646.764688374273, 15761.211939403212, 15853.286602102702, 15916.920415397848, 15950.122743249232, 35148.82425587856, 35385.0, 35818.82090589531, 36124.638753612126, 36288.27423451569, 47036.52963470458, 51016.0, 51984.22023669572, 52048.73975630249, 52659.73670131625, 8477.067522572635, 8556.401051926554, 8570.357223208159, 8638.956805215934, 8701.912980870364, 9946.303758736818, 13090.345482726016, 13359.332033398485, 13376.130551514121, 13396.866031339561, 10849.945750271198, 10984.121270298518, 11039.0, 11134.33194008362, 11707.414629268673, 7881.842363152819, 10698.946505267735, 11076.723081922693, 11449.427528623703, 11668.533258669559, 10994.890051099706, 11323.547058117912, 11456.312621242752, 11721.589744358907, 12012.459439325427, 8556.058833528432, 8561.48631082137, 8565.48607083577, 8685.522296273513, 8733.781655458664, 9202.263818894338, 11368.658940231806, 11598.71003224926, 11611.303321800719, 11672.70818229551], "unit": "score", "name": "jquery.html", "value": 8993.377702559135}, {"lowerIsBetter": false, "replicates": [1553.6115971007248, 1576.818665853427, 1810.8551315894729, 1854.0173707934782, 1904.857135714821, 7726.227377262285, 8307.626156822942, 8501.829963400736, 8673.0, 8712.73861784146, 8389.538575378352, 8472.788180295496, 8475.237228649421, 8579.613917373717, 8585.656573737044, 2419.213755529451, 2452.9877350613224, 2462.4336402627405, 2467.4078221226955, 2468.0991438125043, 2386.546556154325, 2417.226487523993, 2444.5966415541416, 2449.8162637802147, 2463.2117722328862, 2447.0945750072497, 2465.716442609105, 2487.3905893056135, 2502.2618327593314, 2502.862342571158, 2412.384841865322, 2456.4104614892476, 2456.8157388195955, 2504.724480307183, 2516.5973444248834, 2460.5078984203233, 2462.581361168606, 2476.73994230605, 2492.314613481289, 2513.8491690498445, 8606.440581362254, 8618.913810861874, 8664.8700269496, 8681.826363472695, 8684.60919258635, 5299.894002119974, 5347.1177255752755, 5412.891742165135, 5415.458454154553, 5417.052015897202, 3315.287213249163, 3326.501024846268, 3376.4091284025444, 3384.8984530464127, 3426.9143271418166, 1038.6987773545663, 1050.5430137890041, 1052.5631862776938, 1055.6780182044474, 1059.3008614314515, 12091.395430228542, 12251.877481225163, 12259.448324825404, 12275.877241227652, 12332.260064396076, 4608.216603177468, 4734.28985652148, 4739.786709598076, 4758.310045043519, 4787.114383839001, 10296.22778291631, 10363.06732394088, 10368.326058806153, 10371.325863818827, 10397.428141452141, 5255.605829562798, 5342.9732851336275, 5369.24830523727, 5400.027994960945, 5412.134058550613, 4839.346688197048, 4854.17479028566, 4987.975060124676, 5006.148954677714, 5026.949730502648, 3812.6759225466144, 3871.728978971445, 3884.8834534964, 3894.883153505399, 3960.089179488734, 1207.8007128823822, 1218.4456072486996, 1219.603628820637, 1233.802591585342, 1234.9814752778716, 1337.8729020743015, 1342.328835582209, 1365.1945352242224, 1406.9226192559508, 1416.0583212163797, 7899.170587088388, 8095.02859656845, 8096.271335579826, 8103.756887293391, 8120.309773669186, 511.4399732293133, 520.0612893726859, 520.7422325948604, 523.4869827569004, 527.8416475057544, 5910.320313163955, 5944.881102377928, 5953.821385358447, 5970.552208584373, 5986.551008674367, 9898.703038908845, 10155.136813370798, 10187.847182292271, 10196.949015255024, 10238.129758970423, 9977.201823854219, 10083.899161008296, 10104.797904041878, 10209.642662506776, 10238.641647542301, 8100.270975612223, 8196.30331421824, 8228.30059444942, 8229.753107406787, 8301.418900677016, 7830.80422989407, 7834.843303134019, 7890.171531989288, 7955.164707705608, 7968.601569921365, 9261.0, 9350.485723285285, 9443.338966272295, 9452.353341064512, 9465.0, 9433.103855133751, 9620.71137865865, 9655.565499552678, 9703.369280996712, 9793.902060979584, 6921.377076063179, 7311.341979221896, 7404.851902962018, 7525.774226773206, 7584.393248540214, 8144.918550814416, 8172.101068882299, 8229.300509456763, 8236.958815205886, 8287.254147126787, 6892.345227203407, 7265.12818461788, 7288.526245794006, 7360.1903790584065, 7406.111266648037, 7246.202917679157, 7272.854542909006, 7274.781756547312, 7276.0, 7292.890606641011, 7662.080550333995, 7723.227677232232, 7759.146493885781, 7768.689252429839, 7808.141104478616, 6843.897341539781, 6950.131233595801, 6971.65141742921, 7004.509684322048, 7020.087388639444, 7101.928980710127, 7102.0, 7105.857882842418, 7106.502544821813, 7107.857842843011], "unit": "score", "name": "mootools.html", "value": 4807.050104720298}, {"lowerIsBetter": false, "replicates": [349.1724612667977, 351.95072689823445, 353.7329316366143, 359.01987573923196, 368.34250862210945, 6451.838704032401, 6498.025296205572, 6509.934900650992, 6518.120053792736, 6561.114249576306, 6360.968195159017, 6432.678366081689, 6439.935600643992, 6492.642904640243, 6501.707423165957, 4783.760811959405, 4882.365292511969, 4895.632827537949, 4928.876778080558, 4932.309476673268, 4916.090523253191, 4930.506949305077, 4938.456769755324, 4946.406431228258, 4947.50524947506, 4887.755612219393, 4895.730734809584, 4898.118338699032, 4901.754912254373, 4908.361912951329, 4887.877803054952, 4888.413390393158, 4895.192293271606, 4896.412430508326, 4896.412430508326, 4290.828366865321, 4300.182965236595, 4300.74195548265, 4309.84915527955, 4326.783660816978, 5939.435753603444, 6103.725332360054, 6125.601835880698, 6125.693715314261, 6139.2632884053755, 5693.686847223401, 5741.712914354307, 5750.856228594277, 5753.0, 5755.84883023397, 6852.862942741117, 6859.039734437183, 6868.896966545506, 6875.449964002868, 6898.965505172442, 4724.7401392923375, 4727.409073865767, 4733.810647574127, 4739.454962679301, 4774.212254977924, 7063.752768653072, 7144.607046612434, 7144.785656430316, 7146.785596432115, 7165.6775445105095, 4704.341392205094, 4782.976085119552, 4797.472278049412, 4858.295547145644, 4871.318015477836, 4904.7492889313, 4927.408710954708, 4932.852014439501, 4944.53026962438, 4958.776855041532, 5674.858128546737, 5680.147977803363, 5681.971590142023, 5692.971535142297, 5719.056355701263, 6819.079424277659, 6876.553024053421, 6878.621675807779, 6878.65606719662, 6879.5184337096925, 1707.6243226490153, 1743.2852530462703, 1743.686136495443, 1743.7907451105948, 1746.3451205797826, 1093.8359246113146, 1100.7908497385472, 1137.436968700482, 1138.698244965085, 1145.9885401146048, 6524.641144737085, 6572.507061970276, 6593.505487088488, 6605.141331626858, 6613.239477460057, 7013.509054366145, 7058.2941705830035, 7071.61106139157, 7095.574265544084, 7098.574085554883, 6453.45145662624, 6538.215414150332, 6543.083968244449, 6619.933800661932, 6626.370494802986, 3843.461915331856, 3853.9229215415535, 3864.0, 3868.2650296443585, 3885.592012838668, 7384.667689953965, 7395.778126656209, 7444.925550744423, 7453.627318634047, 7464.514806537558, 7357.117145942521, 7384.372328352043, 7402.222766609536, 7403.18564957865, 7440.7767766966, 7190.352868241884, 7414.0, 7457.925420745832, 7463.70145194197, 7464.589447580435, 7143.1428228612895, 7173.641317934187, 7175.784726458214, 7180.856382872209, 7207.495475316888, 7033.120859892513, 7050.365467107985, 7060.435165186876, 7068.787936361918, 7075.5047146699235, 7289.963550182215, 7426.8143296415865, 7436.888446673413, 7440.181580026301, 7443.106827180556, 4791.401074865642, 4834.685745426536, 4839.661223714306, 4841.830535931366, 4848.030393921159, 7137.500374973702, 7160.0, 7172.0676312079095, 7178.138623365229, 7181.138263408425, 6923.792286231421, 6928.341807528277, 6937.549059311129, 6939.167299924042, 6952.965235173791, 6722.327767223239, 6892.586444813327, 6912.170539535288, 6926.826829329307, 6933.306669333027, 6716.597004179765, 6743.224529179207, 6784.966075169593, 6815.69329380189, 6821.693023814039, 6938.618375989167, 6972.825679358057, 6977.895331570132, 6979.197392299748, 6980.930190698231, 6774.491913106635, 6798.694058767268, 6803.149606299213, 6803.42170915458, 6817.284185160685], "unit": "score", "name": "prototype.html", "value": 5180.362261169502}, {"lowerIsBetter": false, "replicates": [830.1283652165226, 833.0960907415454, 883.6818745251708, 886.4592598514909, 887.2236792806294, 13609.38757755901, 13654.0, 13677.452901883926, 13702.109362891406, 14251.50119745809, 13381.464741410357, 13391.866081339183, 13525.797113043312, 13530.25583592902, 13565.864341356584, 720.5208536323339, 831.4346244553701, 832.4963397144732, 839.8278352937633, 844.2233145506149, 844.2064459408167, 844.6410275632832, 847.7414388611471, 848.2196379331, 849.3502470609989, 880.6169316347409, 880.9867851982225, 885.4642941020686, 886.5257087458211, 896.5338024227431, 881.0660699658382, 883.9425437346616, 886.0120965123905, 886.835935351962, 896.6771962093641, 646.4698946863574, 656.5535435903583, 656.7176114270861, 660.5013215022675, 663.1279866974912, 14012.579622611338, 14046.43814247429, 14054.43782248719, 14097.85902140986, 14119.0, 13570.0, 13815.0, 13846.723065538632, 13934.30328483582, 14003.64990875226, 11059.170562207786, 11212.159088068427, 11213.66359009231, 11218.326900386002, 11285.605003824827, 3846.8845934622004, 3880.4373365862075, 3899.395593682984, 3908.609139086097, 3930.862419815321, 50691.23963140556, 51414.0, 52012.0, 52107.0, 52143.21785173225, 11171.16216283782, 11189.328640281608, 11198.16013798952, 11251.774964500828, 11312.434378281054, 20218.393448196577, 20324.69512957307, 20360.0, 20387.8980605099, 20400.18399264013, 7892.289693927574, 7892.802679932933, 7953.284204421514, 8011.278984891271, 8223.835523289501, 4550.362949187116, 4550.977245113753, 4584.770761461914, 4607.0785842831565, 4672.0, 3477.200243943907, 3497.965020349815, 3510.613832478425, 3528.8412021459094, 3544.91137721559, 618.0975775367923, 639.2073828452778, 639.3734140542294, 641.2561428742636, 643.3566433566433, 620.1534904854841, 694.3160986428364, 701.8771714949863, 703.2756261051126, 711.7971378157304, 9653.324267301221, 9746.171575416027, 9871.555779989918, 9903.950480247697, 9949.403035817873, 684.3737979748574, 693.1751216052982, 736.2453485177736, 743.0, 768.6925229908081, 4138.337865941435, 4220.936685949713, 4410.272305069628, 4418.911621767546, 4509.616682582017, 55002.17496737552, 59291.11063334053, 60673.39326606766, 61053.0, 61442.69278653578, 52074.0, 52233.0, 52806.471935280926, 53398.46601534013, 55067.72466137644, 47980.0, 48068.03863922702, 48416.27375589299, 48487.757561212675, 49257.0, 9287.257019438564, 9480.383775054599, 9683.709488715349, 9733.415995040321, 9871.753206169617, 34818.82590587132, 35242.64757352394, 36114.27771444504, 36571.63428365682, 36887.26225475529, 42314.15371692611, 42317.15365692607, 45234.0, 45842.0, 47358.0, 11740.119491038036, 12017.81973270419, 12080.39598020078, 12189.75620487603, 12338.444769985193, 12522.436490358137, 12637.0, 12834.358282085672, 13130.868691312964, 13269.60191194227, 11840.822387664364, 12052.397380130784, 12275.508979641072, 12323.0, 12326.260424374566, 12154.0, 12495.500179992698, 12579.748405031665, 12613.243205407338, 12727.745445091232, 11361.0, 11458.0, 11643.825342619699, 12252.0, 12499.437570303711, 9997.75005624836, 10578.153747700011, 10673.57305707763, 10989.505472253608, 11290.43547822622, 10263.281570290306, 10446.791064178826, 10742.140628749838, 10888.51001704941, 11056.447177641247], "unit": "score", "name": "yui.html", "value": 6760.705884688509}], "name": "dromaeo_css", "value": 7403.813077210657}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 112.0, 109.0, 110.0, 123.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [154.0, 136.0, 151.0, 167.0, 127.0, 162.0, 164.0, 128.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 160.0, 77.0, 76.0, 72.0, 79.0, 165.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 145.0, 94.0, 94.0, 95.0, 145.0, 94.0, 92.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 58.0, 57.0, 56.0, 57.0, 60.0, 62.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 80.0, 87.0, 79.0, 78.0, 80.0, 79.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 111.0, 116.0, 114.0, 114.0, 112.0, 128.0, 113.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.7}, {"lowerIsBetter": true, "replicates": [132.0, 143.0, 155.0, 136.0, 143.0, 140.0, 142.0, 152.0, 135.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 70.0, 67.0, 70.0, 65.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1509.2000000000003}]} 03:38:58 INFO - Return code: 0 03:38:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:38:58 ERROR - # TBPL SUCCESS # 03:38:58 INFO - Running post-action listener: _resource_record_post_action 03:38:58 INFO - Running post-run listener: _resource_record_post_run 03:38:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497414144; Read time: 12; Write time: 566396 03:38:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244654080; Read time: 0; Write time: 442248 03:38:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252162048; Read time: 12; Write time: 124148 03:38:59 INFO - Running post-run listener: _upload_blobber_files 03:38:59 INFO - Blob upload gear active. 03:38:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:59 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 03:38:59 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'] 03:38:59 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 03:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:01 INFO - (blobuploader) - INFO - Done attempting. 03:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:01 INFO - (blobuploader) - INFO - Done attempting. 03:39:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:01 INFO - Return code: 0 03:39:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6776aed75e961db11aaabba64d34db3537d36d82639bee62cc31b1201bcf08e5bab07376c1f238d61f74c2317e88ada2915c62fb959c7ea4fc30d8d5d25a814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9ca5ff91a99fcef6f6684732414c44fa525604c5390068d9718ed65077f814822148e56587f964fe92cc3d87bea4c9a84cac8f734c8b68d5a2fe8beeddd8cde"} 03:39:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:01 INFO - Contents: 03:39:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6776aed75e961db11aaabba64d34db3537d36d82639bee62cc31b1201bcf08e5bab07376c1f238d61f74c2317e88ada2915c62fb959c7ea4fc30d8d5d25a814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9ca5ff91a99fcef6f6684732414c44fa525604c5390068d9718ed65077f814822148e56587f964fe92cc3d87bea4c9a84cac8f734c8b68d5a2fe8beeddd8cde"} 03:39:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:01 INFO - Copying logs to upload dir... 03:39:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.563172 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-15 03:39:01.160107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:39:01.165472) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 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/6776aed75e961db11aaabba64d34db3537d36d82639bee62cc31b1201bcf08e5bab07376c1f238d61f74c2317e88ada2915c62fb959c7ea4fc30d8d5d25a814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9ca5ff91a99fcef6f6684732414c44fa525604c5390068d9718ed65077f814822148e56587f964fe92cc3d87bea4c9a84cac8f734c8b68d5a2fe8beeddd8cde"} build_url:https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/GyI6sQXbTairJ0nh4t2fpA/artifacts/public/build/firefox-47.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/6776aed75e961db11aaabba64d34db3537d36d82639bee62cc31b1201bcf08e5bab07376c1f238d61f74c2317e88ada2915c62fb959c7ea4fc30d8d5d25a814f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9ca5ff91a99fcef6f6684732414c44fa525604c5390068d9718ed65077f814822148e56587f964fe92cc3d87bea4c9a84cac8f734c8b68d5a2fe8beeddd8cde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:39:01.192073) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:39:01.192423) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460714130.280917-723721099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:39:01.275792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:39:01.279163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:39:01.279492) ========= ========= Total master_lag: 0.17 =========