builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1461215225.59 results: success (0) buildid: 20160420193352 builduid: 40f232753bdc4e8b8cd0aa5d512e1562 revision: 279dfae6682ff32bf6dfdc77546702d2999481db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.593501) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.594000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.594297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.611262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.611625) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 22:07:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.1M=0s 2016-04-20 22:07:05 (70.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.707655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.707985) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017584 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.756855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.757231) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 279dfae6682ff32bf6dfdc77546702d2999481db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 279dfae6682ff32bf6dfdc77546702d2999481db --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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 22:07:05,918 truncating revision to first 12 chars 2016-04-20 22:07:05,918 Setting DEBUG logging. 2016-04-20 22:07:05,918 attempt 1/10 2016-04-20 22:07:05,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/279dfae6682f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 22:07:06,187 unpacking tar archive at: mozilla-inbound-279dfae6682f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.330274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.330612) ========= script_repo_revision: 279dfae6682ff32bf6dfdc77546702d2999481db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.331000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.331351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.340550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-20 22:07:06.340895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:06 INFO - MultiFileLogger online at 20160420 22:07:06 in /builds/slave/test 22:07:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:07:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:06 INFO - {'append_to_log': False, 22:07:06 INFO - 'base_work_dir': '/builds/slave/test', 22:07:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:07:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:06 INFO - 'branch': 'Mozilla-Inbound', 22:07:06 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:06 INFO - 'config_files': ('talos/linux_config.py',), 22:07:06 INFO - 'default_actions': ('clobber', 22:07:06 INFO - 'read-buildbot-config', 22:07:06 INFO - 'download-and-extract', 22:07:06 INFO - 'populate-webroot', 22:07:06 INFO - 'create-virtualenv', 22:07:06 INFO - 'install', 22:07:06 INFO - 'run-tests'), 22:07:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:06 INFO - 'download_minidump_stackwalk': True, 22:07:06 INFO - 'download_symbols': 'ondemand', 22:07:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:06 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:06 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:06 INFO - 'installer_path': 'installer.exe', 22:07:06 INFO - 'log_level': 'info', 22:07:06 INFO - 'log_name': 'talos', 22:07:06 INFO - 'log_to_console': True, 22:07:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:06 INFO - 'opt_config_files': (), 22:07:06 INFO - 'pip_index': False, 22:07:06 INFO - 'sps_profile': False, 22:07:06 INFO - 'sps_profile_interval': 0, 22:07:06 INFO - 'suite': 'dromaeojs-e10s', 22:07:06 INFO - 'system_bits': '32', 22:07:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:06 INFO - 'title': 'talos-linux64-ix-060', 22:07:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:06 INFO - 'use_talos_json': True, 22:07:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:06 INFO - 'work_dir': 'build'} 22:07:06 INFO - ##### 22:07:06 INFO - ##### Running clobber step. 22:07:06 INFO - ##### 22:07:06 INFO - Running pre-action listener: _resource_record_pre_action 22:07:06 INFO - Running main action method: clobber 22:07:06 INFO - rmtree: /builds/slave/test/build 22:07:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:07 INFO - Running post-action listener: _resource_record_post_action 22:07:07 INFO - ##### 22:07:07 INFO - ##### Running read-buildbot-config step. 22:07:07 INFO - ##### 22:07:07 INFO - Running pre-action listener: _resource_record_pre_action 22:07:07 INFO - Running main action method: read_buildbot_config 22:07:07 INFO - Using buildbot properties: 22:07:07 INFO - { 22:07:07 INFO - "project": "", 22:07:07 INFO - "product": "firefox", 22:07:07 INFO - "script_repo_revision": "production", 22:07:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:07:07 INFO - "repository": "", 22:07:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:07:07 INFO - "buildid": "20160420193352", 22:07:07 INFO - "pgo_build": "True", 22:07:07 INFO - "basedir": "/builds/slave/test", 22:07:07 INFO - "buildnumber": 481, 22:07:07 INFO - "slavename": "talos-linux64-ix-060", 22:07:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:07:07 INFO - "platform": "ubuntu64_hw", 22:07:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:07:07 INFO - "branch": "mozilla-inbound", 22:07:07 INFO - "repo_path": "integration/mozilla-inbound", 22:07:07 INFO - "revision": "279dfae6682ff32bf6dfdc77546702d2999481db", 22:07:07 INFO - "stage_platform": "linux64-pgo", 22:07:07 INFO - "builduid": "40f232753bdc4e8b8cd0aa5d512e1562", 22:07:07 INFO - "slavebuilddir": "test" 22:07:07 INFO - } 22:07:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:07:07 INFO - Running post-action listener: _resource_record_post_action 22:07:07 INFO - ##### 22:07:07 INFO - ##### Running download-and-extract step. 22:07:07 INFO - ##### 22:07:07 INFO - Running pre-action listener: _resource_record_pre_action 22:07:07 INFO - Running main action method: download_and_extract 22:07:07 INFO - mkdir: /builds/slave/test/build/tests 22:07: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')]} 22:07:07 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:08 INFO - Downloaded 1361 bytes. 22:07:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:08 INFO - Using the following test package requirements: 22:07:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:07:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'jsshell-linux-x86_64.zip'], 22:07:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:07:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:07:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:08 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')]} 22:07:08 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:11 INFO - Downloaded 23849222 bytes. 22:07:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:12 INFO - Return code: 0 22:07:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07:12 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')]} 22:07:12 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:16 INFO - Downloaded 23849222 bytes. 22:07:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:17 INFO - Return code: 0 22:07:17 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')]} 22:07:17 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:18 INFO - Downloaded 10845952 bytes. 22:07:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:07:19 INFO - Return code: 0 22:07:19 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')]} 22:07:19 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:20 INFO - Downloaded 58323054 bytes. 22:07:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:20 INFO - mkdir: /builds/slave/test/properties 22:07:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:20 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:20 INFO - Contents: 22:07:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:21 INFO - Running post-action listener: _resource_record_post_action 22:07:21 INFO - Running post-action listener: set_extra_try_arguments 22:07:21 INFO - ##### 22:07:21 INFO - ##### Running populate-webroot step. 22:07:21 INFO - ##### 22:07:21 INFO - Running pre-action listener: _resource_record_pre_action 22:07:21 INFO - Running main action method: populate_webroot 22:07:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:21 INFO - '--tppagecycles', 22:07:21 INFO - '7'], 22:07:21 INFO - 'tests': ['tsvgm']}}, 22:07:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:07:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:07:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:07:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['damp', 'tps']}, 22:07:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['damp', 'tps']}, 22:07:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['dromaeo_dom']}, 22:07:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tsvgx', 22:07:21 INFO - 'tsvgr_opacity', 22:07:21 INFO - 'tart', 22:07:21 INFO - 'tscrollx', 22:07:21 INFO - 'cart']}, 22:07:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:07:21 INFO - 'tsvgr_opacity', 22:07:21 INFO - 'tart', 22:07:21 INFO - 'tscrollx', 22:07:21 INFO - 'cart']}, 22:07:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tp5o']}, 22:07:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['tp5o']}, 22:07:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s', 22:07:21 INFO - '--xperf_path', 22:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:21 INFO - 'tests': ['tp5n']}, 22:07:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--xperf_path', 22:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:21 INFO - 'tests': ['tp5n']}}, 22:07:21 INFO - 'talos.zip': {'path': '', 22:07:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:21 INFO - Running post-action listener: _resource_record_post_action 22:07:21 INFO - ##### 22:07:21 INFO - ##### Running create-virtualenv step. 22:07:21 INFO - ##### 22:07:21 INFO - Running pre-action listener: _resource_record_pre_action 22:07:21 INFO - Running main action method: create_virtualenv 22:07:21 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:21 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 22:07:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:21 INFO - Using real prefix '/usr' 22:07:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:23 INFO - Installing pip.................done. 22:07:23 INFO - Return code: 0 22:07:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:23 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')]} 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 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')]} 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:23 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 22:07:23 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 22:07:23 INFO - Using env: {'DISPLAY': ':0', 22:07:23 INFO - 'HOME': '/home/cltbld', 22:07:23 INFO - 'LANG': 'en_US.UTF-8', 22:07:23 INFO - 'LANGUAGE': 'en_US:en', 22:07:23 INFO - 'LOGNAME': 'cltbld', 22:07:23 INFO - 'MAIL': '/var/mail/cltbld', 22:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:23 INFO - 'MOZ_NO_REMOTE': '1', 22:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:23 INFO - 'NO_EM_RESTART': '1', 22:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:23 INFO - 'PWD': '/builds/slave/test', 22:07:23 INFO - 'SHELL': '/bin/bash', 22:07:23 INFO - 'SHLVL': '1', 22:07:23 INFO - 'TERM': 'linux', 22:07:23 INFO - 'TMOUT': '86400', 22:07:23 INFO - 'USER': 'cltbld', 22:07:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:23 INFO - '_': '/tools/buildbot/bin/python'} 22:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:24 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 22:07:24 INFO - Cleaning up... 22:07:24 INFO - Return code: 0 22:07:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07:24 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')]} 22:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:24 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')]} 22:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:24 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:24 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 22:07:24 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 22:07:24 INFO - Using env: {'DISPLAY': ':0', 22:07:24 INFO - 'HOME': '/home/cltbld', 22:07:24 INFO - 'LANG': 'en_US.UTF-8', 22:07:24 INFO - 'LANGUAGE': 'en_US:en', 22:07:24 INFO - 'LOGNAME': 'cltbld', 22:07:24 INFO - 'MAIL': '/var/mail/cltbld', 22:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:24 INFO - 'MOZ_NO_REMOTE': '1', 22:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:24 INFO - 'NO_EM_RESTART': '1', 22:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:24 INFO - 'PWD': '/builds/slave/test', 22:07:24 INFO - 'SHELL': '/bin/bash', 22:07:24 INFO - 'SHLVL': '1', 22:07:24 INFO - 'TERM': 'linux', 22:07:24 INFO - 'TMOUT': '86400', 22:07:24 INFO - 'USER': 'cltbld', 22:07:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:24 INFO - '_': '/tools/buildbot/bin/python'} 22:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:24 INFO - Downloading/unpacking psutil>=0.7.1 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:26 INFO - Installing collected packages: psutil 22:07:26 INFO - Running setup.py install for psutil 22:07:26 INFO - building 'psutil._psutil_linux' extension 22:07:26 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 22:07:26 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 22:07:26 INFO - building 'psutil._psutil_posix' extension 22:07:26 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 22:07:26 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 22:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:26 INFO - Successfully installed psutil 22:07:26 INFO - Cleaning up... 22:07:26 INFO - Return code: 0 22:07:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:26 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:26 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 22:07:26 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 22:07:26 INFO - Using env: {'DISPLAY': ':0', 22:07:26 INFO - 'HOME': '/home/cltbld', 22:07:26 INFO - 'LANG': 'en_US.UTF-8', 22:07:26 INFO - 'LANGUAGE': 'en_US:en', 22:07:26 INFO - 'LOGNAME': 'cltbld', 22:07:26 INFO - 'MAIL': '/var/mail/cltbld', 22:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:26 INFO - 'MOZ_NO_REMOTE': '1', 22:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:26 INFO - 'NO_EM_RESTART': '1', 22:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:26 INFO - 'PWD': '/builds/slave/test', 22:07:26 INFO - 'SHELL': '/bin/bash', 22:07:26 INFO - 'SHLVL': '1', 22:07:26 INFO - 'TERM': 'linux', 22:07:26 INFO - 'TMOUT': '86400', 22:07:26 INFO - 'USER': 'cltbld', 22:07:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:26 INFO - '_': '/tools/buildbot/bin/python'} 22:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:27 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 22:07:27 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 22:07:27 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 22:07:27 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 22:07:27 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 22:07:27 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 22:07:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:28 INFO - Installing collected packages: mozsystemmonitor 22:07:28 INFO - Running setup.py install for mozsystemmonitor 22:07:29 INFO - Successfully installed mozsystemmonitor 22:07:29 INFO - Cleaning up... 22:07:29 INFO - Return code: 0 22:07:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:29 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:29 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 22:07:29 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 22:07:29 INFO - Using env: {'DISPLAY': ':0', 22:07:29 INFO - 'HOME': '/home/cltbld', 22:07:29 INFO - 'LANG': 'en_US.UTF-8', 22:07:29 INFO - 'LANGUAGE': 'en_US:en', 22:07:29 INFO - 'LOGNAME': 'cltbld', 22:07:29 INFO - 'MAIL': '/var/mail/cltbld', 22:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:29 INFO - 'MOZ_NO_REMOTE': '1', 22:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:29 INFO - 'NO_EM_RESTART': '1', 22:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:29 INFO - 'PWD': '/builds/slave/test', 22:07:29 INFO - 'SHELL': '/bin/bash', 22:07:29 INFO - 'SHLVL': '1', 22:07:29 INFO - 'TERM': 'linux', 22:07:29 INFO - 'TMOUT': '86400', 22:07:29 INFO - 'USER': 'cltbld', 22:07:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:29 INFO - '_': '/tools/buildbot/bin/python'} 22:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:29 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:31 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 INFO - Downloading docopt-0.6.1.tar.gz 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:31 INFO - Running setup.py install for blobuploader 22:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:32 INFO - Running setup.py install for requests 22:07:32 INFO - Running setup.py install for docopt 22:07:32 INFO - Successfully installed blobuploader requests docopt 22:07:32 INFO - Cleaning up... 22:07:32 INFO - Return code: 0 22:07:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:32 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:32 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 22:07:32 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 22:07:32 INFO - Using env: {'DISPLAY': ':0', 22:07:32 INFO - 'HOME': '/home/cltbld', 22:07:32 INFO - 'LANG': 'en_US.UTF-8', 22:07:32 INFO - 'LANGUAGE': 'en_US:en', 22:07:32 INFO - 'LOGNAME': 'cltbld', 22:07:32 INFO - 'MAIL': '/var/mail/cltbld', 22:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:32 INFO - 'MOZ_NO_REMOTE': '1', 22:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:32 INFO - 'NO_EM_RESTART': '1', 22:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:32 INFO - 'PWD': '/builds/slave/test', 22:07:32 INFO - 'SHELL': '/bin/bash', 22:07:32 INFO - 'SHLVL': '1', 22:07:32 INFO - 'TERM': 'linux', 22:07:32 INFO - 'TMOUT': '86400', 22:07:32 INFO - 'USER': 'cltbld', 22:07:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:32 INFO - '_': '/tools/buildbot/bin/python'} 22:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:32 INFO - Running setup.py (path:/tmp/pip-tLUFXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:32 INFO - Running setup.py (path:/tmp/pip-_XedJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:32 INFO - Running setup.py (path:/tmp/pip-JY21yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:32 INFO - Running setup.py (path:/tmp/pip-p_PrGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:33 INFO - Running setup.py (path:/tmp/pip-rWSnIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:33 INFO - Running setup.py (path:/tmp/pip-BbdApd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:33 INFO - Running setup.py (path:/tmp/pip-dI5YBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:33 INFO - Running setup.py (path:/tmp/pip-aeDZ3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:33 INFO - Running setup.py (path:/tmp/pip-wzsFKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:33 INFO - Running setup.py (path:/tmp/pip-oamv1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:33 INFO - Running setup.py (path:/tmp/pip-qCtXy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:33 INFO - Running setup.py (path:/tmp/pip-9tvfDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:33 INFO - Running setup.py (path:/tmp/pip-uBR65d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:33 INFO - Running setup.py (path:/tmp/pip-IqxsVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:33 INFO - Running setup.py (path:/tmp/pip-ccDCjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:33 INFO - Running setup.py (path:/tmp/pip-jX2DTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:33 INFO - Running setup.py (path:/tmp/pip-xXx6sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:33 INFO - Running setup.py install for manifestparser 22:07:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozcrash 22:07:34 INFO - Running setup.py install for mozdebug 22:07:34 INFO - Running setup.py install for mozdevice 22:07:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozfile 22:07:34 INFO - Running setup.py install for mozhttpd 22:07:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozinfo 22:07:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozInstall 22:07:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozleak 22:07:34 INFO - Running setup.py install for mozlog 22:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for moznetwork 22:07:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Running setup.py install for mozprocess 22:07:35 INFO - Running setup.py install for mozprofile 22:07:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Running setup.py install for mozrunner 22:07:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Running setup.py install for mozscreenshot 22:07:35 INFO - Running setup.py install for moztest 22:07:35 INFO - Running setup.py install for mozversion 22:07:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:35 INFO - Cleaning up... 22:07:35 INFO - Return code: 0 22:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:35 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')]} 22:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:35 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')]} 22:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:35 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:35 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 22:07:35 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 22:07:35 INFO - Using env: {'DISPLAY': ':0', 22:07:35 INFO - 'HOME': '/home/cltbld', 22:07:35 INFO - 'LANG': 'en_US.UTF-8', 22:07:35 INFO - 'LANGUAGE': 'en_US:en', 22:07:35 INFO - 'LOGNAME': 'cltbld', 22:07:35 INFO - 'MAIL': '/var/mail/cltbld', 22:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:35 INFO - 'MOZ_NO_REMOTE': '1', 22:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:35 INFO - 'NO_EM_RESTART': '1', 22:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:35 INFO - 'PWD': '/builds/slave/test', 22:07:35 INFO - 'SHELL': '/bin/bash', 22:07:35 INFO - 'SHLVL': '1', 22:07:35 INFO - 'TERM': 'linux', 22:07:35 INFO - 'TMOUT': '86400', 22:07:35 INFO - 'USER': 'cltbld', 22:07:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:35 INFO - '_': '/tools/buildbot/bin/python'} 22:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:35 INFO - Running setup.py (path:/tmp/pip-0c_drg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:36 INFO - Running setup.py (path:/tmp/pip-u5Qiwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:36 INFO - Running setup.py (path:/tmp/pip-BPJ57s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:36 INFO - Running setup.py (path:/tmp/pip-OIJGYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:36 INFO - Running setup.py (path:/tmp/pip-V7z7PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:36 INFO - Running setup.py (path:/tmp/pip-4bePhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:36 INFO - Running setup.py (path:/tmp/pip-I5b5JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:36 INFO - Running setup.py (path:/tmp/pip-vE0Vr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:36 INFO - Running setup.py (path:/tmp/pip-u1TFDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:36 INFO - Running setup.py (path:/tmp/pip-bGCsv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:36 INFO - Running setup.py (path:/tmp/pip-vjbXaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:36 INFO - Running setup.py (path:/tmp/pip-shDfLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:36 INFO - Running setup.py (path:/tmp/pip-9LhNWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:36 INFO - Running setup.py (path:/tmp/pip-Uz376v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:36 INFO - Running setup.py (path:/tmp/pip-gfTd6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:37 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)) 22:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:37 INFO - Running setup.py (path:/tmp/pip-FdUry9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:37 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)) 22:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:37 INFO - Running setup.py (path:/tmp/pip-Lb6plo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:37 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 22:07:37 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 22:07:37 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 22:07:37 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 22:07:37 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 22:07:37 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 22:07:38 INFO - Downloading blessings-1.6.tar.gz 22:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:39 INFO - Installing collected packages: blessings 22:07:39 INFO - Running setup.py install for blessings 22:07:39 INFO - Successfully installed blessings 22:07:39 INFO - Cleaning up... 22:07:39 INFO - Return code: 0 22:07:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:39 INFO - Reading from file tmpfile_stdout 22:07:39 INFO - Current package versions: 22:07:39 INFO - argparse == 1.2.1 22:07:39 INFO - blessings == 1.6 22:07:39 INFO - blobuploader == 1.2.4 22:07:39 INFO - docopt == 0.6.1 22:07:39 INFO - manifestparser == 1.1 22:07:39 INFO - mozInstall == 1.12 22:07:39 INFO - mozcrash == 0.17 22:07:39 INFO - mozdebug == 0.1 22:07:39 INFO - mozdevice == 0.48 22:07:39 INFO - mozfile == 1.2 22:07:39 INFO - mozhttpd == 0.7 22:07:39 INFO - mozinfo == 0.9 22:07:39 INFO - mozleak == 0.1 22:07:39 INFO - mozlog == 3.1 22:07:39 INFO - moznetwork == 0.27 22:07:39 INFO - mozprocess == 0.22 22:07:39 INFO - mozprofile == 0.28 22:07:39 INFO - mozrunner == 6.11 22:07:39 INFO - mozscreenshot == 0.1 22:07:39 INFO - mozsystemmonitor == 0.0 22:07:39 INFO - moztest == 0.7 22:07:39 INFO - mozversion == 1.4 22:07:39 INFO - psutil == 3.1.1 22:07:39 INFO - requests == 1.2.3 22:07:39 INFO - wsgiref == 0.1.2 22:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:39 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 22:07:39 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 22:07:39 INFO - Using env: {'DISPLAY': ':0', 22:07:39 INFO - 'HOME': '/home/cltbld', 22:07:39 INFO - 'LANG': 'en_US.UTF-8', 22:07:39 INFO - 'LANGUAGE': 'en_US:en', 22:07:39 INFO - 'LOGNAME': 'cltbld', 22:07:39 INFO - 'MAIL': '/var/mail/cltbld', 22:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:39 INFO - 'MOZ_NO_REMOTE': '1', 22:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:39 INFO - 'NO_EM_RESTART': '1', 22:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:39 INFO - 'PWD': '/builds/slave/test', 22:07:39 INFO - 'SHELL': '/bin/bash', 22:07:39 INFO - 'SHLVL': '1', 22:07:39 INFO - 'TERM': 'linux', 22:07:39 INFO - 'TMOUT': '86400', 22:07:39 INFO - 'USER': 'cltbld', 22:07:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:39 INFO - '_': '/tools/buildbot/bin/python'} 22:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 INFO - Cleaning up... 22:07:39 INFO - Return code: 0 22:07:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:07:39 INFO - Using env: {'DISPLAY': ':0', 22:07:39 INFO - 'HOME': '/home/cltbld', 22:07:39 INFO - 'LANG': 'en_US.UTF-8', 22:07:39 INFO - 'LANGUAGE': 'en_US:en', 22:07:39 INFO - 'LOGNAME': 'cltbld', 22:07:39 INFO - 'MAIL': '/var/mail/cltbld', 22:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:39 INFO - 'MOZ_NO_REMOTE': '1', 22:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:39 INFO - 'NO_EM_RESTART': '1', 22:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:39 INFO - 'PWD': '/builds/slave/test', 22:07:39 INFO - 'SHELL': '/bin/bash', 22:07:39 INFO - 'SHLVL': '1', 22:07:39 INFO - 'TERM': 'linux', 22:07:39 INFO - 'TMOUT': '86400', 22:07:39 INFO - 'USER': 'cltbld', 22:07:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:39 INFO - '_': '/tools/buildbot/bin/python'} 22:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:39 INFO - Downloading/unpacking jsonschema 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:41 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:42 INFO - warning: no files found matching '*.txt' 22:07:42 INFO - no previously-included directories found matching 'build' 22:07:42 INFO - no previously-included directories found matching 'dist' 22:07:42 INFO - no previously-included directories found matching '.git*' 22:07:42 INFO - Installing collected packages: jsonschema, functools32 22:07:42 INFO - Running setup.py install for functools32 22:07:42 INFO - warning: no files found matching '*.txt' 22:07:42 INFO - no previously-included directories found matching 'build' 22:07:42 INFO - no previously-included directories found matching 'dist' 22:07:42 INFO - no previously-included directories found matching '.git*' 22:07:42 INFO - Successfully installed jsonschema functools32 22:07:42 INFO - Cleaning up... 22:07:42 INFO - Return code: 0 22:07:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:42 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 0x7f1d8ed29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25815a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', '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 22:07:42 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 22:07:42 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 22:07:42 INFO - Using env: {'DISPLAY': ':0', 22:07:42 INFO - 'HOME': '/home/cltbld', 22:07:42 INFO - 'LANG': 'en_US.UTF-8', 22:07:42 INFO - 'LANGUAGE': 'en_US:en', 22:07:42 INFO - 'LOGNAME': 'cltbld', 22:07:42 INFO - 'MAIL': '/var/mail/cltbld', 22:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:42 INFO - 'MOZ_NO_REMOTE': '1', 22:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:42 INFO - 'NO_EM_RESTART': '1', 22:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:42 INFO - 'PWD': '/builds/slave/test', 22:07:42 INFO - 'SHELL': '/bin/bash', 22:07:42 INFO - 'SHLVL': '1', 22:07:42 INFO - 'TERM': 'linux', 22:07:42 INFO - 'TMOUT': '86400', 22:07:42 INFO - 'USER': 'cltbld', 22:07:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:42 INFO - '_': '/tools/buildbot/bin/python'} 22:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:42 INFO - Downloading/unpacking flake8 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 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 22:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:45 INFO - no previously-included directories found matching 'docs/_build' 22:07:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:45 INFO - Running setup.py install for pep8 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:45 INFO - no previously-included directories found matching 'docs/_build' 22:07:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:07:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:45 INFO - Cleaning up... 22:07:45 INFO - Return code: 0 22:07:45 INFO - Running post-action listener: _resource_record_post_action 22:07:45 INFO - Running post-action listener: _start_resource_monitoring 22:07:45 INFO - Starting resource monitoring. 22:07:45 INFO - ##### 22:07:45 INFO - ##### Running install step. 22:07:45 INFO - ##### 22:07:45 INFO - Running pre-action listener: _resource_record_pre_action 22:07:45 INFO - Running main action method: install 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:45 INFO - Reading from file tmpfile_stdout 22:07:45 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:45 INFO - Reading from file tmpfile_stdout 22:07:45 INFO - Output received: 22:07:45 INFO - Usage: mozinstall [options] installer 22:07:45 INFO - Options: 22:07:45 INFO - -h, --help show this help message and exit 22:07:45 INFO - -d DEST, --destination=DEST 22:07:45 INFO - Directory to install application into. [default: 22:07:45 INFO - "/builds/slave/test"] 22:07:45 INFO - --app=APP Application being installed. [default: firefox] 22:07:45 INFO - mkdir: /builds/slave/test/build/application 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:08:02 INFO - Reading from file tmpfile_stdout 22:08:02 INFO - Output received: 22:08:02 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:02 INFO - Running post-action listener: _resource_record_post_action 22:08:02 INFO - ##### 22:08:02 INFO - ##### Running run-tests step. 22:08:02 INFO - ##### 22:08:02 INFO - Running pre-action listener: _resource_record_pre_action 22:08:02 INFO - Running main action method: run_tests 22:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:02 INFO - Python 2.7.3 22:08:02 INFO - Return code: 0 22:08:02 INFO - grabbing minidump binary from tooltool 22:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:02 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 0x2610410>, '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 0x2611310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26117a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:02 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 22:08:02 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 22:08:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:02 INFO - Return code: 0 22:08:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:08:03 INFO - Return code: 0 22:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 22:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 22:08:03 INFO - Using env: {'DISPLAY': ':0', 22:08:03 INFO - 'HOME': '/home/cltbld', 22:08:03 INFO - 'LANG': 'en_US.UTF-8', 22:08:03 INFO - 'LANGUAGE': 'en_US:en', 22:08:03 INFO - 'LOGNAME': 'cltbld', 22:08:03 INFO - 'MAIL': '/var/mail/cltbld', 22:08:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:03 INFO - 'MOZ_NO_REMOTE': '1', 22:08:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:03 INFO - 'NO_EM_RESTART': '1', 22:08:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:03 INFO - 'PWD': '/builds/slave/test', 22:08:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:03 INFO - 'SHELL': '/bin/bash', 22:08:03 INFO - 'SHLVL': '1', 22:08:03 INFO - 'TERM': 'linux', 22:08:03 INFO - 'TMOUT': '86400', 22:08:03 INFO - 'USER': 'cltbld', 22:08:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938', 22:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:03 INFO - '_': '/tools/buildbot/bin/python'} 22:08:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 22:08:03 INFO - mozversion application_buildid: 20160420193352 22:08:03 INFO - mozversion application_changeset: 279dfae6682ff32bf6dfdc77546702d2999481db 22:08:03 INFO - mozversion application_display_name: Nightly 22:08:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:03 INFO - mozversion application_name: Firefox 22:08:03 INFO - mozversion application_remotingname: firefox 22:08:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:03 INFO - mozversion application_vendor: Mozilla 22:08:03 INFO - mozversion application_version: 48.0a1 22:08:03 INFO - mozversion platform_buildid: 20160420193352 22:08:03 INFO - mozversion platform_changeset: 279dfae6682ff32bf6dfdc77546702d2999481db 22:08:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:03 INFO - mozversion platform_version: 48.0a1 22:08:03 INFO - using testdate: 1461215283 22:08:03 INFO - actual date: 1461215283 22:08:03 INFO - starting webserver on 'localhost:53586' 22:08:03 INFO - SUITE-START | Running 2 tests 22:08:03 INFO - TEST-START | dromaeo_css 22:08:03 INFO - operating with platform_type : linux_ 22:08:03 INFO - Initialising browser for dromaeo_css test... 22:08:03 INFO - TEST-INFO | started process 17612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TByBJ/profile http://localhost:53586/getInfo.html) 22:08:06 INFO - PROCESS | 17612 | 22:08:06 INFO - PROCESS | 17612 | (process:17683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:07 INFO - PROCESS | 17612 | __metrics Screen width/height:1600/1200 22:08:07 INFO - PROCESS | 17612 | colorDepth:24 22:08:07 INFO - PROCESS | 17612 | Browser inner width/height: 1024/697 22:08:07 INFO - PROCESS | 17612 | __metrics 22:08:08 ERROR - PROCESS | 17612 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:08:09 INFO - TEST-INFO | 17612: exit 0 22:08:09 INFO - Browser initialized. 22:08:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:09 INFO - TEST-INFO | started process 17734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7TByBJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:11 INFO - PROCESS | 17734 | 22:08:11 INFO - PROCESS | 17734 | (process:17793): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:21 INFO - PROCESS | 17734 | RSS: Main: 163864576 22:08:21 INFO - PROCESS | 17734 | 22:09:10 INFO - PROCESS | 17734 | 1461215350824 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] 22:11:18 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53586/tests/dromaeo/cssquery-ext.html) 22:11:19 INFO - PROCESS | 17734 | RSS: Main: 169029632 22:11:19 INFO - PROCESS | 17734 | 22:14:21 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-ext.html (next: http://localhost:53586/tests/dromaeo/cssquery-jquery.html) 22:14:21 INFO - PROCESS | 17734 | RSS: Main: 165355520 22:14:21 INFO - PROCESS | 17734 | 22:17:23 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53586/tests/dromaeo/cssquery-mootools.html) 22:17:23 INFO - PROCESS | 17734 | RSS: Main: 166785024 22:17:23 INFO - PROCESS | 17734 | 22:20:25 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53586/tests/dromaeo/cssquery-prototype.html) 22:20:26 INFO - PROCESS | 17734 | RSS: Main: 164388864 22:20:26 INFO - PROCESS | 17734 | 22:23:28 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53586/tests/dromaeo/cssquery-yui.html) 22:23:29 INFO - PROCESS | 17734 | RSS: Main: 166232064 22:23:29 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | Cycle 1(1): loaded http://localhost:53586/tests/dromaeo/cssquery-yui.html (next: http://localhost:53586/tests/dromaeo/cssquery-dojo.html) 22:26:31 INFO - PROCESS | 17734 | RSS: Main: 167710720 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | __start_tp_report 22:26:31 INFO - PROCESS | 17734 | _x_x_mozilla_page_load 22:26:31 INFO - PROCESS | 17734 | _x_x_mozilla_page_load_details 22:26:31 INFO - PROCESS | 17734 | |i|pagename|runs| 22:26:31 INFO - PROCESS | 17734 | |0;dojo.html;3060.6633270340258;3061.693830616938;3114.6573876873526;3139.6546379898223;3141.842907854607;5240.790368385269;5282.418933917271;5293.444188360225;5313.681179129255;5356.651817631851;5206.531412172903;5281.577473802096;5314.468553144693;5343.919841202375;5390.649607775492;4746.359241502405;4778.761061946889;4825.613950883921;4853.417589889218;4875.8537243882565;815.1199648593786;4838.782254798525;4843.128236917353;4889.559939605435;4908.214685650297;4831.9275210871865;4852.369192005052;4868.245421959602;4871.147549178897;4908.7300198489065;4679.81280748773;4920.188168952119;4948.851534453972;4963.45402005779;4983.601311895076;4762.738049407281;4781.737004464753;4799.18413869643;4834.250691142844;4843.4914333994775;5198.740062996872;5210.843674689765;5227.555657769094;5229.529342359206;5286.259923610698;5599.580031497654;5604.327480702342;5608.130739735348;5660.066089095294;5718.971405142947;5620.409856965041;5666.178404131378;5670.914936275959;5679.460451257124;5697.715114244313;5223.059849227137;5255.527002569787;5268.262443257947;5271.235670827708;5337.919931200996;5659.5755318351285;5776.33572139201;5789.594728369058;5856.765729370777;5897.587168898136;5507.476789704971;5540.501354878;5540.584456165804;5543.722813859291;5543.750531226024;5611.354694210218;5617.438256174431;5625.606207565513;5627.8593035174445;5628.099504079328;5517.751701173457;5648.604597678205;5677.574181936288;5700.8859822803315;5707.629004114802;5489.807856724996;5586.497215250647;5594.552435805126;5628.380878103405;5675.31896172462;4274;4325.718828276152;4329.6536277098385;4331.285337919271;4361.433013708261;3808.2383523294898;3814;3847.788371639587;3883;3892.2993861105274;5380.515753582118;5383.031054410244;5389.676619402849;5390.380106287748;5395.109806881899;5620.213170156181;5641.774329026793;5642.548596112301;5645.887082258332;5652.236948012048;5263.7894484220205;5338.439463856317;5368.3826359968325;5422.15956526739;5440.020796256633;4765.666403351732;4783.425988881357;4784.30627559002;4785.1625965455905;4811.566958973709;5626.718664066781;5678.034734095214;5688.800891968844;5708.457696518824;5740.397258287903;5632.436756324417;5657.2928383952;5678.829635110953;5705.457981491834;5728.0262355398845;5711.485966263056;5725.656460612377;5727.455891690282;5732.799352022659;5739.62692424991;5429.375621803543;5501.3948465667945;5504.614676972574;5505.421930697379;5536.52939500147;5673.886522269614;5679.119736440858;5687.516561092188;5693.971530142323;5741.856453588526;5475.452454754652;5518.558515318845;5532.30846144232;5533.059379905506;5546.667199968015;5390.27231323782;5490.286262785812;5506.697131657797;5517.124516566377;5569.610127291051;5290.814821481384;5372.301600791872;5438.972805136107;5442.755076021509;5460.726963651881;5460.099083651153;5488.506034456918;5518.144687573433;5550.38945715979;5557.833265002057;5303.416624171261;5384.865378365572;5406.216098665593;5408.72956352173;5462.535684466865 22:26:31 INFO - PROCESS | 17734 | |1;ext.html;601.4136217188242;628.9905651415227;640.103854603555;645.9741610335584;653.333599728277;38582.61417385825;39207.607923920754;39279;39360.21279574407;39710.60289397105;35624.64375356246;35736.642633573654;35902.640973590256;35960.46059309113;35961.1009724757;8490.490570565771;8732.8690069649;8739.781505462382;8856.202941735242;8859.645614175457;8591.527465989368;8677.739667809945;8711.215990560848;8928;8939.77650558738;8946.597403116875;9004.774880628003;9005.459672419676;9005.729828105135;9007.729768106967;8844.911550884473;8876.600552975067;8941.865872011926;8987.056359082268;9003.774905627346;8682.565871706389;8871.467711937305;8877.51173685447;8886.422382545114;8925.464472131693;40929.38605920914;41671.58328416707;41730;41743.1651366974;41830.581694182976;2890.5519644455144;3239;3418.4017796885696;3434.1586311353876;3504.8773292934625;27570.310742231402;27579.172624821087;27794.3051423714;27798.3050423739;27856.30359241015;4034.979825100885;4067.51189857219;4121.278776214151;4183.393407955859;4384.517703052694;275301;276503;277151;277454;277671;59952;60132.39867601268;60153.398466014776;60166.28420300064;60168.08907421004;63248;65187.674061630336;65246.34753652403;65544;65771.34228657748;16367.427140050278;16590;16617.750733739005;16725.6654866902;16746.4138755143;12261.203021803554;12400.441980110916;12466.376681165906;12478.313692746804;12497.500099995897;18930.242790288234;19107.617847643247;19137.90431047836;20106;20148.39554813358;6773.390394864387;7162.140543134858;7181.964090179516;7186.425085993108;7198;1066.989330106689;1084.653842894663;1089.8201796703613;1173.096715529038;1230.138902768066;27589.31026724348;27843;28065.579016314772;28077.298067548476;28205.71794282072;974;995.66147509847;1057.006413970865;1069.3583849690124;1125.943702814856;15910.124943128008;15913.204339782964;16110.194490275439;16171.919140404223;16388.180590970405;443385;451737;452585;452695;453231;57550.71224643934;58414.41585584175;58508.41491585115;58676;58687.413125868195;1378.4899587152818;1396.7276381105587;1404.5294826233326;1405.5642750747506;1480.1267252321181;30765;30803.69196308098;30856;31710.524342135348;31790;50642;51175.48824511856;51239.23141152811;51276.74361628168;51548.71128221675;405187;407637;408082;409369;412215;28176.85911570429;28657.42685146244;29004.564931526467;29140.854295728386;29141.980030698825;47650.285245722036;47670.52329476661;48370.274445884046;48755.611994920626;48884.26673599828;40015.59984400119;40274.79862600668;40463.595364045985;41558.37662435006;41634.79182604067;39658;39912.80043599763;41036.1792764149;41195;41562.792186038874;41142.382864257655;41345;41607.37588936229;42241.36637950372;42317;33602.83198583991;35767.28465430625;35886.820565897004;36071.81964090268;36240.275194495436;28180.43639127247;28622;28970.7102928968;29037;29089.12732618025 22:26:31 INFO - PROCESS | 17734 | |2;jquery.html;359.577496441681;371.72863809419124;371.7917965939076;379.9487069245652;380.9866654667087;17438.2152803124;18764.812351876477;18802.435926922197;19775.30786422474;19905.104270307835;17202.311907523683;17326.740098898495;18396.816031839677;18683.346082887103;18724.251029958785;5500.28496295481;5643.435656434344;5663.207150998864;5668.858278543049;5692.203091567184;5359.330083739533;5605.887882242353;5608.2428872102155;5615.719214039282;5639.182318563806;5553.194786755938;5557.416471270519;5583.776648934058;5584.6090773645865;5593;6830.419414349786;7162.498625096271;7195.568265904062;7215.206327303992;7234.240404757504;6742.2920593337485;6949.826254343631;7050.788476345718;7064.858702825914;7077.893831592531;23541.17605883786;23542.64686029711;23835.523289534285;25051.498970020497;25065.248042558753;2355.328731311585;2401.2556107606524;2546.0834099724084;2663.7868970482314;2743.1770468859263;14993.775093373608;15659.2953317101;15756.133412662299;15792.526224213292;16150.030998140031;2063.2881655828714;2127.0640917996034;2137.5083730741862;2164;2212.3805334506364;89913.55043224742;94366;94938.52530737303;95086.52456737742;96024.06447841173;16063.714902807747;17020.31918723262;17259.827401726074;17355.30578776835;17441.825581744273;30823.537646935314;31060.534091988637;31344.05967820969;31446.685533144835;31583.21041973969;9564.61741530331;9796.510174491246;9841.409515428953;9870.210383169473;9903.25725570585;8088.11030786613;8254.174582541698;8273.793155171168;8301.584920753938;8551.187637174458;8619.224269815746;8632.611532481053;8673.869891951626;8677.739667809976;8722;3342.6462282775515;3366.5455163552606;3511.1924257420937;3524.964750352515;3591.2099338145567;877.140402405646;888.9199972002551;947.7583216279804;952.3809523809441;994.2841154368842;17516.64966700659;18245.63508729818;18251.087445627665;18546;18891.527711807314;966.8743063401854;974.7075877236942;975.1418751498636;980.3627642032736;993.9006099390148;10419.791604167875;10507.684769456775;10544.314619549705;10612;10618.787624247627;439913;440367;458973;462024;468069;63951;77997;80215.59892200501;85788.57105714432;89307;959.5921733263335;1019.7399663085865;1041.5313109100935;1042.0777611813598;1047.9056884880245;16605.66788664244;17165.313387464863;17204.741928871328;17208.655826883143;17313.220905059556;35182.64817351896;37059.25881482409;37308.25383492261;37730.490780369575;38141.23717525578;50882.74558627331;52149;52239.43281701555;52283;53461.200175907536;7762.5730584818375;7809.453338266494;7925.722599708983;7975.481593696391;8243.299319557906;8534.402591818513;11631.418429078682;11975;12336.444859981502;12417.875821242033;5622.690752008679;9427.82152230971;9630.229581633312;11050.613228536962;11425.37160456183;10643.893561064291;11217.71955701114;11443.14176436754;11524.308541487537;11655.825162622737;11270.154738394489;11773.17587768848;11835.585754498552;12019.939900300442;12131.393430328624;7671.808204794925;7700.229977002479;7817.5309481431295;7839.25527074927;7989.760307190793;10418.635347762793;11400.48697808584;11434.199606027498;11500.194986350874;11672.70818229551 22:26:31 INFO - PROCESS | 17734 | |3;mootools.html;1482.8961972661914;1510.2297828107664;1627.1538799824084;1740.834620711032;1775.0947017021315;7405.148407933089;7794.8441031179345;7968.601569921502;7981.481203721754;8110.513369197837;8038.196180381959;8073.878891816613;8094.595270236479;8120.066192387877;8120.350371970243;2227.13141874669;2264.67162261472;2265;2265.320403878838;2267.138487374795;2210.7678693737166;2240.529488807352;2245.5733410652006;2246.1127854497463;2247.359502541776;2200.460887082667;2208.9447763805874;2218.301235110943;2225.877576733279;2231.2748356784027;2168.1760930846176;2176.3035828534876;2184.650455927044;2188.321620297705;2190.1020581561484;2107.6311645462138;2131.25406107861;2133.45596872798;2136.102836808544;2141.1114387529155;8181.304589109933;8265.504069755774;8279.130691277449;8314.70898518555;8337;4749.691270067435;4887.828925987574;4899.412070551521;4906.435759887623;4906.460289368167;2972.405518896208;3147.8583463744185;3167.3506931079073;3176.857041433118;3180.0300908222985;1012.4735137728413;1019.3934608907688;1023.9744006399825;1046.4349251404233;1046.529061922138;10550.736231594195;10566.788664226673;10594.629187978384;10602.46987650622;10608.045275925204;4158.979205103955;4177.081042170778;4290.249206388932;4302.9569704303185;4501.729896206238;9147.588358523883;9179.495127767903;9201.631934722536;9226.26189904806;9233.769155771159;4967.105920934267;4988.127077761377;4994.275830004629;5008.874778130576;5028.723420211923;4097.610726980932;4598.655100867449;4606.746628935441;4609;4748.382710247645;3858.2476417098956;3893.7274390792372;3898.7660740355104;3955.9011024724614;3973.3642617181113;1257.352463481308;1290.6902343437507;1296.5202874936333;1299.4412402666944;1300.6163181861373;868.431177578687;942.7030485397215;951.6050838901916;961.4375590279765;969.5103972493987;5478.315210598676;5549.889002220014;5652.971735141298;5700.458456446631;5761.164631128463;970.5680971967407;984.6510280915192;985.9654912078042;998.5805961496189;1002.2082554781641;3718.4794128821986;3965.6827453804203;4004.7797371144866;4022.6982976276313;4032.0927791246736;9534.475603841855;9717.56270967808;9958.751031224278;9994.450305233282;10031.347962382422;9991.850122248172;10001.849972250422;10371.325863818978;10501.739791224949;10571;7565.659545320584;7566.31903128721;7578.280063394079;7667.731629392944;7720.691172353043;5886.58793884424;5954;5968.4926781224085;6023.759049637965;6055.697215139137;9592.520373981133;9597.184239339735;9633.421994680342;9777.657781977596;9780.902190977999;9682.128608425275;9757.512124393894;10021.749456263651;10057.597696092074;10163.085322321027;7228.241034691282;7487.438442116972;7517.1355294139685;7605.619719013916;7719.768406947801;8171.959140204261;8175.550344731097;8232.794180145544;8268.2558569729;8308.459950103224;7259.6007219603425;7429.4799364044;7549.50928189666;7661.425393095428;7699.153093159636;7344.30229128232;7431.4054875608745;7467.738629147953;7549.849003019799;7583.5070720403;6507.446867016357;6519.674016299071;6541.08424820516;6596.538242322991;6633.734650614115;4924.975375123101;4996.7001979881325;5082.237664350377;5119.360079990001;5128.410232823273;5130.384353877558;5157.896842063213;5217.34783152106;5218.08683480397;5236.266922630759 22:26:31 INFO - PROCESS | 17734 | |4;prototype.html;282.2037729849507;289.4861620623395;292.86967299551696;299.5820829942231;301.3054908436057;5913.526917846572;5994.340622531524;6000.459958603736;6086.269647642283;6159.8440545809;6058.212432383795;6089.5432842536875;6090.116933044706;6109.35851735568;6119.969400153004;4495.910081798362;4534.435619711195;4537.750423726686;4538.591526762591;4552.635789136861;4217.40956266123;4393.275109606911;4436.911261774762;4452.821887124527;4519.163954668397;4343.284402660947;4397.1205758848355;4399.406080179183;4410.117976404716;4414.668899832509;4350.673699472536;4379.233634114017;4396.098799746044;4402.097569998143;4413.713108647944;3653.0502069461863;3707.8331475083687;3711.554613446404;3721.6464435878547;3723.1809002019513;5731.283589551306;5731.742071606787;5761.971190144064;5775.653460792366;5800.187973683687;5045.949540504622;5050.2929589857085;5070.569001634865;5073.036123136592;5078.46676099008;6114.449699527064;6308;6312.305646378894;6316.652584107872;6317.557770956035;4058.269511487931;4060.512738471373;4085.8978525536804;4087.89780255493;4099.057216840114;6493.123428337209;6571.34286571339;6603.273639899608;6653.900191497131;6656.80029599108;4179.853705120307;4234.25900467417;4240.342746874239;4250.702450828474;4271.935920961126;4233.386159006926;4273.487181538173;4283.528811830696;4311.1377724454605;4314.180305741962;5075.22367171487;5086.847394578169;5124.205748109049;5124.718140502234;5127.923081153711;6233.750649974041;6242.344553821783;6292.087647291117;6351.872962540723;6439.9356006440275;1459.2703648175911;1462.429652435551;1471.5953112893826;1472.308015232839;1475.8783324673325;927.2489283680105;946.8532377481501;959.6593209410698;970.7621632700034;971.2666936463066;6142.170806941095;6143.262808462924;6143.262808463013;6150.7847225346895;6189.35011823761;6541.182352205974;6577.539572229898;6599.175103112111;6615.140031795932;6624.90062649051;5959.791407300723;6080.665563394055;6142.877142457215;6146.108814221912;6156.846078848064;3526.400511912981;3530.117470632342;3558.491263659114;3558.946615800765;3559.804210768381;6575.243846957565;6766.4248538874745;6785;6795.082663840319;6854.931450685429;6718.294579069225;6734.831629209309;6758.324167583202;6789;6792.184937807495;6555.934440655532;6753.7636182732385;6757.560758550679;6760.966195169091;6777.72889084441;6488.967555162194;6507.707153178024;6543.574667646588;6553.934460655523;6600.768973085919;6253.937460625336;6448.290688024407;6476.902846457401;6480.416762491398;6483.319251478715;6673.799786006233;6746.9325306746305;6747.527673062838;6757.493188010821;6780.38976492118;4209.052963083282;4239.915201696011;4242.363645453083;4242.957570424256;4246.978765106154;6351.2060992375955;6431.935680643133;6571.34286571339;6571.80284591463;6673.332666733288;6384.680765961776;6416.7754128605275;6427.517936154713;6473.2232132144445;6495.707693153725;6224;6477.352264773674;6491;6494.2856285807575;6504.804855854332;6270.435660790551;6308.526860485574;6345.8730825384155;6348.492120630431;6376.93623063782;6418.422341989243;6483.578567393104;6527.771527996687;6529.216494020748;6543.607383557001;6259.34276900937;6270.122182894307;6353.396427339396;6356.555041147075;6371.139896113966 22:26:31 INFO - PROCESS | 17734 | |5;yui.html;759.3279947246685;797.0395673213778;825.686239229093;852.9104444033376;857.5926434943402;12638.368081595918;12659.49362025519;12700.237985720853;12743;12745.681357966056;10982.890171098286;13623.591292261222;13681.863181368184;13704.45182192711;13720.245386503764;782.2295039386214;807.4872455990459;811.4401063266328;812.4110020235312;813.3046245460135;783.7922950418143;785.5247575216997;785.6071964017991;786.6735304848481;792.73839632921;838.8825564420986;842.3050982939069;846.9872951905726;847.2036285891243;850.37497439382;834.5535138700797;835.8495470815251;836.7155167243105;840.5419046619606;843.8312337532457;609.8841220168154;611.3336463255029;613.910982907476;614.4285814192799;615.5383462403198;14530.92734536331;14532.200728959902;14557.563273101823;14569.12585244878;14600.415983360654;13518.391672374668;13651.795223071662;13938.442462301497;13951.441942322397;14335;10794.434806952948;10829.133669306437;10861.239713220079;10904.291221070684;10989.780204395867;3777.9610607082996;3781;3861.942070868939;3945.2504024235304;3965.0285680008296;55174;55404;56338;56499.43500565024;56633.71683141599;11102.61140860066;11133.610323638633;11232.213745037769;11244.156688248415;11291.774164516664;20413.489662758253;20454.59090818175;20464.897675511525;20593.38219853407;20908.059137338856;8262.17378262169;8293.295069919004;8320.916790832136;8330.541820199947;8369.163083691583;4535.25168347219;4622.19111655459;4624.5375462453485;4647.442306923191;4772.976135119302;3074.969250307513;3112.9844350778103;3118;3138.1370123216298;3143.0413723814454;531.6491115863512;539.3393093460479;542.8995635807388;568.4116938968231;570.2216474512344;765.3265126688478;792.7225471085189;796.7888509544975;796.9641366138537;817.3747083481142;9400.623975041059;9428.528573571293;9542.379745316532;9704.854427183598;9757.756056098655;756.4477931110321;771.8842173673994;773.9961300193576;781.8436312737475;791.1179035375515;4397.516273209944;4577.679562430664;4676.789544470507;4689.413823272091;4701.506341834127;54367.45632543703;54413.45586544163;55385;55748;62971.37028629747;45875.541244587796;46260.5373946263;46543;47601.76199118982;47990.5200947993;45972.310415343796;46289.30566041512;46620.99999999932;47474;48691;8597.828043439222;8919.331050171133;9254.676086336945;9369.016253293306;9551.188149007134;28355.716442836132;28805.230770768434;29468.410631786814;29646.407071858874;30780.23049423782;38354.23291534098;38817.805910970266;38843.80578097091;39126.60873391343;43313.7834310839;12418.81371779442;12474.18917770342;12591.24452532851;12602.180858244184;12742.235465872078;13828.792568111687;13965;14031.438742450597;14272;14950.252487375805;13414.530491432753;13414.798778018143;13522.594322170351;13688.178709277476;13688.591512834346;13028;13046.478140874258;13077.280749558486;13454;13781.242031688353;13573.660658483617;13869.09850859691;14042.227677477837;14120.50578229757;14129;10966.451677416257;11105.666829995112;11219.158563107636;11333.26333788301;11646.126540509325;11260.774784504429;11372.260803047775;11423.200375973935;11424.543018279175;11458.4270786462 22:26:31 INFO - PROCESS | 17734 | __end_tp_report 22:26:31 INFO - PROCESS | 17734 | __start_cc_report 22:26:31 INFO - PROCESS | 17734 | _x_x_mozilla_cycle_collect,331 22:26:31 INFO - PROCESS | 17734 | __end_cc_report 22:26:31 INFO - PROCESS | 17734 | __startTimestamp1461216391961__endTimestamp 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | ------- Summary: start ------- 22:26:31 INFO - PROCESS | 17734 | Number of tests: 6 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#0] dojo.html Cycles:165 Average:5215.93 Median:5440.02 stddev:671.74 (12.3%) stddev-sans-first:652.17 22:26:31 INFO - PROCESS | 17734 | Values: 3060.7 3061.7 3114.7 3139.7 3141.8 5240.8 5282.4 5293.4 5313.7 5356.7 5206.5 5281.6 5314.5 5343.9 5390.6 4746.4 4778.8 4825.6 4853.4 4875.9 815.1 4838.8 4843.1 4889.6 4908.2 4831.9 4852.4 4868.2 4871.1 4908.7 4679.8 4920.2 4948.9 4963.5 4983.6 4762.7 4781.7 4799.2 4834.3 4843.5 5198.7 5210.8 5227.6 5229.5 5286.3 5599.6 5604.3 5608.1 5660.1 5719.0 5620.4 5666.2 5670.9 5679.5 5697.7 5223.1 5255.5 5268.3 5271.2 5337.9 5659.6 5776.3 5789.6 5856.8 5897.6 5507.5 5540.5 5540.6 5543.7 5543.8 5611.4 5617.4 5625.6 5627.9 5628.1 5517.8 5648.6 5677.6 5700.9 5707.6 5489.8 5586.5 5594.6 5628.4 5675.3 4274.0 4325.7 4329.7 4331.3 4361.4 3808.2 3814.0 3847.8 3883.0 3892.3 5380.5 5383.0 5389.7 5390.4 5395.1 5620.2 5641.8 5642.5 5645.9 5652.2 5263.8 5338.4 5368.4 5422.2 5440.0 4765.7 4783.4 4784.3 4785.2 4811.6 5626.7 5678.0 5688.8 5708.5 5740.4 5632.4 5657.3 5678.8 5705.5 5728.0 5711.5 5725.7 5727.5 5732.8 5739.6 5429.4 5501.4 5504.6 5505.4 5536.5 5673.9 5679.1 5687.5 5694.0 5741.9 5475.5 5518.6 5532.3 5533.1 5546.7 5390.3 5490.3 5506.7 5517.1 5569.6 5290.8 5372.3 5439.0 5442.8 5460.7 5460.1 5488.5 5518.1 5550.4 5557.8 5303.4 5384.9 5406.2 5408.7 5462.5 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#1] ext.html Cycles:180 Average:54623.69 Median:205852.26 stddev:101944.07 (49.5%) stddev-sans-first:102149.36 22:26:31 INFO - PROCESS | 17734 | Values: 601.4 629.0 640.1 646.0 653.3 38582.6 39207.6 39279.0 39360.2 39710.6 35624.6 35736.6 35902.6 35960.5 35961.1 8490.5 8732.9 8739.8 8856.2 8859.6 8591.5 8677.7 8711.2 8928.0 8939.8 8946.6 9004.8 9005.5 9005.7 9007.7 8844.9 8876.6 8941.9 8987.1 9003.8 8682.6 8871.5 8877.5 8886.4 8925.5 40929.4 41671.6 41730.0 41743.2 41830.6 2890.6 3239.0 3418.4 3434.2 3504.9 27570.3 27579.2 27794.3 27798.3 27856.3 4035.0 4067.5 4121.3 4183.4 4384.5 275301.0 276503.0 277151.0 277454.0 277671.0 59952.0 60132.4 60153.4 60166.3 60168.1 63248.0 65187.7 65246.3 65544.0 65771.3 16367.4 16590.0 16617.8 16725.7 16746.4 12261.2 12400.4 12466.4 12478.3 12497.5 18930.2 19107.6 19137.9 20106.0 20148.4 6773.4 7162.1 7182.0 7186.4 7198.0 1067.0 1084.7 1089.8 1173.1 1230.1 27589.3 27843.0 28065.6 28077.3 28205.7 974.0 995.7 1057.0 1069.4 1125.9 15910.1 15913.2 16110.2 16171.9 16388.2 443385.0 451737.0 452585.0 452695.0 453231.0 57550.7 58414.4 58508.4 58676.0 58687.4 1378.5 1396.7 1404.5 1405.6 1480.1 30765.0 30803.7 30856.0 31710.5 31790.0 50642.0 51175.5 51239.2 51276.7 51548.7 405187.0 407637.0 408082.0 409369.0 412215.0 28176.9 28657.4 29004.6 29140.9 29142.0 47650.3 47670.5 48370.3 48755.6 48884.3 40015.6 40274.8 40463.6 41558.4 41634.8 39658.0 39912.8 41036.2 41195.0 41562.8 41142.4 41345.0 41607.4 42241.4 42317.0 33602.8 35767.3 35886.8 36071.8 36240.3 28180.4 28622.0 28970.7 29037.0 29089.1 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#2] jquery.html Cycles:180 Average:28549.98 Median:37519.37 stddev:74903.69 (199.6%) stddev-sans-first:75083.91 22:26:31 INFO - PROCESS | 17734 | Values: 359.6 371.7 371.8 379.9 381.0 17438.2 18764.8 18802.4 19775.3 19905.1 17202.3 17326.7 18396.8 18683.3 18724.3 5500.3 5643.4 5663.2 5668.9 5692.2 5359.3 5605.9 5608.2 5615.7 5639.2 5553.2 5557.4 5583.8 5584.6 5593.0 6830.4 7162.5 7195.6 7215.2 7234.2 6742.3 6949.8 7050.8 7064.9 7077.9 23541.2 23542.6 23835.5 25051.5 25065.2 2355.3 2401.3 2546.1 2663.8 2743.2 14993.8 15659.3 15756.1 15792.5 16150.0 2063.3 2127.1 2137.5 2164.0 2212.4 89913.6 94366.0 94938.5 95086.5 96024.1 16063.7 17020.3 17259.8 17355.3 17441.8 30823.5 31060.5 31344.1 31446.7 31583.2 9564.6 9796.5 9841.4 9870.2 9903.3 8088.1 8254.2 8273.8 8301.6 8551.2 8619.2 8632.6 8673.9 8677.7 8722.0 3342.6 3366.5 3511.2 3525.0 3591.2 877.1 888.9 947.8 952.4 994.3 17516.6 18245.6 18251.1 18546.0 18891.5 966.9 974.7 975.1 980.4 993.9 10419.8 10507.7 10544.3 10612.0 10618.8 439913.0 440367.0 458973.0 462024.0 468069.0 63951.0 77997.0 80215.6 85788.6 89307.0 959.6 1019.7 1041.5 1042.1 1047.9 16605.7 17165.3 17204.7 17208.7 17313.2 35182.6 37059.3 37308.3 37730.5 38141.2 50882.7 52149.0 52239.4 52283.0 53461.2 7762.6 7809.5 7925.7 7975.5 8243.3 8534.4 11631.4 11975.0 12336.4 12417.9 5622.7 9427.8 9630.2 11050.6 11425.4 10643.9 11217.7 11443.1 11524.3 11655.8 11270.2 11773.2 11835.6 12019.9 12131.4 7671.8 7700.2 7817.5 7839.3 7989.8 10418.6 11400.5 11434.2 11500.2 11672.7 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#3] mootools.html Cycles:180 Average:5474.72 Median:5055.48 stddev:3018.60 (59.7%) stddev-sans-first:3012.16 22:26:31 INFO - PROCESS | 17734 | Values: 1482.9 1510.2 1627.2 1740.8 1775.1 7405.1 7794.8 7968.6 7981.5 8110.5 8038.2 8073.9 8094.6 8120.1 8120.4 2227.1 2264.7 2265.0 2265.3 2267.1 2210.8 2240.5 2245.6 2246.1 2247.4 2200.5 2208.9 2218.3 2225.9 2231.3 2168.2 2176.3 2184.7 2188.3 2190.1 2107.6 2131.3 2133.5 2136.1 2141.1 8181.3 8265.5 8279.1 8314.7 8337.0 4749.7 4887.8 4899.4 4906.4 4906.5 2972.4 3147.9 3167.4 3176.9 3180.0 1012.5 1019.4 1024.0 1046.4 1046.5 10550.7 10566.8 10594.6 10602.5 10608.0 4159.0 4177.1 4290.2 4303.0 4501.7 9147.6 9179.5 9201.6 9226.3 9233.8 4967.1 4988.1 4994.3 5008.9 5028.7 4097.6 4598.7 4606.7 4609.0 4748.4 3858.2 3893.7 3898.8 3955.9 3973.4 1257.4 1290.7 1296.5 1299.4 1300.6 868.4 942.7 951.6 961.4 969.5 5478.3 5549.9 5653.0 5700.5 5761.2 970.6 984.7 986.0 998.6 1002.2 3718.5 3965.7 4004.8 4022.7 4032.1 9534.5 9717.6 9958.8 9994.5 10031.3 9991.9 10001.8 10371.3 10501.7 10571.0 7565.7 7566.3 7578.3 7667.7 7720.7 5886.6 5954.0 5968.5 6023.8 6055.7 9592.5 9597.2 9633.4 9777.7 9780.9 9682.1 9757.5 10021.7 10057.6 10163.1 7228.2 7487.4 7517.1 7605.6 7719.8 8172.0 8175.6 8232.8 8268.3 8308.5 7259.6 7429.5 7549.5 7661.4 7699.2 7344.3 7431.4 7467.7 7549.8 7583.5 6507.4 6519.7 6541.1 6596.5 6633.7 4925.0 4996.7 5082.2 5119.4 5128.4 5130.4 5157.9 5217.3 5218.1 5236.3 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#4] prototype.html Cycles:180 Average:5252.54 Median:6144.69 stddev:1663.34 (27.1%) stddev-sans-first:1625.63 22:26:31 INFO - PROCESS | 17734 | Values: 282.2 289.5 292.9 299.6 301.3 5913.5 5994.3 6000.5 6086.3 6159.8 6058.2 6089.5 6090.1 6109.4 6120.0 4495.9 4534.4 4537.8 4538.6 4552.6 4217.4 4393.3 4436.9 4452.8 4519.2 4343.3 4397.1 4399.4 4410.1 4414.7 4350.7 4379.2 4396.1 4402.1 4413.7 3653.1 3707.8 3711.6 3721.6 3723.2 5731.3 5731.7 5762.0 5775.7 5800.2 5045.9 5050.3 5070.6 5073.0 5078.5 6114.4 6308.0 6312.3 6316.7 6317.6 4058.3 4060.5 4085.9 4087.9 4099.1 6493.1 6571.3 6603.3 6653.9 6656.8 4179.9 4234.3 4240.3 4250.7 4271.9 4233.4 4273.5 4283.5 4311.1 4314.2 5075.2 5086.8 5124.2 5124.7 5127.9 6233.8 6242.3 6292.1 6351.9 6439.9 1459.3 1462.4 1471.6 1472.3 1475.9 927.2 946.9 959.7 970.8 971.3 6142.2 6143.3 6143.3 6150.8 6189.4 6541.2 6577.5 6599.2 6615.1 6624.9 5959.8 6080.7 6142.9 6146.1 6156.8 3526.4 3530.1 3558.5 3558.9 3559.8 6575.2 6766.4 6785.0 6795.1 6854.9 6718.3 6734.8 6758.3 6789.0 6792.2 6555.9 6753.8 6757.6 6761.0 6777.7 6489.0 6507.7 6543.6 6553.9 6600.8 6253.9 6448.3 6476.9 6480.4 6483.3 6673.8 6746.9 6747.5 6757.5 6780.4 4209.1 4239.9 4242.4 4243.0 4247.0 6351.2 6431.9 6571.3 6571.8 6673.3 6384.7 6416.8 6427.5 6473.2 6495.7 6224.0 6477.4 6491.0 6494.3 6504.8 6270.4 6308.5 6345.9 6348.5 6376.9 6418.4 6483.6 6527.8 6529.2 6543.6 6259.3 6270.1 6353.4 6356.6 6371.1 22:26:31 INFO - PROCESS | 17734 | 22:26:31 INFO - PROCESS | 17734 | [#5] yui.html Cycles:180 Average:14242.80 Median:4466.38 stddev:15670.98 (350.9%) stddev-sans-first:15682.22 22:26:31 INFO - PROCESS | 17734 | Values: 759.3 797.0 825.7 852.9 857.6 12638.4 12659.5 12700.2 12743.0 12745.7 10982.9 13623.6 13681.9 13704.5 13720.2 782.2 807.5 811.4 812.4 813.3 783.8 785.5 785.6 786.7 792.7 838.9 842.3 847.0 847.2 850.4 834.6 835.8 836.7 840.5 843.8 609.9 611.3 613.9 614.4 615.5 14530.9 14532.2 14557.6 14569.1 14600.4 13518.4 13651.8 13938.4 13951.4 14335.0 10794.4 10829.1 10861.2 10904.3 10989.8 3778.0 3781.0 3861.9 3945.3 3965.0 55174.0 55404.0 56338.0 56499.4 56633.7 11102.6 11133.6 11232.2 11244.2 11291.8 20413.5 20454.6 20464.9 20593.4 20908.1 8262.2 8293.3 8320.9 8330.5 8369.2 4535.3 4622.2 4624.5 4647.4 4773.0 3075.0 3113.0 3118.0 3138.1 3143.0 531.6 539.3 542.9 568.4 570.2 765.3 792.7 796.8 797.0 817.4 9400.6 9428.5 9542.4 9704.9 9757.8 756.4 771.9 774.0 781.8 791.1 4397.5 4577.7 4676.8 4689.4 4701.5 54367.5 54413.5 55385.0 55748.0 62971.4 45875.5 46260.5 46543.0 47601.8 47990.5 45972.3 46289.3 46621.0 47474.0 48691.0 8597.8 8919.3 9254.7 9369.0 9551.2 28355.7 28805.2 29468.4 29646.4 30780.2 38354.2 38817.8 38843.8 39126.6 43313.8 12418.8 12474.2 12591.2 12602.2 12742.2 13828.8 13965.0 14031.4 14272.0 14950.3 13414.5 13414.8 13522.6 13688.2 13688.6 13028.0 13046.5 13077.3 13454.0 13781.2 13573.7 13869.1 14042.2 14120.5 14129.0 10966.5 11105.7 11219.2 11333.3 11646.1 11260.8 11372.3 11423.2 11424.5 11458.4 22:26:31 INFO - PROCESS | 17734 | -------- Summary: end -------- 22:26:31 INFO - PROCESS | 17734 | 22:26:32 INFO - TEST-INFO | 17734: exit 0 22:26:32 INFO - TEST-OK | dromaeo_css | took 1109296ms 22:26:32 INFO - TEST-START | kraken 22:26:32 INFO - operating with platform_type : linux_ 22:26:32 INFO - Initialising browser for kraken test... 22:26:32 INFO - TEST-INFO | started process 17972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UvsJb/profile http://localhost:53586/getInfo.html) 22:26:36 INFO - PROCESS | 17972 | 22:26:36 INFO - PROCESS | 17972 | (process:18042): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:36 INFO - PROCESS | 17972 | __metrics Screen width/height:1600/1200 22:26:36 INFO - PROCESS | 17972 | colorDepth:24 22:26:36 INFO - PROCESS | 17972 | Browser inner width/height: 1024/697 22:26:36 INFO - PROCESS | 17972 | __metrics 22:26:37 ERROR - PROCESS | 17972 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:26:38 INFO - TEST-INFO | 17972: exit 0 22:26:38 INFO - Browser initialized. 22:26:38 INFO - Running cycle 1/1 for kraken test... 22:26:38 INFO - TEST-INFO | started process 18093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6UvsJb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:40 INFO - PROCESS | 18093 | 22:26:40 INFO - PROCESS | 18093 | (process:18153): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:50 INFO - PROCESS | 18093 | RSS: Main: 163532800 22:26:50 INFO - PROCESS | 18093 | 22:26:52 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53586/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:53 INFO - PROCESS | 18093 | RSS: Main: 168103936 22:26:53 INFO - PROCESS | 18093 | 22:26:56 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53586/tests/kraken/driver.html?testName=audio-dft) 22:26:56 INFO - PROCESS | 18093 | RSS: Main: 171507712 22:26:56 INFO - PROCESS | 18093 | 22:26:59 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53586/tests/kraken/driver.html?testName=audio-fft) 22:27:00 INFO - PROCESS | 18093 | RSS: Main: 163672064 22:27:00 INFO - PROCESS | 18093 | 22:27:02 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53586/tests/kraken/driver.html?testName=audio-oscillator) 22:27:03 INFO - PROCESS | 18093 | RSS: Main: 164134912 22:27:03 INFO - PROCESS | 18093 | 22:27:05 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:05 INFO - PROCESS | 18093 | RSS: Main: 164700160 22:27:05 INFO - PROCESS | 18093 | 22:27:09 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53586/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:09 INFO - PROCESS | 18093 | RSS: Main: 165142528 22:27:09 INFO - PROCESS | 18093 | 22:27:13 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53586/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:13 INFO - PROCESS | 18093 | RSS: Main: 164892672 22:27:13 INFO - PROCESS | 18093 | 22:27:16 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53586/tests/kraken/driver.html?testName=json-parse-financial) 22:27:17 INFO - PROCESS | 18093 | RSS: Main: 164745216 22:27:17 INFO - PROCESS | 18093 | 22:27:18 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:19 INFO - PROCESS | 18093 | RSS: Main: 164978688 22:27:19 INFO - PROCESS | 18093 | 22:27:21 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:21 INFO - PROCESS | 18093 | RSS: Main: 165294080 22:27:21 INFO - PROCESS | 18093 | 22:27:23 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:24 INFO - PROCESS | 18093 | RSS: Main: 165609472 22:27:24 INFO - PROCESS | 18093 | 22:27:27 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:27 INFO - PROCESS | 18093 | RSS: Main: 166322176 22:27:27 INFO - PROCESS | 18093 | 22:27:30 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:31 INFO - PROCESS | 18093 | RSS: Main: 165900288 22:27:31 INFO - PROCESS | 18093 | 22:27:32 INFO - PROCESS | 18093 | Cycle 1(1): loaded http://localhost:53586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53586/tests/kraken/driver.html?testName=ai-astar) 22:27:33 INFO - PROCESS | 18093 | RSS: Main: 167383040 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | __start_tp_report 22:27:33 INFO - PROCESS | 18093 | _x_x_mozilla_page_load 22:27:33 INFO - PROCESS | 18093 | _x_x_mozilla_page_load_details 22:27:33 INFO - PROCESS | 18093 | |i|pagename|runs| 22:27:33 INFO - PROCESS | 18093 | |0;ai-astar;111;107;113;112;111;124;112;116;112;115 22:27:33 INFO - PROCESS | 18093 | |1;audio-beat-detection;166;127;153;181;129;160;158;130;183;129 22:27:33 INFO - PROCESS | 18093 | |2;audio-dft;162;164;162;167;161;165;166;162;164;162 22:27:33 INFO - PROCESS | 18093 | |3;audio-fft;75;77;76;163;77;77;77;77;151;77 22:27:33 INFO - PROCESS | 18093 | |4;audio-oscillator;93;92;151;92;93;93;138;92;93;143 22:27:33 INFO - PROCESS | 18093 | |5;imaging-gaussian-blur;118;117;118;117;118;117;119;119;118;118 22:27:33 INFO - PROCESS | 18093 | |6;imaging-darkroom;147;148;146;146;147;146;149;150;147;146 22:27:33 INFO - PROCESS | 18093 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;95;95 22:27:33 INFO - PROCESS | 18093 | |8;json-parse-financial;56;57;57;58;56;57;58;74;54;56 22:27:33 INFO - PROCESS | 18093 | |9;json-stringify-tinderbox;61;61;62;62;62;60;60;61;62;62 22:27:33 INFO - PROCESS | 18093 | |10;stanford-crypto-aes;77;76;77;78;78;77;86;77;79;79 22:27:33 INFO - PROCESS | 18093 | |11;stanford-crypto-ccm;130;128;135;124;135;124;131;136;159;132 22:27:33 INFO - PROCESS | 18093 | |12;stanford-crypto-pbkdf2;169;178;169;170;173;164;170;166;169;170 22:27:33 INFO - PROCESS | 18093 | |13;stanford-crypto-sha256-iterative;68;70;67;70;83;70;68;67;69;70 22:27:33 INFO - PROCESS | 18093 | __end_tp_report 22:27:33 INFO - PROCESS | 18093 | __start_cc_report 22:27:33 INFO - PROCESS | 18093 | _x_x_mozilla_cycle_collect,818 22:27:33 INFO - PROCESS | 18093 | __end_cc_report 22:27:33 INFO - PROCESS | 18093 | __startTimestamp1461216453090__endTimestamp 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | ------- Summary: start ------- 22:27:33 INFO - PROCESS | 18093 | Number of tests: 14 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.50 stddev:4.47 (4.0%) stddev-sans-first:4.67 22:27:33 INFO - PROCESS | 18093 | Values: 111.0 107.0 113.0 112.0 111.0 124.0 112.0 116.0 112.0 115.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.00 stddev:21.77 (13.7%) stddev-sans-first:22.46 22:27:33 INFO - PROCESS | 18093 | Values: 166.0 127.0 153.0 181.0 129.0 160.0 158.0 130.0 183.0 129.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.01 (1.2%) stddev-sans-first:2.06 22:27:33 INFO - PROCESS | 18093 | Values: 162.0 164.0 162.0 167.0 161.0 165.0 166.0 162.0 164.0 162.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#3] audio-fft Cycles:10 Average:92.70 Median:77.00 stddev:34.01 (44.2%) stddev-sans-first:35.47 22:27:33 INFO - PROCESS | 18093 | Values: 75.0 77.0 76.0 163.0 77.0 77.0 77.0 77.0 151.0 77.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.50 stddev:25.04 (27.1%) stddev-sans-first:25.96 22:27:33 INFO - PROCESS | 18093 | Values: 93.0 92.0 151.0 92.0 93.0 93.0 138.0 92.0 93.0 143.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 22:27:33 INFO - PROCESS | 18093 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 119.0 119.0 118.0 118.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.40 (1.0%) stddev-sans-first:1.48 22:27:33 INFO - PROCESS | 18093 | Values: 147.0 148.0 146.0 146.0 147.0 146.0 149.0 150.0 147.0 146.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:27:33 INFO - PROCESS | 18093 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:5.64 (9.9%) stddev-sans-first:5.92 22:27:33 INFO - PROCESS | 18093 | Values: 56.0 57.0 57.0 58.0 56.0 57.0 58.0 74.0 54.0 56.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 22:27:33 INFO - PROCESS | 18093 | Values: 61.0 61.0 62.0 62.0 62.0 60.0 60.0 61.0 62.0 62.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.84 (3.6%) stddev-sans-first:2.96 22:27:33 INFO - PROCESS | 18093 | Values: 77.0 76.0 77.0 78.0 78.0 77.0 86.0 77.0 79.0 79.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:133.50 stddev:9.96 (7.5%) stddev-sans-first:10.49 22:27:33 INFO - PROCESS | 18093 | Values: 130.0 128.0 135.0 124.0 135.0 124.0 131.0 136.0 159.0 132.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.00 stddev:3.77 (2.2%) stddev-sans-first:3.98 22:27:33 INFO - PROCESS | 18093 | Values: 169.0 178.0 169.0 170.0 173.0 164.0 170.0 166.0 169.0 170.0 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - PROCESS | 18093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:4.66 (6.7%) stddev-sans-first:4.88 22:27:33 INFO - PROCESS | 18093 | Values: 68.0 70.0 67.0 70.0 83.0 70.0 68.0 67.0 69.0 70.0 22:27:33 INFO - PROCESS | 18093 | -------- Summary: end -------- 22:27:33 INFO - PROCESS | 18093 | 22:27:33 INFO - TEST-INFO | 18093: exit 0 22:27:34 INFO - TEST-OK | kraken | took 61366ms 22:27:34 INFO - SUITE-END | took 1170s 22:27:34 INFO - Completed test suite (00:19:30) 22:27:34 INFO - javascript benchmark 22:27:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.6633270340258, 3061.693830616938, 3114.6573876873526, 3139.6546379898223, 3141.842907854607, 5240.790368385269, 5282.418933917271, 5293.444188360225, 5313.681179129255, 5356.651817631851, 5206.531412172903, 5281.577473802096, 5314.468553144693, 5343.919841202375, 5390.649607775492, 4746.359241502405, 4778.761061946889, 4825.613950883921, 4853.417589889218, 4875.8537243882565, 815.1199648593786, 4838.782254798525, 4843.128236917353, 4889.559939605435, 4908.214685650297, 4831.9275210871865, 4852.369192005052, 4868.245421959602, 4871.147549178897, 4908.7300198489065, 4679.81280748773, 4920.188168952119, 4948.851534453972, 4963.45402005779, 4983.601311895076, 4762.738049407281, 4781.737004464753, 4799.18413869643, 4834.250691142844, 4843.4914333994775, 5198.740062996872, 5210.843674689765, 5227.555657769094, 5229.529342359206, 5286.259923610698, 5599.580031497654, 5604.327480702342, 5608.130739735348, 5660.066089095294, 5718.971405142947, 5620.409856965041, 5666.178404131378, 5670.914936275959, 5679.460451257124, 5697.715114244313, 5223.059849227137, 5255.527002569787, 5268.262443257947, 5271.235670827708, 5337.919931200996, 5659.5755318351285, 5776.33572139201, 5789.594728369058, 5856.765729370777, 5897.587168898136, 5507.476789704971, 5540.501354878, 5540.584456165804, 5543.722813859291, 5543.750531226024, 5611.354694210218, 5617.438256174431, 5625.606207565513, 5627.8593035174445, 5628.099504079328, 5517.751701173457, 5648.604597678205, 5677.574181936288, 5700.8859822803315, 5707.629004114802, 5489.807856724996, 5586.497215250647, 5594.552435805126, 5628.380878103405, 5675.31896172462, 4274.0, 4325.718828276152, 4329.6536277098385, 4331.285337919271, 4361.433013708261, 3808.2383523294898, 3814.0, 3847.788371639587, 3883.0, 3892.2993861105274, 5380.515753582118, 5383.031054410244, 5389.676619402849, 5390.380106287748, 5395.109806881899, 5620.213170156181, 5641.774329026793, 5642.548596112301, 5645.887082258332, 5652.236948012048, 5263.7894484220205, 5338.439463856317, 5368.3826359968325, 5422.15956526739, 5440.020796256633, 4765.666403351732, 4783.425988881357, 4784.30627559002, 4785.1625965455905, 4811.566958973709, 5626.718664066781, 5678.034734095214, 5688.800891968844, 5708.457696518824, 5740.397258287903, 5632.436756324417, 5657.2928383952, 5678.829635110953, 5705.457981491834, 5728.0262355398845, 5711.485966263056, 5725.656460612377, 5727.455891690282, 5732.799352022659, 5739.62692424991, 5429.375621803543, 5501.3948465667945, 5504.614676972574, 5505.421930697379, 5536.52939500147, 5673.886522269614, 5679.119736440858, 5687.516561092188, 5693.971530142323, 5741.856453588526, 5475.452454754652, 5518.558515318845, 5532.30846144232, 5533.059379905506, 5546.667199968015, 5390.27231323782, 5490.286262785812, 5506.697131657797, 5517.124516566377, 5569.610127291051, 5290.814821481384, 5372.301600791872, 5438.972805136107, 5442.755076021509, 5460.726963651881, 5460.099083651153, 5488.506034456918, 5518.144687573433, 5550.38945715979, 5557.833265002057, 5303.416624171261, 5384.865378365572, 5406.216098665593, 5408.72956352173, 5462.535684466865], "value": 5174.009745924024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4136217188242, 628.9905651415227, 640.103854603555, 645.9741610335584, 653.333599728277, 38582.61417385825, 39207.607923920754, 39279.0, 39360.21279574407, 39710.60289397105, 35624.64375356246, 35736.642633573654, 35902.640973590256, 35960.46059309113, 35961.1009724757, 8490.490570565771, 8732.8690069649, 8739.781505462382, 8856.202941735242, 8859.645614175457, 8591.527465989368, 8677.739667809945, 8711.215990560848, 8928.0, 8939.77650558738, 8946.597403116875, 9004.774880628003, 9005.459672419676, 9005.729828105135, 9007.729768106967, 8844.911550884473, 8876.600552975067, 8941.865872011926, 8987.056359082268, 9003.774905627346, 8682.565871706389, 8871.467711937305, 8877.51173685447, 8886.422382545114, 8925.464472131693, 40929.38605920914, 41671.58328416707, 41730.0, 41743.1651366974, 41830.581694182976, 2890.5519644455144, 3239.0, 3418.4017796885696, 3434.1586311353876, 3504.8773292934625, 27570.310742231402, 27579.172624821087, 27794.3051423714, 27798.3050423739, 27856.30359241015, 4034.979825100885, 4067.51189857219, 4121.278776214151, 4183.393407955859, 4384.517703052694, 275301.0, 276503.0, 277151.0, 277454.0, 277671.0, 59952.0, 60132.39867601268, 60153.398466014776, 60166.28420300064, 60168.08907421004, 63248.0, 65187.674061630336, 65246.34753652403, 65544.0, 65771.34228657748, 16367.427140050278, 16590.0, 16617.750733739005, 16725.6654866902, 16746.4138755143, 12261.203021803554, 12400.441980110916, 12466.376681165906, 12478.313692746804, 12497.500099995897, 18930.242790288234, 19107.617847643247, 19137.90431047836, 20106.0, 20148.39554813358, 6773.390394864387, 7162.140543134858, 7181.964090179516, 7186.425085993108, 7198.0, 1066.989330106689, 1084.653842894663, 1089.8201796703613, 1173.096715529038, 1230.138902768066, 27589.31026724348, 27843.0, 28065.579016314772, 28077.298067548476, 28205.71794282072, 974.0, 995.66147509847, 1057.006413970865, 1069.3583849690124, 1125.943702814856, 15910.124943128008, 15913.204339782964, 16110.194490275439, 16171.919140404223, 16388.180590970405, 443385.0, 451737.0, 452585.0, 452695.0, 453231.0, 57550.71224643934, 58414.41585584175, 58508.41491585115, 58676.0, 58687.413125868195, 1378.4899587152818, 1396.7276381105587, 1404.5294826233326, 1405.5642750747506, 1480.1267252321181, 30765.0, 30803.69196308098, 30856.0, 31710.524342135348, 31790.0, 50642.0, 51175.48824511856, 51239.23141152811, 51276.74361628168, 51548.71128221675, 405187.0, 407637.0, 408082.0, 409369.0, 412215.0, 28176.85911570429, 28657.42685146244, 29004.564931526467, 29140.854295728386, 29141.980030698825, 47650.285245722036, 47670.52329476661, 48370.274445884046, 48755.611994920626, 48884.26673599828, 40015.59984400119, 40274.79862600668, 40463.595364045985, 41558.37662435006, 41634.79182604067, 39658.0, 39912.80043599763, 41036.1792764149, 41195.0, 41562.792186038874, 41142.382864257655, 41345.0, 41607.37588936229, 42241.36637950372, 42317.0, 33602.83198583991, 35767.28465430625, 35886.820565897004, 36071.81964090268, 36240.275194495436, 28180.43639127247, 28622.0, 28970.7102928968, 29037.0, 29089.12732618025], "value": 19546.72890693056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.577496441681, 371.72863809419124, 371.7917965939076, 379.9487069245652, 380.9866654667087, 17438.2152803124, 18764.812351876477, 18802.435926922197, 19775.30786422474, 19905.104270307835, 17202.311907523683, 17326.740098898495, 18396.816031839677, 18683.346082887103, 18724.251029958785, 5500.28496295481, 5643.435656434344, 5663.207150998864, 5668.858278543049, 5692.203091567184, 5359.330083739533, 5605.887882242353, 5608.2428872102155, 5615.719214039282, 5639.182318563806, 5553.194786755938, 5557.416471270519, 5583.776648934058, 5584.6090773645865, 5593.0, 6830.419414349786, 7162.498625096271, 7195.568265904062, 7215.206327303992, 7234.240404757504, 6742.2920593337485, 6949.826254343631, 7050.788476345718, 7064.858702825914, 7077.893831592531, 23541.17605883786, 23542.64686029711, 23835.523289534285, 25051.498970020497, 25065.248042558753, 2355.328731311585, 2401.2556107606524, 2546.0834099724084, 2663.7868970482314, 2743.1770468859263, 14993.775093373608, 15659.2953317101, 15756.133412662299, 15792.526224213292, 16150.030998140031, 2063.2881655828714, 2127.0640917996034, 2137.5083730741862, 2164.0, 2212.3805334506364, 89913.55043224742, 94366.0, 94938.52530737303, 95086.52456737742, 96024.06447841173, 16063.714902807747, 17020.31918723262, 17259.827401726074, 17355.30578776835, 17441.825581744273, 30823.537646935314, 31060.534091988637, 31344.05967820969, 31446.685533144835, 31583.21041973969, 9564.61741530331, 9796.510174491246, 9841.409515428953, 9870.210383169473, 9903.25725570585, 8088.11030786613, 8254.174582541698, 8273.793155171168, 8301.584920753938, 8551.187637174458, 8619.224269815746, 8632.611532481053, 8673.869891951626, 8677.739667809976, 8722.0, 3342.6462282775515, 3366.5455163552606, 3511.1924257420937, 3524.964750352515, 3591.2099338145567, 877.140402405646, 888.9199972002551, 947.7583216279804, 952.3809523809441, 994.2841154368842, 17516.64966700659, 18245.63508729818, 18251.087445627665, 18546.0, 18891.527711807314, 966.8743063401854, 974.7075877236942, 975.1418751498636, 980.3627642032736, 993.9006099390148, 10419.791604167875, 10507.684769456775, 10544.314619549705, 10612.0, 10618.787624247627, 439913.0, 440367.0, 458973.0, 462024.0, 468069.0, 63951.0, 77997.0, 80215.59892200501, 85788.57105714432, 89307.0, 959.5921733263335, 1019.7399663085865, 1041.5313109100935, 1042.0777611813598, 1047.9056884880245, 16605.66788664244, 17165.313387464863, 17204.741928871328, 17208.655826883143, 17313.220905059556, 35182.64817351896, 37059.25881482409, 37308.25383492261, 37730.490780369575, 38141.23717525578, 50882.74558627331, 52149.0, 52239.43281701555, 52283.0, 53461.200175907536, 7762.5730584818375, 7809.453338266494, 7925.722599708983, 7975.481593696391, 8243.299319557906, 8534.402591818513, 11631.418429078682, 11975.0, 12336.444859981502, 12417.875821242033, 5622.690752008679, 9427.82152230971, 9630.229581633312, 11050.613228536962, 11425.37160456183, 10643.893561064291, 11217.71955701114, 11443.14176436754, 11524.308541487537, 11655.825162622737, 11270.154738394489, 11773.17587768848, 11835.585754498552, 12019.939900300442, 12131.393430328624, 7671.808204794925, 7700.229977002479, 7817.5309481431295, 7839.25527074927, 7989.760307190793, 10418.635347762793, 11400.48697808584, 11434.199606027498, 11500.194986350874, 11672.70818229551], "value": 9860.906148818307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.8961972661914, 1510.2297828107664, 1627.1538799824084, 1740.834620711032, 1775.0947017021315, 7405.148407933089, 7794.8441031179345, 7968.601569921502, 7981.481203721754, 8110.513369197837, 8038.196180381959, 8073.878891816613, 8094.595270236479, 8120.066192387877, 8120.350371970243, 2227.13141874669, 2264.67162261472, 2265.0, 2265.320403878838, 2267.138487374795, 2210.7678693737166, 2240.529488807352, 2245.5733410652006, 2246.1127854497463, 2247.359502541776, 2200.460887082667, 2208.9447763805874, 2218.301235110943, 2225.877576733279, 2231.2748356784027, 2168.1760930846176, 2176.3035828534876, 2184.650455927044, 2188.321620297705, 2190.1020581561484, 2107.6311645462138, 2131.25406107861, 2133.45596872798, 2136.102836808544, 2141.1114387529155, 8181.304589109933, 8265.504069755774, 8279.130691277449, 8314.70898518555, 8337.0, 4749.691270067435, 4887.828925987574, 4899.412070551521, 4906.435759887623, 4906.460289368167, 2972.405518896208, 3147.8583463744185, 3167.3506931079073, 3176.857041433118, 3180.0300908222985, 1012.4735137728413, 1019.3934608907688, 1023.9744006399825, 1046.4349251404233, 1046.529061922138, 10550.736231594195, 10566.788664226673, 10594.629187978384, 10602.46987650622, 10608.045275925204, 4158.979205103955, 4177.081042170778, 4290.249206388932, 4302.9569704303185, 4501.729896206238, 9147.588358523883, 9179.495127767903, 9201.631934722536, 9226.26189904806, 9233.769155771159, 4967.105920934267, 4988.127077761377, 4994.275830004629, 5008.874778130576, 5028.723420211923, 4097.610726980932, 4598.655100867449, 4606.746628935441, 4609.0, 4748.382710247645, 3858.2476417098956, 3893.7274390792372, 3898.7660740355104, 3955.9011024724614, 3973.3642617181113, 1257.352463481308, 1290.6902343437507, 1296.5202874936333, 1299.4412402666944, 1300.6163181861373, 868.431177578687, 942.7030485397215, 951.6050838901916, 961.4375590279765, 969.5103972493987, 5478.315210598676, 5549.889002220014, 5652.971735141298, 5700.458456446631, 5761.164631128463, 970.5680971967407, 984.6510280915192, 985.9654912078042, 998.5805961496189, 1002.2082554781641, 3718.4794128821986, 3965.6827453804203, 4004.7797371144866, 4022.6982976276313, 4032.0927791246736, 9534.475603841855, 9717.56270967808, 9958.751031224278, 9994.450305233282, 10031.347962382422, 9991.850122248172, 10001.849972250422, 10371.325863818978, 10501.739791224949, 10571.0, 7565.659545320584, 7566.31903128721, 7578.280063394079, 7667.731629392944, 7720.691172353043, 5886.58793884424, 5954.0, 5968.4926781224085, 6023.759049637965, 6055.697215139137, 9592.520373981133, 9597.184239339735, 9633.421994680342, 9777.657781977596, 9780.902190977999, 9682.128608425275, 9757.512124393894, 10021.749456263651, 10057.597696092074, 10163.085322321027, 7228.241034691282, 7487.438442116972, 7517.1355294139685, 7605.619719013916, 7719.768406947801, 8171.959140204261, 8175.550344731097, 8232.794180145544, 8268.2558569729, 8308.459950103224, 7259.6007219603425, 7429.4799364044, 7549.50928189666, 7661.425393095428, 7699.153093159636, 7344.30229128232, 7431.4054875608745, 7467.738629147953, 7549.849003019799, 7583.5070720403, 6507.446867016357, 6519.674016299071, 6541.08424820516, 6596.538242322991, 6633.734650614115, 4924.975375123101, 4996.7001979881325, 5082.237664350377, 5119.360079990001, 5128.410232823273, 5130.384353877558, 5157.896842063213, 5217.34783152106, 5218.08683480397, 5236.266922630759], "value": 4427.572540455219, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.2037729849507, 289.4861620623395, 292.86967299551696, 299.5820829942231, 301.3054908436057, 5913.526917846572, 5994.340622531524, 6000.459958603736, 6086.269647642283, 6159.8440545809, 6058.212432383795, 6089.5432842536875, 6090.116933044706, 6109.35851735568, 6119.969400153004, 4495.910081798362, 4534.435619711195, 4537.750423726686, 4538.591526762591, 4552.635789136861, 4217.40956266123, 4393.275109606911, 4436.911261774762, 4452.821887124527, 4519.163954668397, 4343.284402660947, 4397.1205758848355, 4399.406080179183, 4410.117976404716, 4414.668899832509, 4350.673699472536, 4379.233634114017, 4396.098799746044, 4402.097569998143, 4413.713108647944, 3653.0502069461863, 3707.8331475083687, 3711.554613446404, 3721.6464435878547, 3723.1809002019513, 5731.283589551306, 5731.742071606787, 5761.971190144064, 5775.653460792366, 5800.187973683687, 5045.949540504622, 5050.2929589857085, 5070.569001634865, 5073.036123136592, 5078.46676099008, 6114.449699527064, 6308.0, 6312.305646378894, 6316.652584107872, 6317.557770956035, 4058.269511487931, 4060.512738471373, 4085.8978525536804, 4087.89780255493, 4099.057216840114, 6493.123428337209, 6571.34286571339, 6603.273639899608, 6653.900191497131, 6656.80029599108, 4179.853705120307, 4234.25900467417, 4240.342746874239, 4250.702450828474, 4271.935920961126, 4233.386159006926, 4273.487181538173, 4283.528811830696, 4311.1377724454605, 4314.180305741962, 5075.22367171487, 5086.847394578169, 5124.205748109049, 5124.718140502234, 5127.923081153711, 6233.750649974041, 6242.344553821783, 6292.087647291117, 6351.872962540723, 6439.9356006440275, 1459.2703648175911, 1462.429652435551, 1471.5953112893826, 1472.308015232839, 1475.8783324673325, 927.2489283680105, 946.8532377481501, 959.6593209410698, 970.7621632700034, 971.2666936463066, 6142.170806941095, 6143.262808462924, 6143.262808463013, 6150.7847225346895, 6189.35011823761, 6541.182352205974, 6577.539572229898, 6599.175103112111, 6615.140031795932, 6624.90062649051, 5959.791407300723, 6080.665563394055, 6142.877142457215, 6146.108814221912, 6156.846078848064, 3526.400511912981, 3530.117470632342, 3558.491263659114, 3558.946615800765, 3559.804210768381, 6575.243846957565, 6766.4248538874745, 6785.0, 6795.082663840319, 6854.931450685429, 6718.294579069225, 6734.831629209309, 6758.324167583202, 6789.0, 6792.184937807495, 6555.934440655532, 6753.7636182732385, 6757.560758550679, 6760.966195169091, 6777.72889084441, 6488.967555162194, 6507.707153178024, 6543.574667646588, 6553.934460655523, 6600.768973085919, 6253.937460625336, 6448.290688024407, 6476.902846457401, 6480.416762491398, 6483.319251478715, 6673.799786006233, 6746.9325306746305, 6747.527673062838, 6757.493188010821, 6780.38976492118, 4209.052963083282, 4239.915201696011, 4242.363645453083, 4242.957570424256, 4246.978765106154, 6351.2060992375955, 6431.935680643133, 6571.34286571339, 6571.80284591463, 6673.332666733288, 6384.680765961776, 6416.7754128605275, 6427.517936154713, 6473.2232132144445, 6495.707693153725, 6224.0, 6477.352264773674, 6491.0, 6494.2856285807575, 6504.804855854332, 6270.435660790551, 6308.526860485574, 6345.8730825384155, 6348.492120630431, 6376.93623063782, 6418.422341989243, 6483.578567393104, 6527.771527996687, 6529.216494020748, 6543.607383557001, 6259.34276900937, 6270.122182894307, 6353.396427339396, 6356.555041147075, 6371.139896113966], "value": 4686.381441637758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3279947246685, 797.0395673213778, 825.686239229093, 852.9104444033376, 857.5926434943402, 12638.368081595918, 12659.49362025519, 12700.237985720853, 12743.0, 12745.681357966056, 10982.890171098286, 13623.591292261222, 13681.863181368184, 13704.45182192711, 13720.245386503764, 782.2295039386214, 807.4872455990459, 811.4401063266328, 812.4110020235312, 813.3046245460135, 783.7922950418143, 785.5247575216997, 785.6071964017991, 786.6735304848481, 792.73839632921, 838.8825564420986, 842.3050982939069, 846.9872951905726, 847.2036285891243, 850.37497439382, 834.5535138700797, 835.8495470815251, 836.7155167243105, 840.5419046619606, 843.8312337532457, 609.8841220168154, 611.3336463255029, 613.910982907476, 614.4285814192799, 615.5383462403198, 14530.92734536331, 14532.200728959902, 14557.563273101823, 14569.12585244878, 14600.415983360654, 13518.391672374668, 13651.795223071662, 13938.442462301497, 13951.441942322397, 14335.0, 10794.434806952948, 10829.133669306437, 10861.239713220079, 10904.291221070684, 10989.780204395867, 3777.9610607082996, 3781.0, 3861.942070868939, 3945.2504024235304, 3965.0285680008296, 55174.0, 55404.0, 56338.0, 56499.43500565024, 56633.71683141599, 11102.61140860066, 11133.610323638633, 11232.213745037769, 11244.156688248415, 11291.774164516664, 20413.489662758253, 20454.59090818175, 20464.897675511525, 20593.38219853407, 20908.059137338856, 8262.17378262169, 8293.295069919004, 8320.916790832136, 8330.541820199947, 8369.163083691583, 4535.25168347219, 4622.19111655459, 4624.5375462453485, 4647.442306923191, 4772.976135119302, 3074.969250307513, 3112.9844350778103, 3118.0, 3138.1370123216298, 3143.0413723814454, 531.6491115863512, 539.3393093460479, 542.8995635807388, 568.4116938968231, 570.2216474512344, 765.3265126688478, 792.7225471085189, 796.7888509544975, 796.9641366138537, 817.3747083481142, 9400.623975041059, 9428.528573571293, 9542.379745316532, 9704.854427183598, 9757.756056098655, 756.4477931110321, 771.8842173673994, 773.9961300193576, 781.8436312737475, 791.1179035375515, 4397.516273209944, 4577.679562430664, 4676.789544470507, 4689.413823272091, 4701.506341834127, 54367.45632543703, 54413.45586544163, 55385.0, 55748.0, 62971.37028629747, 45875.541244587796, 46260.5373946263, 46543.0, 47601.76199118982, 47990.5200947993, 45972.310415343796, 46289.30566041512, 46620.99999999932, 47474.0, 48691.0, 8597.828043439222, 8919.331050171133, 9254.676086336945, 9369.016253293306, 9551.188149007134, 28355.716442836132, 28805.230770768434, 29468.410631786814, 29646.407071858874, 30780.23049423782, 38354.23291534098, 38817.805910970266, 38843.80578097091, 39126.60873391343, 43313.7834310839, 12418.81371779442, 12474.18917770342, 12591.24452532851, 12602.180858244184, 12742.235465872078, 13828.792568111687, 13965.0, 14031.438742450597, 14272.0, 14950.252487375805, 13414.530491432753, 13414.798778018143, 13522.594322170351, 13688.178709277476, 13688.591512834346, 13028.0, 13046.478140874258, 13077.280749558486, 13454.0, 13781.242031688353, 13573.660658483617, 13869.09850859691, 14042.227677477837, 14120.50578229757, 14129.0, 10966.451677416257, 11105.666829995112, 11219.158563107636, 11333.26333788301, 11646.126540509325, 11260.774784504429, 11372.260803047775, 11423.200375973935, 11424.543018279175, 11458.4270786462], "value": 6707.427268218131, "unit": "score"}], "name": "dromaeo_css", "value": 7195.652287861421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 113.0, 112.0, 111.0, 124.0, 112.0, 116.0, 112.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 127.0, 153.0, 181.0, 129.0, 160.0, 158.0, 130.0, 183.0, 129.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 167.0, 161.0, 165.0, 166.0, 162.0, 164.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 163.0, 77.0, 77.0, 77.0, 77.0, 151.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 92.0, 93.0, 93.0, 138.0, 92.0, 93.0, 143.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 149.0, 150.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 56.0, 57.0, 58.0, 74.0, 54.0, 56.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 60.0, 60.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 78.0, 78.0, 77.0, 86.0, 77.0, 79.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 135.0, 124.0, 135.0, 124.0, 131.0, 136.0, 159.0, 132.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 178.0, 169.0, 170.0, 173.0, 164.0, 170.0, 166.0, 169.0, 170.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 70.0, 83.0, 70.0, 68.0, 67.0, 69.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1561.0000000000002, "alertThreshold": 2.0}]} 22:27:34 INFO - Return code: 0 22:27:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:34 ERROR - # TBPL SUCCESS # 22:27:34 INFO - Running post-action listener: _resource_record_post_action 22:27:34 INFO - Running post-run listener: _resource_record_post_run 22:27:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 549343232; Read time: 0; Write time: 474564 22:27:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244547584; Read time: 0; Write time: 271980 22:27:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292708352; Read time: 0; Write time: 195704 22:27:35 INFO - Running post-run listener: _upload_blobber_files 22:27:35 INFO - Blob upload gear active. 22:27:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:27:35 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 22:27:35 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:27:35 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:27:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:27:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:27:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:36 INFO - (blobuploader) - INFO - Done attempting. 22:27:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:27:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:27:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:37 INFO - (blobuploader) - INFO - Done attempting. 22:27:37 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:37 INFO - Return code: 0 22:27:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:27:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78ada56d9e9c9a2187e0738c04e21a567424343dc79ef4517046aa046ef78d9d13b27c66ac2c61d74ab9cdeb4994e7f02d9e6037408657872574092cb45771de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f91560b01761e67c7bfd9064e7b3638c73573b3d69e9cff0a8a51afd4879a43f7977a412e048533a9bfbed89228586de1b71a48a987acac97b4dd3522a8a834"} 22:27:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:27:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:27:37 INFO - Contents: 22:27:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78ada56d9e9c9a2187e0738c04e21a567424343dc79ef4517046aa046ef78d9d13b27c66ac2c61d74ab9cdeb4994e7f02d9e6037408657872574092cb45771de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f91560b01761e67c7bfd9064e7b3638c73573b3d69e9cff0a8a51afd4879a43f7977a412e048533a9bfbed89228586de1b71a48a987acac97b4dd3522a8a834"} 22:27:37 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:37 INFO - Copying logs to upload dir... 22:27:37 INFO - mkdir: /builds/slave/test/build/upload/logs 22:27:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.040179 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-04-20 22:27:37.396504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:37.400652) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 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-Inbound/sha512/78ada56d9e9c9a2187e0738c04e21a567424343dc79ef4517046aa046ef78d9d13b27c66ac2c61d74ab9cdeb4994e7f02d9e6037408657872574092cb45771de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f91560b01761e67c7bfd9064e7b3638c73573b3d69e9cff0a8a51afd4879a43f7977a412e048533a9bfbed89228586de1b71a48a987acac97b4dd3522a8a834"} build_url:https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78ada56d9e9c9a2187e0738c04e21a567424343dc79ef4517046aa046ef78d9d13b27c66ac2c61d74ab9cdeb4994e7f02d9e6037408657872574092cb45771de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f91560b01761e67c7bfd9064e7b3638c73573b3d69e9cff0a8a51afd4879a43f7977a412e048533a9bfbed89228586de1b71a48a987acac97b4dd3522a8a834"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:37.427446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:37.428026) ========= 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=337fe3f4b1febe37b85fccc40000019e-1461210029.438353-1904575938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:37.512059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:27:37.512396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:27:37.512703) ========= ========= Total master_lag: 0.17 =========